builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-054 starttime: 1453370768.15 results: success (0) buildid: 20160120233027 builduid: ca139c6ca59546feae5cebe8c9c811a1 revision: 8150bbaade324fa7356aa955164f63efd10f917c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 02:06:08.146358) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 02:06:08.147271) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 02:06:08.147601) ========= 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=cbe409c6de289db6ac707de3000001d4-1453369935.764859-141208108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006374 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 02:06:08.218466) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 02:06:08.218803) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 02:06:08.255007) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 02:06:08.255347) ========= 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=cbe409c6de289db6ac707de3000001d4-1453369935.764859-141208108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.012716 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 02:06:08.309656) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 02:06:08.309996) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 02:06:08.310421) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 02:06:08.310731) ========= 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=cbe409c6de289db6ac707de3000001d4-1453369935.764859-141208108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-21 02:06:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.4M=0s 2016-01-21 02:06:08 (43.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160725 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 02:06:08.492484) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 02:06:08.492842) ========= 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=cbe409c6de289db6ac707de3000001d4-1453369935.764859-141208108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.037841 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 02:06:08.545491) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 02:06:08.545878) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 8150bbaade324fa7356aa955164f63efd10f917c --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 8150bbaade324fa7356aa955164f63efd10f917c --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=cbe409c6de289db6ac707de3000001d4-1453369935.764859-141208108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-21 02:06:08,855 truncating revision to first 12 chars 2016-01-21 02:06:08,855 Setting DEBUG logging. 2016-01-21 02:06:08,855 attempt 1/10 2016-01-21 02:06:08,855 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/8150bbaade32?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-21 02:06:09,150 unpacking tar archive at: b2g-inbound-8150bbaade32/testing/mozharness/ program finished with exit code 0 elapsedTime=0.579358 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 02:06:09.144163) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 02:06:09.144536) ========= echo 8150bbaade324fa7356aa955164f63efd10f917c in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8150bbaade324fa7356aa955164f63efd10f917c'] 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=cbe409c6de289db6ac707de3000001d4-1453369935.764859-141208108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 8150bbaade324fa7356aa955164f63efd10f917c program finished with exit code 0 elapsedTime=0.004701 script_repo_revision: '8150bbaade324fa7356aa955164f63efd10f917c' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 02:06:09.202979) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 02:06:09.203415) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 02:06:09.224594) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-21 02:06:09.224919) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/8150bbaade324fa7356aa955164f63efd10f917c ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-21 02:06:09.225437) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-21 02:06:09.225770) ========= /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=cbe409c6de289db6ac707de3000001d4-1453369935.764859-141208108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:06:09 INFO - MultiFileLogger online at 20160121 02:06:09 in /builds/slave/test-pgo 02:06:09 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 02:06:09 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 02:06:09 INFO - {'append_to_log': False, 02:06:09 INFO - 'base_work_dir': '/builds/slave/test-pgo', 02:06:09 INFO - 'blob_upload_branch': 'B2G-Inbound', 02:06:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 02:06:09 INFO - 'branch': 'B2G-Inbound', 02:06:09 INFO - 'buildbot_json_path': 'buildprops.json', 02:06:09 INFO - 'config_files': ('talos/linux_config.py',), 02:06:09 INFO - 'default_actions': ('clobber', 02:06:09 INFO - 'read-buildbot-config', 02:06:09 INFO - 'download-and-extract', 02:06:09 INFO - 'populate-webroot', 02:06:09 INFO - 'create-virtualenv', 02:06:09 INFO - 'install', 02:06:09 INFO - 'run-tests'), 02:06:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:06:09 INFO - 'download_minidump_stackwalk': True, 02:06:09 INFO - 'download_symbols': 'ondemand', 02:06:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:06:09 INFO - 'tooltool.py': '/tools/tooltool.py', 02:06:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:06:09 INFO - '/tools/misc-python/virtualenv.py')}, 02:06:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:06:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:06:09 INFO - 'installer_path': 'installer.exe', 02:06:09 INFO - 'log_level': 'info', 02:06:09 INFO - 'log_name': 'talos', 02:06:09 INFO - 'log_to_console': True, 02:06:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:06:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:06:09 INFO - 'opt_config_files': (), 02:06:09 INFO - 'pip_index': False, 02:06:09 INFO - 'sps_profile': False, 02:06:09 INFO - 'sps_profile_interval': 0, 02:06:09 INFO - 'suite': 'dromaeojs', 02:06:09 INFO - 'system_bits': '32', 02:06:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:06:09 INFO - 'title': 'talos-linux64-ix-054', 02:06:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:06:09 INFO - 'use_talos_json': True, 02:06:09 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 02:06:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:06:09 INFO - 'work_dir': 'build'} 02:06:09 INFO - ##### 02:06:09 INFO - ##### Running clobber step. 02:06:09 INFO - ##### 02:06:09 INFO - Running pre-action listener: _resource_record_pre_action 02:06:09 INFO - Running main action method: clobber 02:06:09 INFO - rmtree: /builds/slave/test-pgo/build 02:06:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 02:06:10 INFO - Running post-action listener: _resource_record_post_action 02:06:10 INFO - ##### 02:06:10 INFO - ##### Running read-buildbot-config step. 02:06:10 INFO - ##### 02:06:10 INFO - Running pre-action listener: _resource_record_pre_action 02:06:10 INFO - Running main action method: read_buildbot_config 02:06:10 INFO - Using buildbot properties: 02:06:10 INFO - { 02:06:10 INFO - "project": "", 02:06:10 INFO - "product": "firefox", 02:06:10 INFO - "script_repo_revision": "production", 02:06:10 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 02:06:10 INFO - "repository": "", 02:06:10 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 02:06:10 INFO - "buildid": "20160120233027", 02:06:10 INFO - "pgo_build": "True", 02:06:10 INFO - "basedir": "/builds/slave/test-pgo", 02:06:10 INFO - "buildnumber": 1125, 02:06:10 INFO - "slavename": "talos-linux64-ix-054", 02:06:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:06:10 INFO - "platform": "ubuntu64_hw", 02:06:10 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 02:06:10 INFO - "branch": "b2g-inbound", 02:06:10 INFO - "repo_path": "integration/b2g-inbound", 02:06:10 INFO - "revision": "8150bbaade324fa7356aa955164f63efd10f917c", 02:06:10 INFO - "stage_platform": "linux64-pgo", 02:06:10 INFO - "builduid": "ca139c6ca59546feae5cebe8c9c811a1", 02:06:10 INFO - "slavebuilddir": "test" 02:06:10 INFO - } 02:06:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 02:06:10 INFO - Running post-action listener: _resource_record_post_action 02:06:10 INFO - ##### 02:06:10 INFO - ##### Running download-and-extract step. 02:06:10 INFO - ##### 02:06:10 INFO - Running pre-action listener: _resource_record_pre_action 02:06:10 INFO - Running main action method: download_and_extract 02:06:10 INFO - mkdir: /builds/slave/test-pgo/build/tests 02:06:10 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')]} 02:06:10 INFO - https://queue.taskcluster.net/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:06:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/test_packages.json 02:06:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/test_packages.json 02:06:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 02:06:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 02:06:12 INFO - Downloaded 1448 bytes. 02:06:12 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 02:06:12 INFO - Using the following test package requirements: 02:06:12 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:06:12 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:06:12 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:06:12 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:12 INFO - u'jsshell-linux-x86_64.zip'], 02:06:12 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:06:12 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:06:12 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:06:12 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:06:12 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:06:12 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:06:12 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:06:12 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:06:12 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')]} 02:06:12 INFO - https://queue.taskcluster.net/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:06:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:06:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:06:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:06:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:06:13 INFO - Downloaded 22485352 bytes. 02:06:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 02:06:13 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 02:06:14 INFO - Return code: 0 02:06:14 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:06:14 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')]} 02:06:14 INFO - https://queue.taskcluster.net/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:06:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:06:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:06:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:06:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:06:16 INFO - Downloaded 22485352 bytes. 02:06:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 02:06:16 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 02:06:17 INFO - Return code: 0 02:06:17 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')]} 02:06:17 INFO - https://queue.taskcluster.net/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:06:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:06:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:06:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:06:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:06:18 INFO - Downloaded 11132144 bytes. 02:06:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 02:06:18 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 02:06:19 INFO - Return code: 0 02:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:19 INFO - https://queue.taskcluster.net/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:06:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:06:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:06:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:06:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:06:21 INFO - Downloaded 55948856 bytes. 02:06:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:06:21 INFO - mkdir: /builds/slave/test-pgo/properties 02:06:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 02:06:21 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 02:06:21 INFO - Contents: 02:06:21 INFO - build_url:https://queue.taskcluster.net/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:06:21 INFO - Running post-action listener: _resource_record_post_action 02:06:21 INFO - Running post-action listener: set_extra_try_arguments 02:06:21 INFO - ##### 02:06:21 INFO - ##### Running populate-webroot step. 02:06:21 INFO - ##### 02:06:21 INFO - Running pre-action listener: _resource_record_pre_action 02:06:21 INFO - Running main action method: populate_webroot 02:06:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:06:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:06:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:06:21 INFO - '--tppagecycles', 02:06:21 INFO - '7'], 02:06:21 INFO - 'tests': ['tsvgm']}}, 02:06:21 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:06:21 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:06:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:06:21 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:06:21 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:06:21 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:06:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:06:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:21 INFO - 'talos_options': ['--e10s'], 02:06:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:06:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:21 INFO - 'tests': ['damp', 'tps']}, 02:06:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:21 INFO - 'talos_options': ['--e10s'], 02:06:21 INFO - 'tests': ['damp', 'tps']}, 02:06:21 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:06:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:06:21 INFO - 'other': {'tests': ['a11yr', 02:06:21 INFO - 'ts_paint', 02:06:21 INFO - 'tpaint', 02:06:21 INFO - 'sessionrestore', 02:06:21 INFO - 'sessionrestore_no_auto_restore']}, 02:06:21 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:06:21 INFO - 'tests': ['a11yr', 02:06:21 INFO - 'ts_paint', 02:06:21 INFO - 'tpaint', 02:06:21 INFO - 'sessionrestore', 02:06:21 INFO - 'sessionrestore_no_auto_restore']}, 02:06:21 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:06:21 INFO - 'tests': ['a11yr', 02:06:21 INFO - 'ts_paint', 02:06:21 INFO - 'tpaint', 02:06:21 INFO - 'sessionrestore', 02:06:21 INFO - 'sessionrestore_no_auto_restore']}, 02:06:21 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:06:21 INFO - 'tests': ['a11yr', 02:06:21 INFO - 'ts_paint', 02:06:21 INFO - 'tpaint', 02:06:21 INFO - 'sessionrestore', 02:06:21 INFO - 'sessionrestore_no_auto_restore']}, 02:06:21 INFO - 'other_l64': {'tests': ['a11yr', 02:06:21 INFO - 'ts_paint', 02:06:21 INFO - 'tpaint', 02:06:21 INFO - 'sessionrestore', 02:06:21 INFO - 'sessionrestore_no_auto_restore']}, 02:06:21 INFO - 'other_nol64': {'tests': ['a11yr', 02:06:21 INFO - 'ts_paint', 02:06:21 INFO - 'tpaint', 02:06:21 INFO - 'sessionrestore', 02:06:21 INFO - 'sessionrestore_no_auto_restore']}, 02:06:21 INFO - 'svgr': {'tests': ['tsvgx', 02:06:21 INFO - 'tsvgr_opacity', 02:06:21 INFO - 'tart', 02:06:21 INFO - 'tscrollx', 02:06:21 INFO - 'cart']}, 02:06:21 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:06:21 INFO - 'tests': ['tsvgx', 02:06:21 INFO - 'tsvgr_opacity', 02:06:21 INFO - 'tart', 02:06:21 INFO - 'tscrollx', 02:06:21 INFO - 'cart']}, 02:06:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:21 INFO - 'tests': ['tp5o']}, 02:06:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:21 INFO - 'talos_options': ['--e10s'], 02:06:21 INFO - 'tests': ['tp5o']}, 02:06:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:21 INFO - 'talos_options': ['--xperf_path', 02:06:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:06:21 INFO - 'tests': ['tp5n']}, 02:06:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:21 INFO - 'talos_options': ['--e10s', 02:06:21 INFO - '--xperf_path', 02:06:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:06:21 INFO - 'tests': ['tp5n']}}, 02:06:21 INFO - 'talos.zip': {'path': '', 02:06:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:06:21 INFO - Running post-action listener: _resource_record_post_action 02:06:21 INFO - ##### 02:06:21 INFO - ##### Running create-virtualenv step. 02:06:21 INFO - ##### 02:06:21 INFO - Running pre-action listener: _resource_record_pre_action 02:06:21 INFO - Running main action method: create_virtualenv 02:06:21 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 02:06:21 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 02:06:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 02:06:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:06:21 INFO - Using real prefix '/usr' 02:06:21 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 02:06:21 INFO - Installing distribute.............................................................................................................................................................................................done. 02:06:23 INFO - Installing pip.................done. 02:06:23 INFO - Return code: 0 02:06:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 02:06:23 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')]} 02:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:23 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')]} 02:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:23 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 0x7f7032e5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fa630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298b840>, '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 0x28f86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f8b60>, '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': 'cbe409c6de289db6ac707de3000001d4-1453369935.764859-141208108', '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 02:06:23 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 02:06:23 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 02:06:23 INFO - Using env: {'DISPLAY': ':0', 02:06:23 INFO - 'HOME': '/home/cltbld', 02:06:23 INFO - 'LANG': 'en_US.UTF-8', 02:06:23 INFO - 'LANGUAGE': 'en_US:en', 02:06:23 INFO - 'LOGNAME': 'cltbld', 02:06:23 INFO - 'MAIL': '/var/mail/cltbld', 02:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:23 INFO - 'MOZ_NO_REMOTE': '1', 02:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:23 INFO - 'NO_EM_RESTART': '1', 02:06:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:23 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:23 INFO - 'SHELL': '/bin/bash', 02:06:23 INFO - 'SHLVL': '1', 02:06:23 INFO - 'TERM': 'linux', 02:06:23 INFO - 'TMOUT': '86400', 02:06:23 INFO - 'USER': 'cltbld', 02:06:23 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453369935.764859-141208108', 02:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:23 INFO - '_': '/tools/buildbot/bin/python'} 02:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:23 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 02:06:23 INFO - Cleaning up... 02:06:23 INFO - Return code: 0 02:06:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 02:06:23 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')]} 02:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:23 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')]} 02:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:23 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 0x7f7032e5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fa630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298b840>, '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 0x28f86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f8b60>, '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': 'cbe409c6de289db6ac707de3000001d4-1453369935.764859-141208108', '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 02:06:23 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 02:06:23 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 02:06:23 INFO - Using env: {'DISPLAY': ':0', 02:06:23 INFO - 'HOME': '/home/cltbld', 02:06:23 INFO - 'LANG': 'en_US.UTF-8', 02:06:23 INFO - 'LANGUAGE': 'en_US:en', 02:06:23 INFO - 'LOGNAME': 'cltbld', 02:06:23 INFO - 'MAIL': '/var/mail/cltbld', 02:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:23 INFO - 'MOZ_NO_REMOTE': '1', 02:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:23 INFO - 'NO_EM_RESTART': '1', 02:06:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:23 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:23 INFO - 'SHELL': '/bin/bash', 02:06:23 INFO - 'SHLVL': '1', 02:06:23 INFO - 'TERM': 'linux', 02:06:23 INFO - 'TMOUT': '86400', 02:06:23 INFO - 'USER': 'cltbld', 02:06:23 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453369935.764859-141208108', 02:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:23 INFO - '_': '/tools/buildbot/bin/python'} 02:06:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:24 INFO - Downloading/unpacking psutil>=0.7.1 02:06:24 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 02:06:24 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 02:06:24 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 02:06:24 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 02:06:24 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 02:06:24 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 02:06:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 02:06:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:06:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:06:26 INFO - Installing collected packages: psutil 02:06:26 INFO - Running setup.py install for psutil 02:06:26 INFO - building 'psutil._psutil_linux' extension 02:06:26 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 02:06:26 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 02:06:26 INFO - building 'psutil._psutil_posix' extension 02:06:26 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 02:06:26 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 02:06:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:06:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:06:26 INFO - Successfully installed psutil 02:06:26 INFO - Cleaning up... 02:06:26 INFO - Return code: 0 02:06:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 02:06: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')]} 02:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06: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')]} 02:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:26 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 0x7f7032e5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fa630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298b840>, '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 0x28f86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f8b60>, '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': 'cbe409c6de289db6ac707de3000001d4-1453369935.764859-141208108', '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 02:06:26 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 02:06:26 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 02:06:26 INFO - Using env: {'DISPLAY': ':0', 02:06:26 INFO - 'HOME': '/home/cltbld', 02:06:26 INFO - 'LANG': 'en_US.UTF-8', 02:06:26 INFO - 'LANGUAGE': 'en_US:en', 02:06:26 INFO - 'LOGNAME': 'cltbld', 02:06:26 INFO - 'MAIL': '/var/mail/cltbld', 02:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:26 INFO - 'MOZ_NO_REMOTE': '1', 02:06:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:26 INFO - 'NO_EM_RESTART': '1', 02:06:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:26 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:26 INFO - 'SHELL': '/bin/bash', 02:06:26 INFO - 'SHLVL': '1', 02:06:26 INFO - 'TERM': 'linux', 02:06:26 INFO - 'TMOUT': '86400', 02:06:26 INFO - 'USER': 'cltbld', 02:06:26 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453369935.764859-141208108', 02:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:26 INFO - '_': '/tools/buildbot/bin/python'} 02:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:06:26 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 02:06:26 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 02:06:26 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 02:06:26 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 02:06:26 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 02:06:26 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 02:06:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:06:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:06:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:06:28 INFO - Installing collected packages: mozsystemmonitor 02:06:28 INFO - Running setup.py install for mozsystemmonitor 02:06:28 INFO - Successfully installed mozsystemmonitor 02:06:28 INFO - Cleaning up... 02:06:28 INFO - Return code: 0 02:06:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 02:06:28 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')]} 02:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:28 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')]} 02:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:28 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 0x7f7032e5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fa630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298b840>, '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 0x28f86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f8b60>, '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': 'cbe409c6de289db6ac707de3000001d4-1453369935.764859-141208108', '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 02:06:28 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 02:06:28 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 02:06:28 INFO - Using env: {'DISPLAY': ':0', 02:06:28 INFO - 'HOME': '/home/cltbld', 02:06:28 INFO - 'LANG': 'en_US.UTF-8', 02:06:28 INFO - 'LANGUAGE': 'en_US:en', 02:06:28 INFO - 'LOGNAME': 'cltbld', 02:06:28 INFO - 'MAIL': '/var/mail/cltbld', 02:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:28 INFO - 'MOZ_NO_REMOTE': '1', 02:06:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:28 INFO - 'NO_EM_RESTART': '1', 02:06:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:28 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:28 INFO - 'SHELL': '/bin/bash', 02:06:28 INFO - 'SHLVL': '1', 02:06:28 INFO - 'TERM': 'linux', 02:06:28 INFO - 'TMOUT': '86400', 02:06:28 INFO - 'USER': 'cltbld', 02:06:28 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453369935.764859-141208108', 02:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:28 INFO - '_': '/tools/buildbot/bin/python'} 02:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:28 INFO - Downloading/unpacking blobuploader==1.2.4 02:06:28 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 02:06:28 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 02:06:28 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 02:06:28 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 02:06:28 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 02:06:28 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 02:06:30 INFO - Downloading blobuploader-1.2.4.tar.gz 02:06:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:06:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:06:30 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 02:06:30 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 02:06:30 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 02:06:30 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 02:06:30 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 02:06:30 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 02:06:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 02:06:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:06:31 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 02:06:31 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 02:06:31 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 02:06:31 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 02:06:31 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 02:06:31 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 02:06:31 INFO - Downloading docopt-0.6.1.tar.gz 02:06:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 02:06:31 INFO - Installing collected packages: blobuploader, requests, docopt 02:06:31 INFO - Running setup.py install for blobuploader 02:06:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:06:31 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 02:06:31 INFO - Running setup.py install for requests 02:06:31 INFO - Running setup.py install for docopt 02:06:31 INFO - Successfully installed blobuploader requests docopt 02:06:31 INFO - Cleaning up... 02:06:32 INFO - Return code: 0 02:06:32 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:32 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 0x7f7032e5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fa630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298b840>, '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 0x28f86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f8b60>, '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': 'cbe409c6de289db6ac707de3000001d4-1453369935.764859-141208108', '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 02:06:32 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 02:06:32 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 02:06:32 INFO - Using env: {'DISPLAY': ':0', 02:06:32 INFO - 'HOME': '/home/cltbld', 02:06:32 INFO - 'LANG': 'en_US.UTF-8', 02:06:32 INFO - 'LANGUAGE': 'en_US:en', 02:06:32 INFO - 'LOGNAME': 'cltbld', 02:06:32 INFO - 'MAIL': '/var/mail/cltbld', 02:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:32 INFO - 'MOZ_NO_REMOTE': '1', 02:06:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:32 INFO - 'NO_EM_RESTART': '1', 02:06:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:32 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:32 INFO - 'SHELL': '/bin/bash', 02:06:32 INFO - 'SHLVL': '1', 02:06:32 INFO - 'TERM': 'linux', 02:06:32 INFO - 'TMOUT': '86400', 02:06:32 INFO - 'USER': 'cltbld', 02:06:32 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453369935.764859-141208108', 02:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:32 INFO - '_': '/tools/buildbot/bin/python'} 02:06:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:06:32 INFO - Running setup.py (path:/tmp/pip-xrqwlt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:06:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:06:32 INFO - Running setup.py (path:/tmp/pip-WDASTb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:06:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:06:32 INFO - Running setup.py (path:/tmp/pip-82zig1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:06:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:06:32 INFO - Running setup.py (path:/tmp/pip-Yyonyx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:06:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:06:32 INFO - Running setup.py (path:/tmp/pip-vbGP3N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:06:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:06:32 INFO - Running setup.py (path:/tmp/pip-11gNl7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:06:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:06:32 INFO - Running setup.py (path:/tmp/pip-8aNgdZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:06:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:06:32 INFO - Running setup.py (path:/tmp/pip-suSNEh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:06:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:06:32 INFO - Running setup.py (path:/tmp/pip-J2EWei-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:06:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:06:32 INFO - Running setup.py (path:/tmp/pip-I8G7ug-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:06:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:06:32 INFO - Running setup.py (path:/tmp/pip-i6G1Dm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:06:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:06:33 INFO - Running setup.py (path:/tmp/pip-y7nhYi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:06:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:06:33 INFO - Running setup.py (path:/tmp/pip-VUY36z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:06:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:06:33 INFO - Running setup.py (path:/tmp/pip-QIr9vx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:06:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:06:33 INFO - Running setup.py (path:/tmp/pip-mH7WtD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:06:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:06:33 INFO - Running setup.py (path:/tmp/pip-hako1k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:06:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:06:33 INFO - Running setup.py (path:/tmp/pip-hsrK5m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:06:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:06:33 INFO - Running setup.py install for manifestparser 02:06:33 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 02:06:33 INFO - Running setup.py install for mozcrash 02:06:33 INFO - Running setup.py install for mozdebug 02:06:33 INFO - Running setup.py install for mozdevice 02:06:33 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 02:06:33 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 02:06:33 INFO - Running setup.py install for mozfile 02:06:33 INFO - Running setup.py install for mozhttpd 02:06:34 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 02:06:34 INFO - Running setup.py install for mozinfo 02:06:34 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 02:06:34 INFO - Running setup.py install for mozInstall 02:06:34 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 02:06:34 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 02:06:34 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 02:06:34 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 02:06:34 INFO - Running setup.py install for mozleak 02:06:34 INFO - Running setup.py install for mozlog 02:06:34 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 02:06:34 INFO - Running setup.py install for moznetwork 02:06:34 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 02:06:34 INFO - Running setup.py install for mozprocess 02:06:34 INFO - Running setup.py install for mozprofile 02:06:34 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 02:06:34 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 02:06:34 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 02:06:34 INFO - Running setup.py install for mozrunner 02:06:34 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 02:06:34 INFO - Running setup.py install for mozscreenshot 02:06:35 INFO - Running setup.py install for moztest 02:06:35 INFO - Running setup.py install for mozversion 02:06:35 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 02:06:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:06:35 INFO - Cleaning up... 02:06:35 INFO - Return code: 0 02:06:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:35 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 0x7f7032e5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fa630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298b840>, '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 0x28f86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f8b60>, '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': 'cbe409c6de289db6ac707de3000001d4-1453369935.764859-141208108', '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 02:06:35 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 02:06:35 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 02:06:35 INFO - Using env: {'DISPLAY': ':0', 02:06:35 INFO - 'HOME': '/home/cltbld', 02:06:35 INFO - 'LANG': 'en_US.UTF-8', 02:06:35 INFO - 'LANGUAGE': 'en_US:en', 02:06:35 INFO - 'LOGNAME': 'cltbld', 02:06:35 INFO - 'MAIL': '/var/mail/cltbld', 02:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:35 INFO - 'MOZ_NO_REMOTE': '1', 02:06:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:35 INFO - 'NO_EM_RESTART': '1', 02:06:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:35 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:35 INFO - 'SHELL': '/bin/bash', 02:06:35 INFO - 'SHLVL': '1', 02:06:35 INFO - 'TERM': 'linux', 02:06:35 INFO - 'TMOUT': '86400', 02:06:35 INFO - 'USER': 'cltbld', 02:06:35 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453369935.764859-141208108', 02:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:35 INFO - '_': '/tools/buildbot/bin/python'} 02:06:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:06:35 INFO - Running setup.py (path:/tmp/pip-FVVOjc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:06:35 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)) 02:06:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:06:35 INFO - Running setup.py (path:/tmp/pip-ocKkOU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:06:35 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)) 02:06:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:06:35 INFO - Running setup.py (path:/tmp/pip-wndcn2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:06:35 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)) 02:06:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:06:35 INFO - Running setup.py (path:/tmp/pip-2xH4yf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:06:35 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)) 02:06:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:06:35 INFO - Running setup.py (path:/tmp/pip-wKloZF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:06:35 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)) 02:06:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:06:35 INFO - Running setup.py (path:/tmp/pip-p41bsX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:06:35 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)) 02:06:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:06:35 INFO - Running setup.py (path:/tmp/pip-NnOCai-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:06:35 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)) 02:06:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:06:35 INFO - Running setup.py (path:/tmp/pip-8Xpi7T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:06:36 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)) 02:06:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:06:36 INFO - Running setup.py (path:/tmp/pip-QNi9sz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:06:36 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)) 02:06:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:06:36 INFO - Running setup.py (path:/tmp/pip-phdh7K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:06:36 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)) 02:06:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:06:36 INFO - Running setup.py (path:/tmp/pip-Qlixb0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:06:36 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)) 02:06:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:06:36 INFO - Running setup.py (path:/tmp/pip-PRfSCG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:06:36 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)) 02:06:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:06:36 INFO - Running setup.py (path:/tmp/pip-m1QpBy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:06:36 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)) 02:06:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:06:36 INFO - Running setup.py (path:/tmp/pip-GofUOr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:06:36 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)) 02:06:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:06:36 INFO - Running setup.py (path:/tmp/pip-2JO4h2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:06:36 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)) 02:06:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:06:36 INFO - Running setup.py (path:/tmp/pip-Qiwdua-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:06:36 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)) 02:06:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:06:36 INFO - Running setup.py (path:/tmp/pip-wD0knh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:06:36 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)) 02:06:36 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)) 02:06:36 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)) 02:06:36 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)) 02:06:36 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)) 02:06:36 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)) 02:06:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 02:06:36 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 02:06:36 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 02:06:36 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 02:06:36 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 02:06:36 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 02:06:36 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 02:06:38 INFO - Downloading blessings-1.6.tar.gz 02:06:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 02:06:38 INFO - Installing collected packages: blessings 02:06:38 INFO - Running setup.py install for blessings 02:06:38 INFO - Successfully installed blessings 02:06:38 INFO - Cleaning up... 02:06:38 INFO - Return code: 0 02:06:38 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 02:06:38 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:06:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:06:38 INFO - Reading from file tmpfile_stdout 02:06:38 INFO - Current package versions: 02:06:38 INFO - argparse == 1.2.1 02:06:38 INFO - blessings == 1.6 02:06:38 INFO - blobuploader == 1.2.4 02:06:38 INFO - docopt == 0.6.1 02:06:38 INFO - manifestparser == 1.1 02:06:38 INFO - mozInstall == 1.12 02:06:38 INFO - mozcrash == 0.16 02:06:38 INFO - mozdebug == 0.1 02:06:38 INFO - mozdevice == 0.48 02:06:38 INFO - mozfile == 1.2 02:06:38 INFO - mozhttpd == 0.7 02:06:38 INFO - mozinfo == 0.9 02:06:38 INFO - mozleak == 0.1 02:06:38 INFO - mozlog == 3.1 02:06:38 INFO - moznetwork == 0.27 02:06:38 INFO - mozprocess == 0.22 02:06:38 INFO - mozprofile == 0.28 02:06:38 INFO - mozrunner == 6.11 02:06:38 INFO - mozscreenshot == 0.1 02:06:38 INFO - mozsystemmonitor == 0.0 02:06:38 INFO - moztest == 0.7 02:06:38 INFO - mozversion == 1.4 02:06:38 INFO - psutil == 3.1.1 02:06:38 INFO - requests == 1.2.3 02:06:38 INFO - wsgiref == 0.1.2 02:06:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:38 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 0x7f7032e5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fa630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298b840>, '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 0x28f86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f8b60>, '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': 'cbe409c6de289db6ac707de3000001d4-1453369935.764859-141208108', '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 02:06:38 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 02:06:38 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 02:06:38 INFO - Using env: {'DISPLAY': ':0', 02:06:38 INFO - 'HOME': '/home/cltbld', 02:06:38 INFO - 'LANG': 'en_US.UTF-8', 02:06:38 INFO - 'LANGUAGE': 'en_US:en', 02:06:38 INFO - 'LOGNAME': 'cltbld', 02:06:38 INFO - 'MAIL': '/var/mail/cltbld', 02:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:38 INFO - 'MOZ_NO_REMOTE': '1', 02:06:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:38 INFO - 'NO_EM_RESTART': '1', 02:06:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:38 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:38 INFO - 'SHELL': '/bin/bash', 02:06:38 INFO - 'SHLVL': '1', 02:06:38 INFO - 'TERM': 'linux', 02:06:38 INFO - 'TMOUT': '86400', 02:06:38 INFO - 'USER': 'cltbld', 02:06:38 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453369935.764859-141208108', 02:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:38 INFO - '_': '/tools/buildbot/bin/python'} 02:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:39 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)) 02:06:39 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)) 02:06:39 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)) 02:06:39 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)) 02:06:39 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)) 02:06:39 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)) 02:06:39 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)) 02:06:39 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)) 02:06:39 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)) 02:06:39 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)) 02:06:39 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)) 02:06:39 INFO - Cleaning up... 02:06:39 INFO - Return code: 0 02:06:39 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 02:06: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')]} 02:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06: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')]} 02:06:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:39 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 0x7f7032e5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fa630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298b840>, '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 0x28f86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f8b60>, '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': 'cbe409c6de289db6ac707de3000001d4-1453369935.764859-141208108', '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 02:06:39 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 02:06:39 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 02:06:39 INFO - Using env: {'DISPLAY': ':0', 02:06:39 INFO - 'HOME': '/home/cltbld', 02:06:39 INFO - 'LANG': 'en_US.UTF-8', 02:06:39 INFO - 'LANGUAGE': 'en_US:en', 02:06:39 INFO - 'LOGNAME': 'cltbld', 02:06:39 INFO - 'MAIL': '/var/mail/cltbld', 02:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:39 INFO - 'MOZ_NO_REMOTE': '1', 02:06:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:39 INFO - 'NO_EM_RESTART': '1', 02:06:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:39 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:39 INFO - 'SHELL': '/bin/bash', 02:06:39 INFO - 'SHLVL': '1', 02:06:39 INFO - 'TERM': 'linux', 02:06:39 INFO - 'TMOUT': '86400', 02:06:39 INFO - 'USER': 'cltbld', 02:06:39 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453369935.764859-141208108', 02:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:39 INFO - '_': '/tools/buildbot/bin/python'} 02:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:39 INFO - Downloading/unpacking jsonschema 02:06:39 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 02:06:39 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 02:06:39 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 02:06:39 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 02:06:39 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 02:06:39 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 02:06:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:06:41 INFO - Downloading/unpacking functools32 (from jsonschema) 02:06:41 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 02:06:41 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 02:06:41 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 02:06:41 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 02:06:41 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 02:06:41 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 02:06:41 INFO - Downloading functools32-3.2.3-2.tar.gz 02:06:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 02:06:41 INFO - warning: no files found matching '*.txt' 02:06:41 INFO - no previously-included directories found matching 'build' 02:06:41 INFO - no previously-included directories found matching 'dist' 02:06:41 INFO - no previously-included directories found matching '.git*' 02:06:41 INFO - Installing collected packages: jsonschema, functools32 02:06:41 INFO - Running setup.py install for functools32 02:06:41 INFO - warning: no files found matching '*.txt' 02:06:41 INFO - no previously-included directories found matching 'build' 02:06:41 INFO - no previously-included directories found matching 'dist' 02:06:41 INFO - no previously-included directories found matching '.git*' 02:06:41 INFO - Successfully installed jsonschema functools32 02:06:41 INFO - Cleaning up... 02:06:41 INFO - Return code: 0 02:06:41 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 02:06: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')]} 02:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06: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')]} 02:06:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:41 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 0x7f7032e5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fa630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298b840>, '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 0x28f86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f8b60>, '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': 'cbe409c6de289db6ac707de3000001d4-1453369935.764859-141208108', '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 02:06:41 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 02:06:41 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 02:06:41 INFO - Using env: {'DISPLAY': ':0', 02:06:41 INFO - 'HOME': '/home/cltbld', 02:06:41 INFO - 'LANG': 'en_US.UTF-8', 02:06:41 INFO - 'LANGUAGE': 'en_US:en', 02:06:41 INFO - 'LOGNAME': 'cltbld', 02:06:41 INFO - 'MAIL': '/var/mail/cltbld', 02:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:41 INFO - 'MOZ_NO_REMOTE': '1', 02:06:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:41 INFO - 'NO_EM_RESTART': '1', 02:06:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:41 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:41 INFO - 'SHELL': '/bin/bash', 02:06:41 INFO - 'SHLVL': '1', 02:06:41 INFO - 'TERM': 'linux', 02:06:41 INFO - 'TMOUT': '86400', 02:06:41 INFO - 'USER': 'cltbld', 02:06:41 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453369935.764859-141208108', 02:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:41 INFO - '_': '/tools/buildbot/bin/python'} 02:06:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:41 INFO - Downloading/unpacking flake8 02:06:41 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 02:06:41 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 02:06:41 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 02:06:41 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 02:06:41 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 02:06:41 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 02:06:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:06:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:06:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:43 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 02:06:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:06:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:06:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:06:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:06:44 INFO - no previously-included directories found matching 'docs/_build' 02:06:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:06:44 INFO - Running setup.py install for pep8 02:06:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:06:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:06:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:06:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:06:44 INFO - no previously-included directories found matching 'docs/_build' 02:06:44 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 02:06:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:06:44 INFO - Cleaning up... 02:06:44 INFO - Return code: 0 02:06:44 INFO - Running post-action listener: _resource_record_post_action 02:06:44 INFO - Running post-action listener: _start_resource_monitoring 02:06:44 INFO - Starting resource monitoring. 02:06:44 INFO - ##### 02:06:44 INFO - ##### Running install step. 02:06:44 INFO - ##### 02:06:44 INFO - Running pre-action listener: _resource_record_pre_action 02:06:44 INFO - Running main action method: install 02:06:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:06:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:06:44 INFO - Reading from file tmpfile_stdout 02:06:44 INFO - Detecting whether we're running mozinstall >=1.0... 02:06:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 02:06:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 02:06:44 INFO - Reading from file tmpfile_stdout 02:06:44 INFO - Output received: 02:06:44 INFO - Usage: mozinstall [options] installer 02:06:44 INFO - Options: 02:06:44 INFO - -h, --help show this help message and exit 02:06:44 INFO - -d DEST, --destination=DEST 02:06:44 INFO - Directory to install application into. [default: 02:06:44 INFO - "/builds/slave/test-pgo"] 02:06:44 INFO - --app=APP Application being installed. [default: firefox] 02:06:44 INFO - mkdir: /builds/slave/test-pgo/build/application 02:06:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 02:06:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 02:07:00 INFO - Reading from file tmpfile_stdout 02:07:00 INFO - Output received: 02:07:00 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 02:07:00 INFO - Running post-action listener: _resource_record_post_action 02:07:00 INFO - ##### 02:07:00 INFO - ##### Running run-tests step. 02:07:00 INFO - ##### 02:07:00 INFO - Running pre-action listener: _resource_record_pre_action 02:07:00 INFO - Running main action method: run_tests 02:07:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 02:07:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 02:07:00 INFO - Python 2.7.3 02:07:00 INFO - Return code: 0 02:07:00 INFO - grabbing minidump binary from tooltool 02:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:00 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 0x298b840>, '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 0x28f86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f8b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 02:07:00 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 02:07:00 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 02:07:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:07:00 INFO - Return code: 0 02:07:00 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 02:07:00 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 02:07:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 02:07:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 02:07:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 02:07:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 02:07:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 02:07:01 INFO - Return code: 0 02:07:01 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/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 02:07:01 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/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 02:07:01 INFO - Using env: {'DISPLAY': ':0', 02:07:01 INFO - 'HOME': '/home/cltbld', 02:07:01 INFO - 'LANG': 'en_US.UTF-8', 02:07:01 INFO - 'LANGUAGE': 'en_US:en', 02:07:01 INFO - 'LOGNAME': 'cltbld', 02:07:01 INFO - 'MAIL': '/var/mail/cltbld', 02:07:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:07:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 02:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:01 INFO - 'MOZ_NO_REMOTE': '1', 02:07:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:01 INFO - 'NO_EM_RESTART': '1', 02:07:01 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:07:01 INFO - 'PWD': '/builds/slave/test-pgo', 02:07:01 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 02:07:01 INFO - 'SHELL': '/bin/bash', 02:07:01 INFO - 'SHLVL': '1', 02:07:01 INFO - 'TERM': 'linux', 02:07:01 INFO - 'TMOUT': '86400', 02:07:01 INFO - 'USER': 'cltbld', 02:07:01 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453369935.764859-141208108', 02:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:01 INFO - '_': '/tools/buildbot/bin/python'} 02:07:01 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/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 02:07:02 INFO - mozversion application_buildid: 20160120233027 02:07:02 INFO - mozversion application_changeset: 8150bbaade324fa7356aa955164f63efd10f917c 02:07:02 INFO - mozversion application_display_name: Nightly 02:07:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:07:02 INFO - mozversion application_name: Firefox 02:07:02 INFO - mozversion application_remotingname: firefox 02:07:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 02:07:02 INFO - mozversion application_vendor: Mozilla 02:07:02 INFO - mozversion application_version: 46.0a1 02:07:02 INFO - mozversion platform_buildid: 20160120233027 02:07:02 INFO - mozversion platform_changeset: 8150bbaade324fa7356aa955164f63efd10f917c 02:07:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 02:07:02 INFO - mozversion platform_version: 46.0a1 02:07:02 INFO - using testdate: 1453370822 02:07:02 INFO - actual date: 1453370822 02:07:02 INFO - starting webserver on 'localhost:38255' 02:07:02 INFO - SUITE-START | Running 3 tests 02:07:02 INFO - TEST-START | dromaeo_css 02:07:02 INFO - operating with platform_type : linux_ 02:07:02 INFO - Initialising browser for dromaeo_css test... 02:07:02 INFO - TEST-INFO | started process 8316 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYjrNHb/profile http://localhost:38255/getInfo.html) 02:07:06 INFO - PROCESS | 8316 | __metrics Screen width/height:1600/1200 02:07:06 INFO - PROCESS | 8316 | colorDepth:24 02:07:06 INFO - PROCESS | 8316 | Browser inner width/height: 1024/697 02:07:06 INFO - PROCESS | 8316 | __metrics 02:07:06 INFO - PROCESS | 8316 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:07:06 INFO - PROCESS | 8316 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:07:07 INFO - TEST-INFO | 8316: exit 0 02:07:07 INFO - Browser initialized. 02:07:07 INFO - Running cycle 1/1 for dromaeo_css test... 02:07:07 INFO - TEST-INFO | started process 8411 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYjrNHb/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:07:19 INFO - PROCESS | 8411 | RSS: Main: 149377024 02:07:19 INFO - PROCESS | 8411 | 02:08:10 INFO - PROCESS | 8411 | 1453370890626 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:10:18 INFO - PROCESS | 8411 | Cycle 1(1): loaded http://localhost:38255/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38255/tests/dromaeo/cssquery-ext.html) 02:10:19 INFO - PROCESS | 8411 | RSS: Main: 268546048 02:10:19 INFO - PROCESS | 8411 | 02:13:22 INFO - PROCESS | 8411 | Cycle 1(1): loaded http://localhost:38255/tests/dromaeo/cssquery-ext.html (next: http://localhost:38255/tests/dromaeo/cssquery-jquery.html) 02:13:23 INFO - PROCESS | 8411 | RSS: Main: 238694400 02:13:23 INFO - PROCESS | 8411 | 02:16:25 INFO - PROCESS | 8411 | Cycle 1(1): loaded http://localhost:38255/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38255/tests/dromaeo/cssquery-mootools.html) 02:16:25 INFO - PROCESS | 8411 | RSS: Main: 243400704 02:16:25 INFO - PROCESS | 8411 | 02:19:27 INFO - PROCESS | 8411 | Cycle 1(1): loaded http://localhost:38255/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38255/tests/dromaeo/cssquery-prototype.html) 02:19:28 INFO - PROCESS | 8411 | RSS: Main: 212967424 02:19:28 INFO - PROCESS | 8411 | 02:22:30 INFO - PROCESS | 8411 | Cycle 1(1): loaded http://localhost:38255/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38255/tests/dromaeo/cssquery-yui.html) 02:22:31 INFO - PROCESS | 8411 | RSS: Main: 216903680 02:22:31 INFO - PROCESS | 8411 | 02:25:33 INFO - PROCESS | 8411 | Cycle 1(1): loaded http://localhost:38255/tests/dromaeo/cssquery-yui.html (next: http://localhost:38255/tests/dromaeo/cssquery-dojo.html) 02:25:33 INFO - PROCESS | 8411 | RSS: Main: 294445056 02:25:33 INFO - PROCESS | 8411 | 02:25:33 INFO - PROCESS | 8411 | __start_tp_report 02:25:33 INFO - PROCESS | 8411 | _x_x_mozilla_page_load 02:25:33 INFO - PROCESS | 8411 | _x_x_mozilla_page_load_details 02:25:33 INFO - PROCESS | 8411 | |i|pagename|runs| 02:25:33 INFO - PROCESS | 8411 | |0;dojo.html;3084.259777653363;3120.438321102201;3126.5310203469476;3144.2453811085334;3169.2393825481886;4964.106460837048;5077.847664570059;5090.363704536933;5116.795328186873;5139.614528910332;5160.354955630546;5190.325257716501;5205.219217117435;5216.374035115782;5228.581713462923;4658.3478313036285;4667.439907211139;4680.227762419197;4746.90506189876;4751.263554149113;4803.111424386482;4808.97595512022;4824.686395384307;4825.710457372569;4860.198067318888;4594.173048851206;4645.790939407735;4650.837220697294;4721.881952951169;4744.786484608167;4666.346711460398;4686.835960741358;4721.6458765592715;4731.952680473186;4747.45404278509;4607.907841843178;4691.132140553975;4697.154512187805;4702.929456058162;4734.763261836894;4928.482509336504;4947.158982972904;4952.158133117378;4966.205407134841;4995.300657907896;5511.476409741068;5519.227308176858;5519.39286678465;5522.6134170608075;5525.557955363602;5419.566434685215;5485.259489968883;5579.46995035471;5583.832485025456;5633.436656334375;5148.922766158511;5157.174852023696;5211.140161873286;5230.267762513251;5232.9738351308;5644.350899646511;5664.575156863251;5667.858303542444;5712.6001179917;5714.942850571441;5451.100568406168;5455.754491047913;5456.154296084113;5456.372517160498;5458.699771512605;5439.755211015435;5453.536449401845;5467.234587157801;5505.697186654773;5560.555155587544;5466.070767969455;5483.835484935458;5490.423505531941;5493.423190564933;5517;5494.148406996922;5517.44825517445;5520.66875987442;5525.11598144303;5572.024895643246;4266.445362102907;4299.054208074219;4316.870493885189;4319.97840010798;4362.738235705868;3844.442555829389;3857.1707082977296;3862.0537968197973;3862.3240932836643;3897.162110146332;5051.621128415383;5138.665986710852;5150.4334523202415;5152;5201.323827902348;5432.103702889058;5438.401775804658;5490.670559766427;5552.500274975191;5568.220449137124;5133.153029750049;5163.509466600667;5173.224016397495;5174.068667639861;5178.067947769362;4732.52674732524;4737.0525894820485;4743.146233677902;4771.308160316735;4794.712317260975;5615.663060216319;5655.4344565543115;5665.348484924204;5723.59934804568;5757.6545407276535;5560.749766260609;5570.969370666439;5575.693336866511;5576.442355764391;5578.163275508706;5729.656220626775;5752.022156233366;5756.510696590837;5759.280089988752;5760.971195143998;5374.3013408256675;5442.537384322219;5477.233187353694;5517.475839795213;5558.805441809517;5531.585131115263;5542.196381524737;5564.693941833238;5577.9442205577425;5579.023670857502;5368.489993450616;5435.402105768441;5446.400895901527;5450.236966824568;5491.313585801775;5325.387580428145;5345.572354211731;5369.624126311121;5371.301730774974;5402.51377376038;5303.04545181871;5328.067588172132;5331.973340133274;5344.893102137858;5380.704061276668;5222.321098257202;5306.28365170697;5410.945890541044;5415.268938693226;5429.104197807317;5270.8155214567305;5302.231176479466;5355.036093503207;5355.3305836770405;5373.140297552372 02:25:33 INFO - PROCESS | 8411 | |1;ext.html;524.9790008399663;534.190701087852;536.1796451429312;552.1634723394058;560.6383882395852;28599;29241;29280.560791588145;29322.560161597565;29326.56010159844;29238.415231695355;36310.27379452416;36892.81553592235;37009.62990370095;37058.62941370586;8331.500109993405;8385.371097167706;8458.619362128718;8477.965288330786;8482.151784821499;8230.176982301782;8356.331493480508;8362.58187090646;8373.790655233606;8380.329573634124;8304.792380190513;8389.07720150783;8396.45423047503;8396.538190399526;8590.140985901422;8496.447730897502;8564.785880352978;8577.142285771373;8577.142285771373;8579.485230886166;8379.287760540361;8467.95766021166;8492.490450572923;8508.532030738306;8510.872336914952;40007.19985600301;40066.19867602661;40291;40381;40382.78851634455;3068.5704001439817;3123.5470856725874;3137.7176054155007;3184.2357834119643;3289.523019162208;30223.395532089457;30315;30524.236894077603;30908.69091309103;31727.365452690818;3926.932492838947;4050.4936882889638;4070.0638853063665;4074.653654439376;4097.795110244476;280604;283932;284036;284301;284656;53138;53836;61793.38206617966;62040.379596203464;62123.37876621266;66965.3303466959;68090.65954670195;68095.65952170307;68116;68166.65916670384;13809.861901380858;14030;14119.364628591738;14149.575512734635;14165.645858853404;10400.27198096126;10437.269391142547;10453.425061621532;10455.059044685862;10457.111145552713;18261.26954921815;18620.44138675842;20338.491537711674;20431.182752690023;21244.468888277606;7834.412419068479;8117.715879944174;8136.796580085545;8179.79550511242;8198.303144232807;924.4222361024359;941.5010044676333;987.9604815807287;1000.009990109786;1064.2337516987757;28909.56635650467;29825.850870745508;31793.364132717215;33949.151271217925;34312.828435857664;1042.61944390297;1047.8375851742992;1057.006413970865;1122.6183097746805;1147.5180424221846;15029.549113526611;15133.924330378277;15665.45170919035;15682.843171568367;16386.590335241715;412897;418815;420006;420371;421287;56190;56408.71795641078;56907.43092569021;57188.14217786737;57266.42733572694;1303.7197002644286;1307.5292894557952;1326.5688651188595;1328.5881376773038;1328.9601311960657;30171.69828301689;30775.846120769253;30827.383452330378;31139.221519462193;31280;47151;47619.523804761506;47752.7612361936;47795;47847.76076119597;313270;313343;313469;315270;315832;28697.139085827457;32576.51135232926;33034.66965330316;33318.50022249717;33525.66474335225;32763.34473310473;46899.53100468952;47355.76322118505;47627.76186119047;47684.5231547694;34609.65390346065;35588;36336;36636.26727465382;37016.62983370132;35849.82075089608;36084.27831443304;38887;39689.2062158761;40545.59454405536;33301;33859.32281354408;41532.169356612096;41902;42592;30138;33864.49203261904;34420.82789586036;34450.31099377948;34708.65291347155;25900.22299331023;25904.22287331383;26016.34959126037;26088.608670870333;26500.602490962265 02:25:33 INFO - PROCESS | 8411 | |2;jquery.html;365.641671162261;367.9411294192929;368.58165981610864;371.0427098086936;372.11436780462503;13690.863091369083;13753.724925501483;15566.844331556682;16991.490255292345;17915.820841791578;15292.464763733271;15466;15560.221988900537;15567.143807090606;16349.83650163498;5229.8954020919555;5411.377691565462;5414.10667239905;5416.783328666848;5417.7291135443265;4004.079061815784;4140.503139623234;5161.251618515313;5625.1843482694985;5883.764649414018;5622.409646987069;5785.595008349417;5799.217105690741;5844.123381492789;5848.2689663792025;5768.97115514424;5794.565407594448;5804.738786754564;5805.477507024367;5816.418358164171;4918;5102.719350435725;5116.6674166179455;5117.437081920985;5161.4322424533275;12567.308798016105;13828.37772300249;19420;20334.694979575317;20347.898260508602;2085.4600411315637;2095.559932414195;2136.7649558548546;2180.858244214121;2233.8324625652976;8855.158759917862;9071.682491112779;9222.538873056388;9254.814903701888;9348.906510934872;1766.8939863608225;1816.7910690270523;1822.8723989320754;1842.1249906294536;1849.7687789026372;49820.50179498231;55371.44628553744;55948.88102237973;56278;56454.43545564574;9353.204977576983;9500.857487137699;9728.124468797841;9734.221262299141;9756.658516951873;12282;12302.323372214614;12304.323262220485;12377.071719621064;12469.75060498785;6948.33990770876;7041.823954401181;7043.471739619549;7087.574745515286;7095.361417472349;6839.726410943506;6881.724731010703;6914.343137401939;6927.653617319214;6937.583744975318;3935.822887969991;4024.5170579530645;4092.897677558085;4121.876343709693;4211.515675697273;1639.4917575551378;1681.28545368218;1754.7455618935182;1772.6277481728723;1786.857051435882;438.6227844054111;443.44347843456256;453.18426831702806;828.4904783558069;848.2154007542998;10366.274360794672;10696.78606427867;10768.676939691823;10793.460326983619;10877.83683244752;457.94733605635776;475.53397670282624;876.3558784293539;884.7213127864702;974.9860145448796;7109.395701365442;9130.81738365229;9205.171534561921;9432.575534100844;9991.500424978722;332989;553364;558042;570901;572437;57679.790026246716;71562;73536;74379;74906.25093748992;1175.3065691242036;1187.590281352932;1218.244688293246;1231.7844377233948;1252.6743046807896;12065.457054432396;14701.264936753334;15152.469663561722;15266.465673701367;15332.77000844966;33446;33836.66163338335;34030.31939361149;34327.65672343245;34547.82726086354;41065.58934410737;41421;41480;42114.789426052674;42376.57623423726;7015.333543313581;7229.421646268181;7282.271772822675;7313.524620899624;7387.667554960147;8236.794080148044;10639.255252132585;10882.020618144405;10990.835137472784;11220;9089.727438158796;9377.156055954996;9680;9779.706608801747;9791.06984836468;9181.403208791407;9467.810643787223;9531.714048578553;9797.510124493889;9881.456519891188;9129.680461183827;9557.61769529211;9831.655892043744;10017.499125043865;10068.14420774213;7553.244675532403;7661.885071723817;7683.769486915401;7695.807604809701;7705.383569314329;8991.730248092568;9950.303478756417;10004.447087157923;10082.29423940317;10195.7451063724 02:25:33 INFO - PROCESS | 8411 | |3;mootools.html;1349.1904857085744;1476.0258229568483;1485.7474229381007;1628.885977981541;1778.6264884374282;7104.715811367546;7569.394448444125;7634.9236507634905;7642.923570764291;7682.654280557388;7702.96148519258;7824.530528168314;7851.646675899584;7851.92148078519;7859.096203936549;2085.2180432337873;2133.797289257518;2134.7438307403054;2356.081128359941;2384.9642255366184;2123.140128248062;2289.839711220215;2341.274204996448;2342.80086192673;2343.3672908314743;2227.209340684058;2245.158065725353;2250.4823890505195;2278.4759505313787;2279.791710393494;2296.9770302297097;2336.6962294901723;2341.934419838969;2346.671465994762;2349.48311371498;2311.653252012195;2320.1299512682745;2320.3155069254612;2326.93019209424;2333.381653861728;7765.26230008154;7786.532808031479;7820.257075577811;7828.334591559725;7840.4511684182135;4797.472278049412;4839.612830973549;4856.15017371962;4861.197902346109;4947.158982972904;3121.266502371941;3204.7275981541598;3221.758368122377;3241.286916878283;3249.545063691085;1045.8326667733127;1054.1092776603757;1069.171392171066;1081.9126777588474;1107.634480621393;11011.83482247767;11026.834597481044;11076.723081923017;11076.889231107667;11109.611163609236;4455.509893911667;4556.202664533694;4573.108243892409;4576.199165146086;4615.9076818463445;9466.857997130048;9469.47917864524;9470.763230919145;9480.24158067353;9483.383580067411;4917.090338287357;4938.777755001033;4939.753012349368;4940.851774446773;4944.1100601891285;4421.668374871898;4452.666050046259;4478.104379124188;4479.574440428154;4490.887727806766;3531.911702207465;3604.5494313210847;3829.9808500957315;3893.591172926802;3942.15243722601;1174.4010554617207;1208.5890797129018;1209.7157168065673;1250.2685928731612;1291.9870801292054;1086.8315411111291;1297.3837427221995;1326.9601911942657;1342.2080972226433;1342.3489607540334;7209.0988626421695;7312.561246325237;7316.378107860892;7318.926810731931;7334.156571994289;1113.6380676280241;1114.9554017839357;1124.128800179867;1129.170060005895;1139.168407062832;5851.765929362778;5985.16207730918;5995.490383317467;6002.879942401128;6004.219451471281;9133.45199288045;9260.49067301305;9397.90602093984;9430.245580353556;9490.952545237367;9228.815423691623;9232.723018309462;9238.538073096319;9248.16766491019;9376.062393760569;7275.454340924452;7325.157606875171;7388.74139405129;7389.519681220596;7464.85070298591;7391;7459;7480.326770590673;7505.211952744883;7519.736809211651;8116.594170291343;8123.959380203061;8351.039630442578;8503.74488765338;8509.446885952393;8398.580070996548;8503.489790612583;8611.052784193858;8618.267447267053;8627.913720862962;7058.964705176441;7192.388646965067;7198.280171982759;7211.42308615299;7214.242504536948;7578.507397019176;7609.239076092346;7635.656395462106;7652.1582625912215;7655.349295309961;6798.252192258748;6980.476464265099;7038.964805176146;7064.576125432491;7086;6858.3141685831015;6904.654767261516;6940.063091482585;6940.201876784033;7036.366726994595;7013.123359580052;7013.368796808311;7016.5790052597;7019.7894063176145;7037.542559733601;6309.400606942333;6438.4527315176865;6445;6469.870602587827;6483.2544257411;6498.155239818793;6531.934680653133;6624.271330153583;6633.237177724431;6641.966790166019 02:25:33 INFO - PROCESS | 8411 | |4;prototype.html;331.42166918726815;338.7967219668199;341.84104391457964;345.025303517563;346.81445426696723;5818.1272809078655;5820.621659592123;5827.737751801168;5838.883222335551;5858.7949421770245;5577.442255774431;5617.466340697627;5732.254806875111;5777.19119323295;5778.884422311562;4492.360288494709;4504.8198072077075;4517.570830771071;4526.818927242906;4530.116627257686;4343.761093139876;4506.143832671798;4516.164509565724;4524.841630542932;4530.6602004849765;4380.58384453478;4413.470383553978;4458.643308535309;4465.933011004838;4467.396901418316;4465.776711164429;4473.463184417858;4484.753338566377;4487.70829896059;4501.5273396293405;3961.7622942623534;3963.920721585552;3968.4245784361397;3981.0445493081743;3984.2828290907623;5478.424765399655;5552.472515111058;5568.7215639217875;5591.133374326986;5595.132754423071;5210.921836172461;5223.6343455958095;5225.947740522623;5229.058769421503;5233.476652334774;6095.756169753205;6148.354422785588;6155.476784473325;6155.538334624876;6158.414950579688;4333.306670932667;4370.344448332744;4382.8904277393;4401.427814384142;4407.338899165119;6264.59280146789;6438.195225596801;6448.45188159007;6457.773977910798;6462.1276127723095;4499.6400287976885;4506.549345065533;4507.729536227836;4508.458984921765;4512.503624601291;4543.5002149763495;4558.111168322212;4561.977190114028;4565.155446242389;4577.313402989512;5192.636515443958;5200.24596433515;5216.191490319006;5219.243209734567;5221.295125158131;6096.9390306096375;6212.88761820983;6220.284667263322;6247.843803904848;6307.337729538424;1612.8306527814411;1619.2227730689335;1620.198001989023;1620.3032695940858;1622.9837701622832;1093.9835902461468;1094.9671509854718;1109.2789686703707;1116.4808364110727;1117.083991127284;5895.263092113486;5896.675682837399;5898.764049437975;5902.38025007368;5903.35063143054;6351.618902865843;6358.936410635927;6360.395762402564;6363.745450182034;6366.586171898812;5689.231953686282;5777.768889244383;5802.709864506758;5879.706014699248;5881.470667639933;3424.0412684448393;3439.8968030959113;3451.3960056989927;3471.0628130405153;3474.2183008822813;6676.6995485202315;6694.765683201064;6709.261981182066;6709.966450167718;6715.294894036154;6437.8239635663385;6550.47596192313;6584.572002819801;6599.439047680905;6607.108040414579;6701.1623547056615;6705.966470167618;6710.16122984627;6715.731370745116;6717.865642687118;6388.872222555616;6406.391392817675;6423.100765892872;6436.935630643634;6443;6265.2980655348665;6330.905036424365;6364.427201551883;6369.777057802955;6377.234731832024;6688.264290927897;6701.296363881722;6704.731810727516;6704.865902682017;6706.128203333536;4637.744924029211;4638.397008388888;4642.18761716705;4643.39802768058;4646.372739680235;6202.689865506616;6441.484681225397;6442.871142577029;6458.288553533412;6464.2889282177985;6262.373762623702;6302.432781049728;6310.842228944313;6312.305646378986;6316.684165791784;6231.127642130196;6274.121622972879;6278.591891527219;6285;6296.150019747275;6070.150178974859;6161.507079433724;6167.352427995175;6174.44430001302;6181.505479561534;6298.811035668938;6303.36966303366;6306.306306306395;6306.684665766785;6310.684465776784;6136.570440069152;6163.19878415803;6164.753409863555;6166.290876549075;6169.136320915165 02:25:33 INFO - PROCESS | 8411 | |5;yui.html;664.1233571685377;700.0269625220942;747.9700811967522;833.3541505333368;867.1285358214997;12900.612981610544;13035.739285214313;13117.081804273705;13151.802722959163;13187.802182967263;12222.938885305583;12240.693982650439;12282.57011004615;12291.938540307308;12303.69240768979;665.6372277108964;797.60518543321;818.5211651184035;823.115151212446;823.2714048067444;666.669998350817;797.8763291689768;817.2767101115526;820.5404973215019;820.9261166495014;851.8764779107025;855.3627547477107;859.3640705877636;859.5057841741024;861.3410740783306;686.9347411995902;697.7348607529157;854.9102344253857;855.5764896376303;857.1128881607538;616.3713012726994;621.8445388652837;623.0591806372411;623.1711823275078;624.4411251929544;13016.284104374256;13043.804342934769;13120.147190432592;13172.802407963889;13206.801897971538;12191.817122743167;13267.800982985264;13313.933430332787;13411.195328280237;13464.124831885896;9930.2055835533;10145.898541014569;10209.38743675382;10273.589056437733;10283.742906427324;3607.332643460968;3642.8907132786057;3667.651573100551;3671.8714844980564;3773.792441415721;47258.81852953669;47586;47586.524134758554;47666.523334766556;47922.76038619784;9597.28020398459;9690.224782017422;9962.452065136487;10015.749606259902;10681.626143084955;18621;18639.906800466182;18655.626887462447;18692.813071869106;18694.439166825017;6924.446044316443;6932.757353492704;7026.613536255555;7180.964095179491;7303.415726741848;3956.050547868491;3969.364901615728;3974.423708562242;3981.402789581586;4048.3117869962175;3049;3065.816051036945;3066.681327029354;3073.523603841408;3076.123304858105;537.1915267522354;547.0809040811475;548.44333002003;551.6414330685087;553.7674176845735;496.9403671559436;520.1988937036996;522.7837490638068;639.3223183425583;651.5894986158689;8200.58997050157;8574.399792014623;8625.913740862636;8641.697540586048;8880.911190888137;582.1791274303212;676.5534747066912;687.8968154776724;704.2851505721696;723.5658604837056;3903.7072219583647;3993.121513267077;4110.876673699794;4124.628783409447;4195.244855925902;47279.5272047282;47955;48905;49115.75442122838;49178.75410622924;44458.33312500315;44985.77507112444;48594;49354.259686104735;49399;43911.78044109759;44035.11929761387;44412.3338149928;44959.55040449619;45215.321770173476;8262.586870656563;8593.88279523658;8821.823563528822;9126.680566180152;9264.39781414206;33145.668543314256;34122;34292.142696431794;34947.12632184216;35003.47494787529;41726.79136604298;41939.161216776105;42189.57810421979;44888;44976.77511612421;11269.436528173723;11290.15323850698;11320.37737924422;11363.886361136283;11810.76378472443;11237.213395062266;11288.604898828502;12144.414684416279;12832.55086071983;13082.28047457399;11038.668839934815;11819.290842549475;11852.70368240801;11914.702132446759;12316.199447035913;10312.587496500357;11229.27009744364;11426.628804543509;11559.133065020325;11582.884171158517;11473.541058357907;11853.229540079867;11941.940290298493;11950.34273114987;12344.13591048618;9056.954715226646;9367.437953722798;9402.529873506433;9849.704508864745;9988.101070903653;8820.955895220482;8830.033019663142;9024.503652299187;9046.954765226132;9378.296627752808 02:25:33 INFO - PROCESS | 8411 | __end_tp_report 02:25:33 INFO - PROCESS | 8411 | __start_cc_report 02:25:33 INFO - PROCESS | 8411 | _x_x_mozilla_cycle_collect,980 02:25:33 INFO - PROCESS | 8411 | __end_cc_report 02:25:33 INFO - PROCESS | 8411 | __startTimestamp1453371933953__endTimestamp 02:25:33 INFO - PROCESS | 8411 | 02:25:33 INFO - PROCESS | 8411 | ------- Summary: start ------- 02:25:33 INFO - PROCESS | 8411 | Number of tests: 6 02:25:33 INFO - PROCESS | 8411 | 02:25:33 INFO - PROCESS | 8411 | [#0] dojo.html Cycles:165 Average:5134.97 Median:5331.97 stddev:555.37 (10.4%) stddev-sans-first:533.26 02:25:33 INFO - PROCESS | 8411 | Values: 3084.3 3120.4 3126.5 3144.2 3169.2 4964.1 5077.8 5090.4 5116.8 5139.6 5160.4 5190.3 5205.2 5216.4 5228.6 4658.3 4667.4 4680.2 4746.9 4751.3 4803.1 4809.0 4824.7 4825.7 4860.2 4594.2 4645.8 4650.8 4721.9 4744.8 4666.3 4686.8 4721.6 4732.0 4747.5 4607.9 4691.1 4697.2 4702.9 4734.8 4928.5 4947.2 4952.2 4966.2 4995.3 5511.5 5519.2 5519.4 5522.6 5525.6 5419.6 5485.3 5579.5 5583.8 5633.4 5148.9 5157.2 5211.1 5230.3 5233.0 5644.4 5664.6 5667.9 5712.6 5714.9 5451.1 5455.8 5456.2 5456.4 5458.7 5439.8 5453.5 5467.2 5505.7 5560.6 5466.1 5483.8 5490.4 5493.4 5517.0 5494.1 5517.4 5520.7 5525.1 5572.0 4266.4 4299.1 4316.9 4320.0 4362.7 3844.4 3857.2 3862.1 3862.3 3897.2 5051.6 5138.7 5150.4 5152.0 5201.3 5432.1 5438.4 5490.7 5552.5 5568.2 5133.2 5163.5 5173.2 5174.1 5178.1 4732.5 4737.1 4743.1 4771.3 4794.7 5615.7 5655.4 5665.3 5723.6 5757.7 5560.7 5571.0 5575.7 5576.4 5578.2 5729.7 5752.0 5756.5 5759.3 5761.0 5374.3 5442.5 5477.2 5517.5 5558.8 5531.6 5542.2 5564.7 5577.9 5579.0 5368.5 5435.4 5446.4 5450.2 5491.3 5325.4 5345.6 5369.6 5371.3 5402.5 5303.0 5328.1 5332.0 5344.9 5380.7 5222.3 5306.3 5410.9 5415.3 5429.1 5270.8 5302.2 5355.0 5355.3 5373.1 02:25:33 INFO - PROCESS | 8411 | 02:25:33 INFO - PROCESS | 8411 | [#1] ext.html Cycles:180 Average:50439.16 Median:36323.14 stddev:90551.99 (249.3%) stddev-sans-first:90728.46 02:25:33 INFO - PROCESS | 8411 | Values: 525.0 534.2 536.2 552.2 560.6 28599.0 29241.0 29280.6 29322.6 29326.6 29238.4 36310.3 36892.8 37009.6 37058.6 8331.5 8385.4 8458.6 8478.0 8482.2 8230.2 8356.3 8362.6 8373.8 8380.3 8304.8 8389.1 8396.5 8396.5 8590.1 8496.4 8564.8 8577.1 8577.1 8579.5 8379.3 8468.0 8492.5 8508.5 8510.9 40007.2 40066.2 40291.0 40381.0 40382.8 3068.6 3123.5 3137.7 3184.2 3289.5 30223.4 30315.0 30524.2 30908.7 31727.4 3926.9 4050.5 4070.1 4074.7 4097.8 280604.0 283932.0 284036.0 284301.0 284656.0 53138.0 53836.0 61793.4 62040.4 62123.4 66965.3 68090.7 68095.7 68116.0 68166.7 13809.9 14030.0 14119.4 14149.6 14165.6 10400.3 10437.3 10453.4 10455.1 10457.1 18261.3 18620.4 20338.5 20431.2 21244.5 7834.4 8117.7 8136.8 8179.8 8198.3 924.4 941.5 988.0 1000.0 1064.2 28909.6 29825.9 31793.4 33949.2 34312.8 1042.6 1047.8 1057.0 1122.6 1147.5 15029.5 15133.9 15665.5 15682.8 16386.6 412897.0 418815.0 420006.0 420371.0 421287.0 56190.0 56408.7 56907.4 57188.1 57266.4 1303.7 1307.5 1326.6 1328.6 1329.0 30171.7 30775.8 30827.4 31139.2 31280.0 47151.0 47619.5 47752.8 47795.0 47847.8 313270.0 313343.0 313469.0 315270.0 315832.0 28697.1 32576.5 33034.7 33318.5 33525.7 32763.3 46899.5 47355.8 47627.8 47684.5 34609.7 35588.0 36336.0 36636.3 37016.6 35849.8 36084.3 38887.0 39689.2 40545.6 33301.0 33859.3 41532.2 41902.0 42592.0 30138.0 33864.5 34420.8 34450.3 34708.7 25900.2 25904.2 26016.3 26088.6 26500.6 02:25:33 INFO - PROCESS | 8411 | 02:25:33 INFO - PROCESS | 8411 | [#2] jquery.html Cycles:180 Average:26386.10 Median:5117.05 stddev:85982.65 (1680.3%) stddev-sans-first:86201.65 02:25:33 INFO - PROCESS | 8411 | Values: 365.6 367.9 368.6 371.0 372.1 13690.9 13753.7 15566.8 16991.5 17915.8 15292.5 15466.0 15560.2 15567.1 16349.8 5229.9 5411.4 5414.1 5416.8 5417.7 4004.1 4140.5 5161.3 5625.2 5883.8 5622.4 5785.6 5799.2 5844.1 5848.3 5769.0 5794.6 5804.7 5805.5 5816.4 4918.0 5102.7 5116.7 5117.4 5161.4 12567.3 13828.4 19420.0 20334.7 20347.9 2085.5 2095.6 2136.8 2180.9 2233.8 8855.2 9071.7 9222.5 9254.8 9348.9 1766.9 1816.8 1822.9 1842.1 1849.8 49820.5 55371.4 55948.9 56278.0 56454.4 9353.2 9500.9 9728.1 9734.2 9756.7 12282.0 12302.3 12304.3 12377.1 12469.8 6948.3 7041.8 7043.5 7087.6 7095.4 6839.7 6881.7 6914.3 6927.7 6937.6 3935.8 4024.5 4092.9 4121.9 4211.5 1639.5 1681.3 1754.7 1772.6 1786.9 438.6 443.4 453.2 828.5 848.2 10366.3 10696.8 10768.7 10793.5 10877.8 457.9 475.5 876.4 884.7 975.0 7109.4 9130.8 9205.2 9432.6 9991.5 332989.0 553364.0 558042.0 570901.0 572437.0 57679.8 71562.0 73536.0 74379.0 74906.3 1175.3 1187.6 1218.2 1231.8 1252.7 12065.5 14701.3 15152.5 15266.5 15332.8 33446.0 33836.7 34030.3 34327.7 34547.8 41065.6 41421.0 41480.0 42114.8 42376.6 7015.3 7229.4 7282.3 7313.5 7387.7 8236.8 10639.3 10882.0 10990.8 11220.0 9089.7 9377.2 9680.0 9779.7 9791.1 9181.4 9467.8 9531.7 9797.5 9881.5 9129.7 9557.6 9831.7 10017.5 10068.1 7553.2 7661.9 7683.8 7695.8 7705.4 8991.7 9950.3 10004.4 10082.3 10195.7 02:25:33 INFO - PROCESS | 8411 | 02:25:33 INFO - PROCESS | 8411 | [#3] mootools.html Cycles:180 Average:5541.40 Median:6373.93 stddev:2835.77 (44.5%) stddev-sans-first:2826.21 02:25:33 INFO - PROCESS | 8411 | Values: 1349.2 1476.0 1485.7 1628.9 1778.6 7104.7 7569.4 7634.9 7642.9 7682.7 7703.0 7824.5 7851.6 7851.9 7859.1 2085.2 2133.8 2134.7 2356.1 2385.0 2123.1 2289.8 2341.3 2342.8 2343.4 2227.2 2245.2 2250.5 2278.5 2279.8 2297.0 2336.7 2341.9 2346.7 2349.5 2311.7 2320.1 2320.3 2326.9 2333.4 7765.3 7786.5 7820.3 7828.3 7840.5 4797.5 4839.6 4856.2 4861.2 4947.2 3121.3 3204.7 3221.8 3241.3 3249.5 1045.8 1054.1 1069.2 1081.9 1107.6 11011.8 11026.8 11076.7 11076.9 11109.6 4455.5 4556.2 4573.1 4576.2 4615.9 9466.9 9469.5 9470.8 9480.2 9483.4 4917.1 4938.8 4939.8 4940.9 4944.1 4421.7 4452.7 4478.1 4479.6 4490.9 3531.9 3604.5 3830.0 3893.6 3942.2 1174.4 1208.6 1209.7 1250.3 1292.0 1086.8 1297.4 1327.0 1342.2 1342.3 7209.1 7312.6 7316.4 7318.9 7334.2 1113.6 1115.0 1124.1 1129.2 1139.2 5851.8 5985.2 5995.5 6002.9 6004.2 9133.5 9260.5 9397.9 9430.2 9491.0 9228.8 9232.7 9238.5 9248.2 9376.1 7275.5 7325.2 7388.7 7389.5 7464.9 7391.0 7459.0 7480.3 7505.2 7519.7 8116.6 8124.0 8351.0 8503.7 8509.4 8398.6 8503.5 8611.1 8618.3 8627.9 7059.0 7192.4 7198.3 7211.4 7214.2 7578.5 7609.2 7635.7 7652.2 7655.3 6798.3 6980.5 7039.0 7064.6 7086.0 6858.3 6904.7 6940.1 6940.2 7036.4 7013.1 7013.4 7016.6 7019.8 7037.5 6309.4 6438.5 6445.0 6469.9 6483.3 6498.2 6531.9 6624.3 6633.2 6642.0 02:25:33 INFO - PROCESS | 8411 | 02:25:33 INFO - PROCESS | 8411 | [#4] prototype.html Cycles:180 Average:5218.89 Median:5833.31 stddev:1553.48 (26.6%) stddev-sans-first:1513.90 02:25:33 INFO - PROCESS | 8411 | Values: 331.4 338.8 341.8 345.0 346.8 5818.1 5820.6 5827.7 5838.9 5858.8 5577.4 5617.5 5732.3 5777.2 5778.9 4492.4 4504.8 4517.6 4526.8 4530.1 4343.8 4506.1 4516.2 4524.8 4530.7 4380.6 4413.5 4458.6 4465.9 4467.4 4465.8 4473.5 4484.8 4487.7 4501.5 3961.8 3963.9 3968.4 3981.0 3984.3 5478.4 5552.5 5568.7 5591.1 5595.1 5210.9 5223.6 5225.9 5229.1 5233.5 6095.8 6148.4 6155.5 6155.5 6158.4 4333.3 4370.3 4382.9 4401.4 4407.3 6264.6 6438.2 6448.5 6457.8 6462.1 4499.6 4506.5 4507.7 4508.5 4512.5 4543.5 4558.1 4562.0 4565.2 4577.3 5192.6 5200.2 5216.2 5219.2 5221.3 6096.9 6212.9 6220.3 6247.8 6307.3 1612.8 1619.2 1620.2 1620.3 1623.0 1094.0 1095.0 1109.3 1116.5 1117.1 5895.3 5896.7 5898.8 5902.4 5903.4 6351.6 6358.9 6360.4 6363.7 6366.6 5689.2 5777.8 5802.7 5879.7 5881.5 3424.0 3439.9 3451.4 3471.1 3474.2 6676.7 6694.8 6709.3 6710.0 6715.3 6437.8 6550.5 6584.6 6599.4 6607.1 6701.2 6706.0 6710.2 6715.7 6717.9 6388.9 6406.4 6423.1 6436.9 6443.0 6265.3 6330.9 6364.4 6369.8 6377.2 6688.3 6701.3 6704.7 6704.9 6706.1 4637.7 4638.4 4642.2 4643.4 4646.4 6202.7 6441.5 6442.9 6458.3 6464.3 6262.4 6302.4 6310.8 6312.3 6316.7 6231.1 6274.1 6278.6 6285.0 6296.2 6070.2 6161.5 6167.4 6174.4 6181.5 6298.8 6303.4 6306.3 6306.7 6310.7 6136.6 6163.2 6164.8 6166.3 6169.1 02:25:33 INFO - PROCESS | 8411 | 02:25:33 INFO - PROCESS | 8411 | [#5] yui.html Cycles:180 Average:13290.77 Median:44981.28 stddev:14821.54 (33.0%) stddev-sans-first:14832.78 02:25:33 INFO - PROCESS | 8411 | Values: 664.1 700.0 748.0 833.4 867.1 12900.6 13035.7 13117.1 13151.8 13187.8 12222.9 12240.7 12282.6 12291.9 12303.7 665.6 797.6 818.5 823.1 823.3 666.7 797.9 817.3 820.5 820.9 851.9 855.4 859.4 859.5 861.3 686.9 697.7 854.9 855.6 857.1 616.4 621.8 623.1 623.2 624.4 13016.3 13043.8 13120.1 13172.8 13206.8 12191.8 13267.8 13313.9 13411.2 13464.1 9930.2 10145.9 10209.4 10273.6 10283.7 3607.3 3642.9 3667.7 3671.9 3773.8 47258.8 47586.0 47586.5 47666.5 47922.8 9597.3 9690.2 9962.5 10015.7 10681.6 18621.0 18639.9 18655.6 18692.8 18694.4 6924.4 6932.8 7026.6 7181.0 7303.4 3956.1 3969.4 3974.4 3981.4 4048.3 3049.0 3065.8 3066.7 3073.5 3076.1 537.2 547.1 548.4 551.6 553.8 496.9 520.2 522.8 639.3 651.6 8200.6 8574.4 8625.9 8641.7 8880.9 582.2 676.6 687.9 704.3 723.6 3903.7 3993.1 4110.9 4124.6 4195.2 47279.5 47955.0 48905.0 49115.8 49178.8 44458.3 44985.8 48594.0 49354.3 49399.0 43911.8 44035.1 44412.3 44959.6 45215.3 8262.6 8593.9 8821.8 9126.7 9264.4 33145.7 34122.0 34292.1 34947.1 35003.5 41726.8 41939.2 42189.6 44888.0 44976.8 11269.4 11290.2 11320.4 11363.9 11810.8 11237.2 11288.6 12144.4 12832.6 13082.3 11038.7 11819.3 11852.7 11914.7 12316.2 10312.6 11229.3 11426.6 11559.1 11582.9 11473.5 11853.2 11941.9 11950.3 12344.1 9057.0 9367.4 9402.5 9849.7 9988.1 8821.0 8830.0 9024.5 9047.0 9378.3 02:25:33 INFO - PROCESS | 8411 | -------- Summary: end -------- 02:25:33 INFO - PROCESS | 8411 | 02:25:34 INFO - TEST-INFO | 8411: exit 0 02:25:34 INFO - TEST-OK | dromaeo_css | took 1112560ms 02:25:34 INFO - TEST-START | kraken 02:25:34 INFO - operating with platform_type : linux_ 02:25:34 INFO - Initialising browser for kraken test... 02:25:34 INFO - TEST-INFO | started process 8610 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuFda5S/profile http://localhost:38255/getInfo.html) 02:25:38 INFO - PROCESS | 8610 | __metrics Screen width/height:1600/1200 02:25:38 INFO - PROCESS | 8610 | colorDepth:24 02:25:38 INFO - PROCESS | 8610 | Browser inner width/height: 1024/697 02:25:38 INFO - PROCESS | 8610 | __metrics 02:25:38 INFO - PROCESS | 8610 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:25:38 INFO - PROCESS | 8610 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:25:39 INFO - TEST-INFO | 8610: exit 0 02:25:39 INFO - Browser initialized. 02:25:39 INFO - Running cycle 1/1 for kraken test... 02:25:39 INFO - TEST-INFO | started process 8692 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuFda5S/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:25:51 INFO - PROCESS | 8692 | RSS: Main: 148967424 02:25:51 INFO - PROCESS | 8692 | 02:25:54 INFO - PROCESS | 8692 | Cycle 1(1): loaded http://localhost:38255/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38255/tests/kraken/driver.html?testName=audio-beat-detection) 02:25:54 INFO - PROCESS | 8692 | RSS: Main: 183943168 02:25:54 INFO - PROCESS | 8692 | 02:25:57 INFO - PROCESS | 8692 | Cycle 1(1): loaded http://localhost:38255/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38255/tests/kraken/driver.html?testName=audio-dft) 02:25:57 INFO - PROCESS | 8692 | RSS: Main: 176324608 02:25:57 INFO - PROCESS | 8692 | 02:26:00 INFO - PROCESS | 8692 | Cycle 1(1): loaded http://localhost:38255/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38255/tests/kraken/driver.html?testName=audio-fft) 02:26:01 INFO - PROCESS | 8692 | RSS: Main: 161316864 02:26:01 INFO - PROCESS | 8692 | 02:26:03 INFO - PROCESS | 8692 | Cycle 1(1): loaded http://localhost:38255/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38255/tests/kraken/driver.html?testName=audio-oscillator) 02:26:03 INFO - PROCESS | 8692 | RSS: Main: 163409920 02:26:03 INFO - PROCESS | 8692 | 02:26:06 INFO - PROCESS | 8692 | Cycle 1(1): loaded http://localhost:38255/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38255/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:26:06 INFO - PROCESS | 8692 | RSS: Main: 165724160 02:26:06 INFO - PROCESS | 8692 | 02:26:09 INFO - PROCESS | 8692 | Cycle 1(1): loaded http://localhost:38255/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38255/tests/kraken/driver.html?testName=imaging-darkroom) 02:26:10 INFO - PROCESS | 8692 | RSS: Main: 165969920 02:26:10 INFO - PROCESS | 8692 | 02:26:13 INFO - PROCESS | 8692 | Cycle 1(1): loaded http://localhost:38255/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38255/tests/kraken/driver.html?testName=imaging-desaturate) 02:26:14 INFO - PROCESS | 8692 | RSS: Main: 167153664 02:26:14 INFO - PROCESS | 8692 | 02:26:16 INFO - PROCESS | 8692 | Cycle 1(1): loaded http://localhost:38255/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38255/tests/kraken/driver.html?testName=json-parse-financial) 02:26:17 INFO - PROCESS | 8692 | RSS: Main: 166027264 02:26:17 INFO - PROCESS | 8692 | 02:26:19 INFO - PROCESS | 8692 | Cycle 1(1): loaded http://localhost:38255/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38255/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:26:19 INFO - PROCESS | 8692 | RSS: Main: 177885184 02:26:19 INFO - PROCESS | 8692 | 02:26:21 INFO - PROCESS | 8692 | Cycle 1(1): loaded http://localhost:38255/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38255/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:26:22 INFO - PROCESS | 8692 | RSS: Main: 175550464 02:26:22 INFO - PROCESS | 8692 | 02:26:24 INFO - PROCESS | 8692 | Cycle 1(1): loaded http://localhost:38255/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38255/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:26:24 INFO - PROCESS | 8692 | RSS: Main: 185999360 02:26:24 INFO - PROCESS | 8692 | 02:26:27 INFO - PROCESS | 8692 | Cycle 1(1): loaded http://localhost:38255/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38255/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:26:27 INFO - PROCESS | 8692 | RSS: Main: 193142784 02:26:27 INFO - PROCESS | 8692 | 02:26:30 INFO - PROCESS | 8692 | Cycle 1(1): loaded http://localhost:38255/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38255/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:26:30 INFO - PROCESS | 8692 | RSS: Main: 193327104 02:26:30 INFO - PROCESS | 8692 | 02:26:32 INFO - PROCESS | 8692 | Cycle 1(1): loaded http://localhost:38255/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38255/tests/kraken/driver.html?testName=ai-astar) 02:26:32 INFO - PROCESS | 8692 | RSS: Main: 250368000 02:26:32 INFO - PROCESS | 8692 | 02:26:32 INFO - PROCESS | 8692 | __start_tp_report 02:26:32 INFO - PROCESS | 8692 | _x_x_mozilla_page_load 02:26:32 INFO - PROCESS | 8692 | _x_x_mozilla_page_load_details 02:26:32 INFO - PROCESS | 8692 | |i|pagename|runs| 02:26:32 INFO - PROCESS | 8692 | |0;ai-astar;111;110;106;111;110;110;111;111;104;112 02:26:32 INFO - PROCESS | 8692 | |1;audio-beat-detection;147;125;158;174;135;152;150;135;174;126 02:26:32 INFO - PROCESS | 8692 | |2;audio-dft;162;162;158;160;164;159;161;159;161;160 02:26:32 INFO - PROCESS | 8692 | |3;audio-fft;73;82;129;100;73;73;74;125;95;74 02:26:32 INFO - PROCESS | 8692 | |4;audio-oscillator;95;96;137;95;95;96;145;94;95;142 02:26:32 INFO - PROCESS | 8692 | |5;imaging-gaussian-blur;110;109;111;109;109;110;109;109;109;109 02:26:32 INFO - PROCESS | 8692 | |6;imaging-darkroom;146;145;146;145;145;147;145;146;145;145 02:26:32 INFO - PROCESS | 8692 | |7;imaging-desaturate;96;97;97;96;96;95;96;97;96;96 02:26:32 INFO - PROCESS | 8692 | |8;json-parse-financial;57;56;56;56;57;55;55;56;56;54 02:26:32 INFO - PROCESS | 8692 | |9;json-stringify-tinderbox;67;67;68;69;69;68;67;68;68;69 02:26:32 INFO - PROCESS | 8692 | |10;stanford-crypto-aes;81;81;82;82;89;82;90;82;82;84 02:26:32 INFO - PROCESS | 8692 | |11;stanford-crypto-ccm;115;113;116;119;120;117;115;118;120;116 02:26:32 INFO - PROCESS | 8692 | |12;stanford-crypto-pbkdf2;135;132;140;139;140;129;145;139;144;142 02:26:32 INFO - PROCESS | 8692 | |13;stanford-crypto-sha256-iterative;66;67;65;66;67;64;66;66;67;66 02:26:32 INFO - PROCESS | 8692 | __end_tp_report 02:26:32 INFO - PROCESS | 8692 | __start_cc_report 02:26:32 INFO - PROCESS | 8692 | _x_x_mozilla_cycle_collect,961 02:26:32 INFO - PROCESS | 8692 | __end_cc_report 02:26:32 INFO - PROCESS | 8692 | __startTimestamp1453371992557__endTimestamp 02:26:32 INFO - PROCESS | 8692 | 02:26:32 INFO - PROCESS | 8692 | ------- Summary: start ------- 02:26:32 INFO - PROCESS | 8692 | Number of tests: 14 02:26:32 INFO - PROCESS | 8692 | 02:26:32 INFO - PROCESS | 8692 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:2.55 (2.3%) stddev-sans-first:2.65 02:26:32 INFO - PROCESS | 8692 | Values: 111.0 110.0 106.0 111.0 110.0 110.0 111.0 111.0 104.0 112.0 02:26:32 INFO - PROCESS | 8692 | 02:26:32 INFO - PROCESS | 8692 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:151.00 stddev:17.71 (11.7%) stddev-sans-first:18.78 02:26:32 INFO - PROCESS | 8692 | Values: 147.0 125.0 158.0 174.0 135.0 152.0 150.0 135.0 174.0 126.0 02:26:32 INFO - PROCESS | 8692 | 02:26:32 INFO - PROCESS | 8692 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.78 (1.1%) stddev-sans-first:1.81 02:26:32 INFO - PROCESS | 8692 | Values: 162.0 162.0 158.0 160.0 164.0 159.0 161.0 159.0 161.0 160.0 02:26:32 INFO - PROCESS | 8692 | 02:26:32 INFO - PROCESS | 8692 | [#3] audio-fft Cycles:10 Average:89.80 Median:73.50 stddev:21.89 (29.8%) stddev-sans-first:22.36 02:26:32 INFO - PROCESS | 8692 | Values: 73.0 82.0 129.0 100.0 73.0 73.0 74.0 125.0 95.0 74.0 02:26:32 INFO - PROCESS | 8692 | 02:26:32 INFO - PROCESS | 8692 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:95.00 stddev:22.40 (23.6%) stddev-sans-first:23.18 02:26:32 INFO - PROCESS | 8692 | Values: 95.0 96.0 137.0 95.0 95.0 96.0 145.0 94.0 95.0 142.0 02:26:32 INFO - PROCESS | 8692 | 02:26:32 INFO - PROCESS | 8692 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 02:26:32 INFO - PROCESS | 8692 | Values: 110.0 109.0 111.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 02:26:32 INFO - PROCESS | 8692 | 02:26:32 INFO - PROCESS | 8692 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 02:26:32 INFO - PROCESS | 8692 | Values: 146.0 145.0 146.0 145.0 145.0 147.0 145.0 146.0 145.0 145.0 02:26:32 INFO - PROCESS | 8692 | 02:26:32 INFO - PROCESS | 8692 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 02:26:32 INFO - PROCESS | 8692 | Values: 96.0 97.0 97.0 96.0 96.0 95.0 96.0 97.0 96.0 96.0 02:26:32 INFO - PROCESS | 8692 | 02:26:32 INFO - PROCESS | 8692 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.00 stddev:0.92 (1.6%) stddev-sans-first:0.87 02:26:32 INFO - PROCESS | 8692 | Values: 57.0 56.0 56.0 56.0 57.0 55.0 55.0 56.0 56.0 54.0 02:26:32 INFO - PROCESS | 8692 | 02:26:32 INFO - PROCESS | 8692 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 02:26:32 INFO - PROCESS | 8692 | Values: 67.0 67.0 68.0 69.0 69.0 68.0 67.0 68.0 68.0 69.0 02:26:32 INFO - PROCESS | 8692 | 02:26:32 INFO - PROCESS | 8692 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:82.00 stddev:3.27 (4.0%) stddev-sans-first:3.35 02:26:32 INFO - PROCESS | 8692 | Values: 81.0 81.0 82.0 82.0 89.0 82.0 90.0 82.0 82.0 84.0 02:26:32 INFO - PROCESS | 8692 | 02:26:32 INFO - PROCESS | 8692 | [#11] stanford-crypto-ccm Cycles:10 Average:116.90 Median:117.50 stddev:2.33 (2.0%) stddev-sans-first:2.37 02:26:32 INFO - PROCESS | 8692 | Values: 115.0 113.0 116.0 119.0 120.0 117.0 115.0 118.0 120.0 116.0 02:26:32 INFO - PROCESS | 8692 | 02:26:32 INFO - PROCESS | 8692 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.50 Median:140.00 stddev:5.10 (3.6%) stddev-sans-first:5.25 02:26:32 INFO - PROCESS | 8692 | Values: 135.0 132.0 140.0 139.0 140.0 129.0 145.0 139.0 144.0 142.0 02:26:32 INFO - PROCESS | 8692 | 02:26:32 INFO - PROCESS | 8692 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:0.94 (1.4%) stddev-sans-first:1.00 02:26:32 INFO - PROCESS | 8692 | Values: 66.0 67.0 65.0 66.0 67.0 64.0 66.0 66.0 67.0 66.0 02:26:32 INFO - PROCESS | 8692 | -------- Summary: end -------- 02:26:32 INFO - PROCESS | 8692 | 02:26:33 INFO - TEST-INFO | 8692: exit 0 02:26:33 INFO - TEST-OK | kraken | took 58818ms 02:26:33 INFO - TEST-START | v8_7 02:26:33 INFO - operating with platform_type : linux_ 02:26:33 INFO - Initialising browser for v8_7 test... 02:26:33 INFO - TEST-INFO | started process 8938 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprnfWpm/profile http://localhost:38255/getInfo.html) 02:26:37 INFO - PROCESS | 8938 | __metrics Screen width/height:1600/1200 02:26:37 INFO - PROCESS | 8938 | colorDepth:24 02:26:37 INFO - PROCESS | 8938 | Browser inner width/height: 1024/697 02:26:37 INFO - PROCESS | 8938 | __metrics 02:26:37 INFO - PROCESS | 8938 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:26:37 INFO - PROCESS | 8938 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:26:38 INFO - TEST-INFO | 8938: exit 0 02:26:38 INFO - Browser initialized. 02:26:38 INFO - Running cycle 1/1 for v8_7 test... 02:26:38 INFO - TEST-INFO | started process 9019 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprnfWpm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:26:50 INFO - PROCESS | 9019 | RSS: Main: 149569536 02:26:50 INFO - PROCESS | 9019 | 02:27:12 INFO - PROCESS | 9019 | Cycle 1(1): loaded http://localhost:38255/tests/v8_7/run.html (next: http://localhost:38255/tests/v8_7/run.html) 02:27:12 INFO - PROCESS | 9019 | RSS: Main: 569155584 02:27:12 INFO - PROCESS | 9019 | 02:27:12 INFO - PROCESS | 9019 | __start_tp_report 02:27:12 INFO - PROCESS | 9019 | _x_x_mozilla_page_load 02:27:12 INFO - PROCESS | 9019 | _x_x_mozilla_page_load_details 02:27:12 INFO - PROCESS | 9019 | |i|pagename|runs| 02:27:12 INFO - PROCESS | 9019 | |0;Richards;168.20857863751053 02:27:12 INFO - PROCESS | 9019 | |1;DeltaBlue;189.60940462646948 02:27:12 INFO - PROCESS | 9019 | |2;Encrypt;278.8622420524261 02:27:12 INFO - PROCESS | 9019 | |3;Decrypt;5251.308900523561 02:27:12 INFO - PROCESS | 9019 | |4;RayTrace;1119.8208286674133 02:27:12 INFO - PROCESS | 9019 | |5;Earley;793.0214115781126 02:27:12 INFO - PROCESS | 9019 | |6;Boyer;12382.716049382716 02:27:12 INFO - PROCESS | 9019 | |7;RegExp;42437.5 02:27:12 INFO - PROCESS | 9019 | |8;Splay;574.6268656716418 02:27:12 INFO - PROCESS | 9019 | |9;NavierStokes;4835.748792270531 02:27:12 INFO - PROCESS | 9019 | __end_tp_report 02:27:12 INFO - PROCESS | 9019 | __startTimestamp1453372032865__endTimestamp 02:27:12 INFO - PROCESS | 9019 | 02:27:12 INFO - PROCESS | 9019 | ------- Summary: start ------- 02:27:12 INFO - PROCESS | 9019 | Number of tests: 10 02:27:12 INFO - PROCESS | 9019 | 02:27:12 INFO - PROCESS | 9019 | [#0] Richards Cycles:1 Average:168.21 Median:168.21 stddev:0.00 (0.0%) 02:27:12 INFO - PROCESS | 9019 | Values: 168.2 02:27:12 INFO - PROCESS | 9019 | 02:27:12 INFO - PROCESS | 9019 | [#1] DeltaBlue Cycles:1 Average:189.61 Median:189.61 stddev:0.00 (0.0%) 02:27:12 INFO - PROCESS | 9019 | Values: 189.6 02:27:12 INFO - PROCESS | 9019 | 02:27:12 INFO - PROCESS | 9019 | [#2] Encrypt Cycles:1 Average:278.86 Median:278.86 stddev:0.00 (0.0%) 02:27:12 INFO - PROCESS | 9019 | Values: 278.9 02:27:12 INFO - PROCESS | 9019 | 02:27:12 INFO - PROCESS | 9019 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 02:27:12 INFO - PROCESS | 9019 | Values: 5251.3 02:27:12 INFO - PROCESS | 9019 | 02:27:12 INFO - PROCESS | 9019 | [#4] RayTrace Cycles:1 Average:1119.82 Median:1119.82 stddev:0.00 (0.0%) 02:27:12 INFO - PROCESS | 9019 | Values: 1119.8 02:27:12 INFO - PROCESS | 9019 | 02:27:12 INFO - PROCESS | 9019 | [#5] Earley Cycles:1 Average:793.02 Median:793.02 stddev:0.00 (0.0%) 02:27:12 INFO - PROCESS | 9019 | Values: 793.0 02:27:12 INFO - PROCESS | 9019 | 02:27:12 INFO - PROCESS | 9019 | [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 02:27:12 INFO - PROCESS | 9019 | Values: 12382.7 02:27:12 INFO - PROCESS | 9019 | 02:27:12 INFO - PROCESS | 9019 | [#7] RegExp Cycles:1 Average:42437.50 Median:42437.50 stddev:0.00 (0.0%) 02:27:12 INFO - PROCESS | 9019 | Values: 42437.5 02:27:12 INFO - PROCESS | 9019 | 02:27:12 INFO - PROCESS | 9019 | [#8] Splay Cycles:1 Average:574.63 Median:574.63 stddev:0.00 (0.0%) 02:27:12 INFO - PROCESS | 9019 | Values: 574.6 02:27:12 INFO - PROCESS | 9019 | 02:27:12 INFO - PROCESS | 9019 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 02:27:12 INFO - PROCESS | 9019 | Values: 4835.7 02:27:12 INFO - PROCESS | 9019 | -------- Summary: end -------- 02:27:12 INFO - PROCESS | 9019 | 02:27:13 INFO - TEST-INFO | 9019: exit 0 02:27:13 INFO - TEST-OK | v8_7 | took 40261ms 02:27:13 INFO - SUITE-END | took 1211s 02:27:13 INFO - Completed test suite (00:20:11) 02:27:13 INFO - Working with test: dromaeo_css 02:27:13 INFO - Generating results file: dromaeo_css 02:27:13 INFO - Working with test: kraken 02:27:13 INFO - Generating results file: kraken 02:27:13 INFO - javascript benchmark 02:27:13 INFO - Working with test: v8_7 02:27:13 INFO - Generating results file: v8_7 02:27:13 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:27:13 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 02:27:13 INFO - process_Request line: dromaeo_css 6793.34 graph.html#tests=[[72,201,35]] 02:27:13 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:27:13 INFO - process_Request line: kraken 1496.40 graph.html#tests=[[232,201,35]] 02:27:13 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:27:13 INFO - process_Request line: v8_7 20040.70 graph.html#tests=[[230,201,35]] 02:27:13 INFO - RETURN: dromaeo_css: 6793.34 02:27:13 INFO - RETURN: kraken: 1496.40 02:27:13 INFO - RETURN: v8_7: 20040.70 02:27:13 INFO - javascript benchmark 02:27:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3084.259777653363, 3120.438321102201, 3126.5310203469476, 3144.2453811085334, 3169.2393825481886, 4964.106460837048, 5077.847664570059, 5090.363704536933, 5116.795328186873, 5139.614528910332, 5160.354955630546, 5190.325257716501, 5205.219217117435, 5216.374035115782, 5228.581713462923, 4658.3478313036285, 4667.439907211139, 4680.227762419197, 4746.90506189876, 4751.263554149113, 4803.111424386482, 4808.97595512022, 4824.686395384307, 4825.710457372569, 4860.198067318888, 4594.173048851206, 4645.790939407735, 4650.837220697294, 4721.881952951169, 4744.786484608167, 4666.346711460398, 4686.835960741358, 4721.6458765592715, 4731.952680473186, 4747.45404278509, 4607.907841843178, 4691.132140553975, 4697.154512187805, 4702.929456058162, 4734.763261836894, 4928.482509336504, 4947.158982972904, 4952.158133117378, 4966.205407134841, 4995.300657907896, 5511.476409741068, 5519.227308176858, 5519.39286678465, 5522.6134170608075, 5525.557955363602, 5419.566434685215, 5485.259489968883, 5579.46995035471, 5583.832485025456, 5633.436656334375, 5148.922766158511, 5157.174852023696, 5211.140161873286, 5230.267762513251, 5232.9738351308, 5644.350899646511, 5664.575156863251, 5667.858303542444, 5712.6001179917, 5714.942850571441, 5451.100568406168, 5455.754491047913, 5456.154296084113, 5456.372517160498, 5458.699771512605, 5439.755211015435, 5453.536449401845, 5467.234587157801, 5505.697186654773, 5560.555155587544, 5466.070767969455, 5483.835484935458, 5490.423505531941, 5493.423190564933, 5517.0, 5494.148406996922, 5517.44825517445, 5520.66875987442, 5525.11598144303, 5572.024895643246, 4266.445362102907, 4299.054208074219, 4316.870493885189, 4319.97840010798, 4362.738235705868, 3844.442555829389, 3857.1707082977296, 3862.0537968197973, 3862.3240932836643, 3897.162110146332, 5051.621128415383, 5138.665986710852, 5150.4334523202415, 5152.0, 5201.323827902348, 5432.103702889058, 5438.401775804658, 5490.670559766427, 5552.500274975191, 5568.220449137124, 5133.153029750049, 5163.509466600667, 5173.224016397495, 5174.068667639861, 5178.067947769362, 4732.52674732524, 4737.0525894820485, 4743.146233677902, 4771.308160316735, 4794.712317260975, 5615.663060216319, 5655.4344565543115, 5665.348484924204, 5723.59934804568, 5757.6545407276535, 5560.749766260609, 5570.969370666439, 5575.693336866511, 5576.442355764391, 5578.163275508706, 5729.656220626775, 5752.022156233366, 5756.510696590837, 5759.280089988752, 5760.971195143998, 5374.3013408256675, 5442.537384322219, 5477.233187353694, 5517.475839795213, 5558.805441809517, 5531.585131115263, 5542.196381524737, 5564.693941833238, 5577.9442205577425, 5579.023670857502, 5368.489993450616, 5435.402105768441, 5446.400895901527, 5450.236966824568, 5491.313585801775, 5325.387580428145, 5345.572354211731, 5369.624126311121, 5371.301730774974, 5402.51377376038, 5303.04545181871, 5328.067588172132, 5331.973340133274, 5344.893102137858, 5380.704061276668, 5222.321098257202, 5306.28365170697, 5410.945890541044, 5415.268938693226, 5429.104197807317, 5270.8155214567305, 5302.231176479466, 5355.036093503207, 5355.3305836770405, 5373.140297552372], "unit": "score", "name": "dojo.html", "value": 5100.007268916286}, {"lowerIsBetter": false, "replicates": [524.9790008399663, 534.190701087852, 536.1796451429312, 552.1634723394058, 560.6383882395852, 28599.0, 29241.0, 29280.560791588145, 29322.560161597565, 29326.56010159844, 29238.415231695355, 36310.27379452416, 36892.81553592235, 37009.62990370095, 37058.62941370586, 8331.500109993405, 8385.371097167706, 8458.619362128718, 8477.965288330786, 8482.151784821499, 8230.176982301782, 8356.331493480508, 8362.58187090646, 8373.790655233606, 8380.329573634124, 8304.792380190513, 8389.07720150783, 8396.45423047503, 8396.538190399526, 8590.140985901422, 8496.447730897502, 8564.785880352978, 8577.142285771373, 8577.142285771373, 8579.485230886166, 8379.287760540361, 8467.95766021166, 8492.490450572923, 8508.532030738306, 8510.872336914952, 40007.19985600301, 40066.19867602661, 40291.0, 40381.0, 40382.78851634455, 3068.5704001439817, 3123.5470856725874, 3137.7176054155007, 3184.2357834119643, 3289.523019162208, 30223.395532089457, 30315.0, 30524.236894077603, 30908.69091309103, 31727.365452690818, 3926.932492838947, 4050.4936882889638, 4070.0638853063665, 4074.653654439376, 4097.795110244476, 280604.0, 283932.0, 284036.0, 284301.0, 284656.0, 53138.0, 53836.0, 61793.38206617966, 62040.379596203464, 62123.37876621266, 66965.3303466959, 68090.65954670195, 68095.65952170307, 68116.0, 68166.65916670384, 13809.861901380858, 14030.0, 14119.364628591738, 14149.575512734635, 14165.645858853404, 10400.27198096126, 10437.269391142547, 10453.425061621532, 10455.059044685862, 10457.111145552713, 18261.26954921815, 18620.44138675842, 20338.491537711674, 20431.182752690023, 21244.468888277606, 7834.412419068479, 8117.715879944174, 8136.796580085545, 8179.79550511242, 8198.303144232807, 924.4222361024359, 941.5010044676333, 987.9604815807287, 1000.009990109786, 1064.2337516987757, 28909.56635650467, 29825.850870745508, 31793.364132717215, 33949.151271217925, 34312.828435857664, 1042.61944390297, 1047.8375851742992, 1057.006413970865, 1122.6183097746805, 1147.5180424221846, 15029.549113526611, 15133.924330378277, 15665.45170919035, 15682.843171568367, 16386.590335241715, 412897.0, 418815.0, 420006.0, 420371.0, 421287.0, 56190.0, 56408.71795641078, 56907.43092569021, 57188.14217786737, 57266.42733572694, 1303.7197002644286, 1307.5292894557952, 1326.5688651188595, 1328.5881376773038, 1328.9601311960657, 30171.69828301689, 30775.846120769253, 30827.383452330378, 31139.221519462193, 31280.0, 47151.0, 47619.523804761506, 47752.7612361936, 47795.0, 47847.76076119597, 313270.0, 313343.0, 313469.0, 315270.0, 315832.0, 28697.139085827457, 32576.51135232926, 33034.66965330316, 33318.50022249717, 33525.66474335225, 32763.34473310473, 46899.53100468952, 47355.76322118505, 47627.76186119047, 47684.5231547694, 34609.65390346065, 35588.0, 36336.0, 36636.26727465382, 37016.62983370132, 35849.82075089608, 36084.27831443304, 38887.0, 39689.2062158761, 40545.59454405536, 33301.0, 33859.32281354408, 41532.169356612096, 41902.0, 42592.0, 30138.0, 33864.49203261904, 34420.82789586036, 34450.31099377948, 34708.65291347155, 25900.22299331023, 25904.22287331383, 26016.34959126037, 26088.608670870333, 26500.602490962265], "unit": "score", "name": "ext.html", "value": 18607.80420041281}, {"lowerIsBetter": false, "replicates": [365.641671162261, 367.9411294192929, 368.58165981610864, 371.0427098086936, 372.11436780462503, 13690.863091369083, 13753.724925501483, 15566.844331556682, 16991.490255292345, 17915.820841791578, 15292.464763733271, 15466.0, 15560.221988900537, 15567.143807090606, 16349.83650163498, 5229.8954020919555, 5411.377691565462, 5414.10667239905, 5416.783328666848, 5417.7291135443265, 4004.079061815784, 4140.503139623234, 5161.251618515313, 5625.1843482694985, 5883.764649414018, 5622.409646987069, 5785.595008349417, 5799.217105690741, 5844.123381492789, 5848.2689663792025, 5768.97115514424, 5794.565407594448, 5804.738786754564, 5805.477507024367, 5816.418358164171, 4918.0, 5102.719350435725, 5116.6674166179455, 5117.437081920985, 5161.4322424533275, 12567.308798016105, 13828.37772300249, 19420.0, 20334.694979575317, 20347.898260508602, 2085.4600411315637, 2095.559932414195, 2136.7649558548546, 2180.858244214121, 2233.8324625652976, 8855.158759917862, 9071.682491112779, 9222.538873056388, 9254.814903701888, 9348.906510934872, 1766.8939863608225, 1816.7910690270523, 1822.8723989320754, 1842.1249906294536, 1849.7687789026372, 49820.50179498231, 55371.44628553744, 55948.88102237973, 56278.0, 56454.43545564574, 9353.204977576983, 9500.857487137699, 9728.124468797841, 9734.221262299141, 9756.658516951873, 12282.0, 12302.323372214614, 12304.323262220485, 12377.071719621064, 12469.75060498785, 6948.33990770876, 7041.823954401181, 7043.471739619549, 7087.574745515286, 7095.361417472349, 6839.726410943506, 6881.724731010703, 6914.343137401939, 6927.653617319214, 6937.583744975318, 3935.822887969991, 4024.5170579530645, 4092.897677558085, 4121.876343709693, 4211.515675697273, 1639.4917575551378, 1681.28545368218, 1754.7455618935182, 1772.6277481728723, 1786.857051435882, 438.6227844054111, 443.44347843456256, 453.18426831702806, 828.4904783558069, 848.2154007542998, 10366.274360794672, 10696.78606427867, 10768.676939691823, 10793.460326983619, 10877.83683244752, 457.94733605635776, 475.53397670282624, 876.3558784293539, 884.7213127864702, 974.9860145448796, 7109.395701365442, 9130.81738365229, 9205.171534561921, 9432.575534100844, 9991.500424978722, 332989.0, 553364.0, 558042.0, 570901.0, 572437.0, 57679.790026246716, 71562.0, 73536.0, 74379.0, 74906.25093748992, 1175.3065691242036, 1187.590281352932, 1218.244688293246, 1231.7844377233948, 1252.6743046807896, 12065.457054432396, 14701.264936753334, 15152.469663561722, 15266.465673701367, 15332.77000844966, 33446.0, 33836.66163338335, 34030.31939361149, 34327.65672343245, 34547.82726086354, 41065.58934410737, 41421.0, 41480.0, 42114.789426052674, 42376.57623423726, 7015.333543313581, 7229.421646268181, 7282.271772822675, 7313.524620899624, 7387.667554960147, 8236.794080148044, 10639.255252132585, 10882.020618144405, 10990.835137472784, 11220.0, 9089.727438158796, 9377.156055954996, 9680.0, 9779.706608801747, 9791.06984836468, 9181.403208791407, 9467.810643787223, 9531.714048578553, 9797.510124493889, 9881.456519891188, 9129.680461183827, 9557.61769529211, 9831.655892043744, 10017.499125043865, 10068.14420774213, 7553.244675532403, 7661.885071723817, 7683.769486915401, 7695.807604809701, 7705.383569314329, 8991.730248092568, 9950.303478756417, 10004.447087157923, 10082.29423940317, 10195.7451063724], "unit": "score", "name": "jquery.html", "value": 7763.952901383024}, {"lowerIsBetter": false, "replicates": [1349.1904857085744, 1476.0258229568483, 1485.7474229381007, 1628.885977981541, 1778.6264884374282, 7104.715811367546, 7569.394448444125, 7634.9236507634905, 7642.923570764291, 7682.654280557388, 7702.96148519258, 7824.530528168314, 7851.646675899584, 7851.92148078519, 7859.096203936549, 2085.2180432337873, 2133.797289257518, 2134.7438307403054, 2356.081128359941, 2384.9642255366184, 2123.140128248062, 2289.839711220215, 2341.274204996448, 2342.80086192673, 2343.3672908314743, 2227.209340684058, 2245.158065725353, 2250.4823890505195, 2278.4759505313787, 2279.791710393494, 2296.9770302297097, 2336.6962294901723, 2341.934419838969, 2346.671465994762, 2349.48311371498, 2311.653252012195, 2320.1299512682745, 2320.3155069254612, 2326.93019209424, 2333.381653861728, 7765.26230008154, 7786.532808031479, 7820.257075577811, 7828.334591559725, 7840.4511684182135, 4797.472278049412, 4839.612830973549, 4856.15017371962, 4861.197902346109, 4947.158982972904, 3121.266502371941, 3204.7275981541598, 3221.758368122377, 3241.286916878283, 3249.545063691085, 1045.8326667733127, 1054.1092776603757, 1069.171392171066, 1081.9126777588474, 1107.634480621393, 11011.83482247767, 11026.834597481044, 11076.723081923017, 11076.889231107667, 11109.611163609236, 4455.509893911667, 4556.202664533694, 4573.108243892409, 4576.199165146086, 4615.9076818463445, 9466.857997130048, 9469.47917864524, 9470.763230919145, 9480.24158067353, 9483.383580067411, 4917.090338287357, 4938.777755001033, 4939.753012349368, 4940.851774446773, 4944.1100601891285, 4421.668374871898, 4452.666050046259, 4478.104379124188, 4479.574440428154, 4490.887727806766, 3531.911702207465, 3604.5494313210847, 3829.9808500957315, 3893.591172926802, 3942.15243722601, 1174.4010554617207, 1208.5890797129018, 1209.7157168065673, 1250.2685928731612, 1291.9870801292054, 1086.8315411111291, 1297.3837427221995, 1326.9601911942657, 1342.2080972226433, 1342.3489607540334, 7209.0988626421695, 7312.561246325237, 7316.378107860892, 7318.926810731931, 7334.156571994289, 1113.6380676280241, 1114.9554017839357, 1124.128800179867, 1129.170060005895, 1139.168407062832, 5851.765929362778, 5985.16207730918, 5995.490383317467, 6002.879942401128, 6004.219451471281, 9133.45199288045, 9260.49067301305, 9397.90602093984, 9430.245580353556, 9490.952545237367, 9228.815423691623, 9232.723018309462, 9238.538073096319, 9248.16766491019, 9376.062393760569, 7275.454340924452, 7325.157606875171, 7388.74139405129, 7389.519681220596, 7464.85070298591, 7391.0, 7459.0, 7480.326770590673, 7505.211952744883, 7519.736809211651, 8116.594170291343, 8123.959380203061, 8351.039630442578, 8503.74488765338, 8509.446885952393, 8398.580070996548, 8503.489790612583, 8611.052784193858, 8618.267447267053, 8627.913720862962, 7058.964705176441, 7192.388646965067, 7198.280171982759, 7211.42308615299, 7214.242504536948, 7578.507397019176, 7609.239076092346, 7635.656395462106, 7652.1582625912215, 7655.349295309961, 6798.252192258748, 6980.476464265099, 7038.964805176146, 7064.576125432491, 7086.0, 6858.3141685831015, 6904.654767261516, 6940.063091482585, 6940.201876784033, 7036.366726994595, 7013.123359580052, 7013.368796808311, 7016.5790052597, 7019.7894063176145, 7037.542559733601, 6309.400606942333, 6438.4527315176865, 6445.0, 6469.870602587827, 6483.2544257411, 6498.155239818793, 6531.934680653133, 6624.271330153583, 6633.237177724431, 6641.966790166019], "unit": "score", "name": "mootools.html", "value": 4576.21010886655}, {"lowerIsBetter": false, "replicates": [331.42166918726815, 338.7967219668199, 341.84104391457964, 345.025303517563, 346.81445426696723, 5818.1272809078655, 5820.621659592123, 5827.737751801168, 5838.883222335551, 5858.7949421770245, 5577.442255774431, 5617.466340697627, 5732.254806875111, 5777.19119323295, 5778.884422311562, 4492.360288494709, 4504.8198072077075, 4517.570830771071, 4526.818927242906, 4530.116627257686, 4343.761093139876, 4506.143832671798, 4516.164509565724, 4524.841630542932, 4530.6602004849765, 4380.58384453478, 4413.470383553978, 4458.643308535309, 4465.933011004838, 4467.396901418316, 4465.776711164429, 4473.463184417858, 4484.753338566377, 4487.70829896059, 4501.5273396293405, 3961.7622942623534, 3963.920721585552, 3968.4245784361397, 3981.0445493081743, 3984.2828290907623, 5478.424765399655, 5552.472515111058, 5568.7215639217875, 5591.133374326986, 5595.132754423071, 5210.921836172461, 5223.6343455958095, 5225.947740522623, 5229.058769421503, 5233.476652334774, 6095.756169753205, 6148.354422785588, 6155.476784473325, 6155.538334624876, 6158.414950579688, 4333.306670932667, 4370.344448332744, 4382.8904277393, 4401.427814384142, 4407.338899165119, 6264.59280146789, 6438.195225596801, 6448.45188159007, 6457.773977910798, 6462.1276127723095, 4499.6400287976885, 4506.549345065533, 4507.729536227836, 4508.458984921765, 4512.503624601291, 4543.5002149763495, 4558.111168322212, 4561.977190114028, 4565.155446242389, 4577.313402989512, 5192.636515443958, 5200.24596433515, 5216.191490319006, 5219.243209734567, 5221.295125158131, 6096.9390306096375, 6212.88761820983, 6220.284667263322, 6247.843803904848, 6307.337729538424, 1612.8306527814411, 1619.2227730689335, 1620.198001989023, 1620.3032695940858, 1622.9837701622832, 1093.9835902461468, 1094.9671509854718, 1109.2789686703707, 1116.4808364110727, 1117.083991127284, 5895.263092113486, 5896.675682837399, 5898.764049437975, 5902.38025007368, 5903.35063143054, 6351.618902865843, 6358.936410635927, 6360.395762402564, 6363.745450182034, 6366.586171898812, 5689.231953686282, 5777.768889244383, 5802.709864506758, 5879.706014699248, 5881.470667639933, 3424.0412684448393, 3439.8968030959113, 3451.3960056989927, 3471.0628130405153, 3474.2183008822813, 6676.6995485202315, 6694.765683201064, 6709.261981182066, 6709.966450167718, 6715.294894036154, 6437.8239635663385, 6550.47596192313, 6584.572002819801, 6599.439047680905, 6607.108040414579, 6701.1623547056615, 6705.966470167618, 6710.16122984627, 6715.731370745116, 6717.865642687118, 6388.872222555616, 6406.391392817675, 6423.100765892872, 6436.935630643634, 6443.0, 6265.2980655348665, 6330.905036424365, 6364.427201551883, 6369.777057802955, 6377.234731832024, 6688.264290927897, 6701.296363881722, 6704.731810727516, 6704.865902682017, 6706.128203333536, 4637.744924029211, 4638.397008388888, 4642.18761716705, 4643.39802768058, 4646.372739680235, 6202.689865506616, 6441.484681225397, 6442.871142577029, 6458.288553533412, 6464.2889282177985, 6262.373762623702, 6302.432781049728, 6310.842228944313, 6312.305646378986, 6316.684165791784, 6231.127642130196, 6274.121622972879, 6278.591891527219, 6285.0, 6296.150019747275, 6070.150178974859, 6161.507079433724, 6167.352427995175, 6174.44430001302, 6181.505479561534, 6298.811035668938, 6303.36966303366, 6306.306306306395, 6306.684665766785, 6310.684465776784, 6136.570440069152, 6163.19878415803, 6164.753409863555, 6166.290876549075, 6169.136320915165], "unit": "score", "name": "prototype.html", "value": 4720.996285823218}, {"lowerIsBetter": false, "replicates": [664.1233571685377, 700.0269625220942, 747.9700811967522, 833.3541505333368, 867.1285358214997, 12900.612981610544, 13035.739285214313, 13117.081804273705, 13151.802722959163, 13187.802182967263, 12222.938885305583, 12240.693982650439, 12282.57011004615, 12291.938540307308, 12303.69240768979, 665.6372277108964, 797.60518543321, 818.5211651184035, 823.115151212446, 823.2714048067444, 666.669998350817, 797.8763291689768, 817.2767101115526, 820.5404973215019, 820.9261166495014, 851.8764779107025, 855.3627547477107, 859.3640705877636, 859.5057841741024, 861.3410740783306, 686.9347411995902, 697.7348607529157, 854.9102344253857, 855.5764896376303, 857.1128881607538, 616.3713012726994, 621.8445388652837, 623.0591806372411, 623.1711823275078, 624.4411251929544, 13016.284104374256, 13043.804342934769, 13120.147190432592, 13172.802407963889, 13206.801897971538, 12191.817122743167, 13267.800982985264, 13313.933430332787, 13411.195328280237, 13464.124831885896, 9930.2055835533, 10145.898541014569, 10209.38743675382, 10273.589056437733, 10283.742906427324, 3607.332643460968, 3642.8907132786057, 3667.651573100551, 3671.8714844980564, 3773.792441415721, 47258.81852953669, 47586.0, 47586.524134758554, 47666.523334766556, 47922.76038619784, 9597.28020398459, 9690.224782017422, 9962.452065136487, 10015.749606259902, 10681.626143084955, 18621.0, 18639.906800466182, 18655.626887462447, 18692.813071869106, 18694.439166825017, 6924.446044316443, 6932.757353492704, 7026.613536255555, 7180.964095179491, 7303.415726741848, 3956.050547868491, 3969.364901615728, 3974.423708562242, 3981.402789581586, 4048.3117869962175, 3049.0, 3065.816051036945, 3066.681327029354, 3073.523603841408, 3076.123304858105, 537.1915267522354, 547.0809040811475, 548.44333002003, 551.6414330685087, 553.7674176845735, 496.9403671559436, 520.1988937036996, 522.7837490638068, 639.3223183425583, 651.5894986158689, 8200.58997050157, 8574.399792014623, 8625.913740862636, 8641.697540586048, 8880.911190888137, 582.1791274303212, 676.5534747066912, 687.8968154776724, 704.2851505721696, 723.5658604837056, 3903.7072219583647, 3993.121513267077, 4110.876673699794, 4124.628783409447, 4195.244855925902, 47279.5272047282, 47955.0, 48905.0, 49115.75442122838, 49178.75410622924, 44458.33312500315, 44985.77507112444, 48594.0, 49354.259686104735, 49399.0, 43911.78044109759, 44035.11929761387, 44412.3338149928, 44959.55040449619, 45215.321770173476, 8262.586870656563, 8593.88279523658, 8821.823563528822, 9126.680566180152, 9264.39781414206, 33145.668543314256, 34122.0, 34292.142696431794, 34947.12632184216, 35003.47494787529, 41726.79136604298, 41939.161216776105, 42189.57810421979, 44888.0, 44976.77511612421, 11269.436528173723, 11290.15323850698, 11320.37737924422, 11363.886361136283, 11810.76378472443, 11237.213395062266, 11288.604898828502, 12144.414684416279, 12832.55086071983, 13082.28047457399, 11038.668839934815, 11819.290842549475, 11852.70368240801, 11914.702132446759, 12316.199447035913, 10312.587496500357, 11229.27009744364, 11426.628804543509, 11559.133065020325, 11582.884171158517, 11473.541058357907, 11853.229540079867, 11941.940290298493, 11950.34273114987, 12344.13591048618, 9056.954715226646, 9367.437953722798, 9402.529873506433, 9849.704508864745, 9988.101070903653, 8820.955895220482, 8830.033019663142, 9024.503652299187, 9046.954765226132, 9378.296627752808], "unit": "score", "name": "yui.html", "value": 6174.107266206485}], "name": "dromaeo_css", "value": 6793.341498702429}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 106.0, 111.0, 110.0, 110.0, 111.0, 111.0, 104.0, 112.0], "unit": "score", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 125.0, 158.0, 174.0, 135.0, 152.0, 150.0, 135.0, 174.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 147.6}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 158.0, 160.0, 164.0, 159.0, 161.0, 159.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [73.0, 82.0, 129.0, 100.0, 73.0, 73.0, 74.0, 125.0, 95.0, 74.0], "unit": "score", "name": "audio-fft", "value": 89.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 137.0, 95.0, 95.0, 96.0, 145.0, 94.0, 95.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 111.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 145.0, 145.0, 147.0, 145.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 96.0, 96.0, 95.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 56.0, 56.0, 57.0, 55.0, 55.0, 56.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.8}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 69.0, 69.0, 68.0, 67.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 82.0, 82.0, 89.0, 82.0, 90.0, 82.0, 82.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.5}, {"lowerIsBetter": true, "replicates": [115.0, 113.0, 116.0, 119.0, 120.0, 117.0, 115.0, 118.0, 120.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.9}, {"lowerIsBetter": true, "replicates": [135.0, 132.0, 140.0, 139.0, 140.0, 129.0, 145.0, 139.0, 144.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.5}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 65.0, 66.0, 67.0, 64.0, 66.0, 66.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.0}], "name": "kraken", "value": 1496.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.20857863751053], "unit": "score", "name": "Richards", "value": 209.87038999999996}, {"lowerIsBetter": false, "replicates": [189.60940462646948], "unit": "score", "name": "DeltaBlue", "value": 348.7063319999999}, {"lowerIsBetter": false, "replicates": [278.8622420524261], "unit": "score", "name": "Encrypt", "value": 954.525066}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [1119.8208286674133], "unit": "score", "name": "RayTrace", "value": 660.8101769999998}, {"lowerIsBetter": false, "replicates": [793.0214115781126], "unit": "score", "name": "Earley", "value": 840.4098429999997}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [42437.5], "unit": "score", "name": "RegExp", "value": 21.466509572901316}, {"lowerIsBetter": false, "replicates": [574.6268656716418], "unit": "score", "name": "Splay", "value": 141.81550649350643}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20040.698948934227}]} 02:27:14 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20040.70"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1496.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6793.34"}}} 02:27:14 INFO - Return code: 0 02:27:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:27:14 INFO - # TBPL SUCCESS # 02:27:14 INFO - Running post-action listener: _resource_record_post_action 02:27:14 INFO - Running post-run listener: _resource_record_post_run 02:27:15 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 32768; Write bytes: 547528704; Read time: 200; Write time: 572348 02:27:15 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 4096; Write bytes: 248561664; Read time: 84; Write time: 364988 02:27:15 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 28672; Write bytes: 298369024; Read time: 116; Write time: 207356 02:27:15 INFO - Running post-run listener: _upload_blobber_files 02:27:15 INFO - Blob upload gear active. 02:27:15 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 02:27:15 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:27:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 02:27:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 02:27:15 INFO - (blobuploader) - INFO - Open directory for files ... 02:27:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 02:27:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:27:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:16 INFO - (blobuploader) - INFO - Done attempting. 02:27:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:27:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:27:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:17 INFO - (blobuploader) - INFO - Done attempting. 02:27:17 INFO - (blobuploader) - INFO - Iteration through files over. 02:27:17 INFO - Return code: 0 02:27:17 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 02:27:17 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 02:27:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ffd36700b2254c1c83a800bb6b42d33e2a25bd9a96d963b17368323c0ec4e07a16315269801fc27b18cd8f2b69e122e927955a0b817c0f7fa4efd9c07a6c9b7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/b01d861a71e7b2f90056eb263a858f706d9d1c1065f6557744c28cc0188d355c550362ec25b0dbe8b93de54a37a315fc3a6c1b7943ae5625c446c0b20ebdaa1b"} 02:27:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 02:27:17 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 02:27:17 INFO - Contents: 02:27:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ffd36700b2254c1c83a800bb6b42d33e2a25bd9a96d963b17368323c0ec4e07a16315269801fc27b18cd8f2b69e122e927955a0b817c0f7fa4efd9c07a6c9b7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/b01d861a71e7b2f90056eb263a858f706d9d1c1065f6557744c28cc0188d355c550362ec25b0dbe8b93de54a37a315fc3a6c1b7943ae5625c446c0b20ebdaa1b"} 02:27:17 INFO - Running post-run listener: copy_logs_to_upload_dir 02:27:17 INFO - Copying logs to upload dir... 02:27:17 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 02:27:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.991009 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-21 02:27:17.260580) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 02:27:17.264715) ========= 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=cbe409c6de289db6ac707de3000001d4-1453369935.764859-141208108 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/ffd36700b2254c1c83a800bb6b42d33e2a25bd9a96d963b17368323c0ec4e07a16315269801fc27b18cd8f2b69e122e927955a0b817c0f7fa4efd9c07a6c9b7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/b01d861a71e7b2f90056eb263a858f706d9d1c1065f6557744c28cc0188d355c550362ec25b0dbe8b93de54a37a315fc3a6c1b7943ae5625c446c0b20ebdaa1b"} build_url:https://queue.taskcluster.net/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011500 build_url: 'https://queue.taskcluster.net/v1/task/XADB6CKMSKSoGCSAM5KmIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ffd36700b2254c1c83a800bb6b42d33e2a25bd9a96d963b17368323c0ec4e07a16315269801fc27b18cd8f2b69e122e927955a0b817c0f7fa4efd9c07a6c9b7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/b01d861a71e7b2f90056eb263a858f706d9d1c1065f6557744c28cc0188d355c550362ec25b0dbe8b93de54a37a315fc3a6c1b7943ae5625c446c0b20ebdaa1b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 02:27:17.290300) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 02:27:17.290629) ========= 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=cbe409c6de289db6ac707de3000001d4-1453369935.764859-141208108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004684 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 02:27:17.342635) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 02:27:17.343006) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 02:27:17.343338) ========= ========= Total master_lag: 0.32 =========