builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1456541053.48 results: success (0) buildid: 20160226163041 builduid: 084ed894a4844740ac33cf82506a9412 revision: 2d8118073de1024df419bb3879e7a7e0e2427aea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:13.477971) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:13.478394) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:13.478960) ========= 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=fa44defc139c4ba8574fe040000001db-1456534520.652117-185683663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009158 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:13.502933) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:13.503243) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:13.536700) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:13.537217) ========= 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=fa44defc139c4ba8574fe040000001db-1456534520.652117-185683663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004564 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:13.589470) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:13.589781) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:13.590184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:13.590497) ========= 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=fa44defc139c4ba8574fe040000001db-1456534520.652117-185683663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-26 18:44:13-- 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% 31.0M=0s 2016-02-26 18:44:14 (31.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150124 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:13.755296) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:13.755610) ========= 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=fa44defc139c4ba8574fe040000001db-1456534520.652117-185683663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018256 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:13.810781) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:13.811115) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 2d8118073de1024df419bb3879e7a7e0e2427aea --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/mozilla-inbound --rev 2d8118073de1024df419bb3879e7a7e0e2427aea --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=fa44defc139c4ba8574fe040000001db-1456534520.652117-185683663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-26 18:44:14,211 truncating revision to first 12 chars 2016-02-26 18:44:14,211 Setting DEBUG logging. 2016-02-26 18:44:14,211 attempt 1/10 2016-02-26 18:44:14,211 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/2d8118073de1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-26 18:44:14,482 unpacking tar archive at: mozilla-inbound-2d8118073de1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.586591 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:14.415689) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:14.416521) ========= echo 2d8118073de1024df419bb3879e7a7e0e2427aea in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'2d8118073de1024df419bb3879e7a7e0e2427aea'] 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=fa44defc139c4ba8574fe040000001db-1456534520.652117-185683663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2d8118073de1024df419bb3879e7a7e0e2427aea program finished with exit code 0 elapsedTime=0.004630 script_repo_revision: '2d8118073de1024df419bb3879e7a7e0e2427aea' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:14.472786) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:14.473430) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:14.484375) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 17 secs) (at 2016-02-26 18:44:14.485065) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-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=fa44defc139c4ba8574fe040000001db-1456534520.652117-185683663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:44:14 INFO - MultiFileLogger online at 20160226 18:44:14 in /builds/slave/test-pgo 18:44:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 18:44:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:44:14 INFO - {'append_to_log': False, 18:44:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:44:14 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:44:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:44:14 INFO - 'branch': 'Mozilla-Inbound', 18:44:14 INFO - 'buildbot_json_path': 'buildprops.json', 18:44:14 INFO - 'config_files': ('talos/linux_config.py',), 18:44:14 INFO - 'default_actions': ('clobber', 18:44:14 INFO - 'read-buildbot-config', 18:44:14 INFO - 'download-and-extract', 18:44:14 INFO - 'populate-webroot', 18:44:14 INFO - 'create-virtualenv', 18:44:14 INFO - 'install', 18:44:14 INFO - 'run-tests'), 18:44:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:44:14 INFO - 'download_minidump_stackwalk': True, 18:44:14 INFO - 'download_symbols': 'ondemand', 18:44:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:44:14 INFO - 'tooltool.py': '/tools/tooltool.py', 18:44:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:44:14 INFO - '/tools/misc-python/virtualenv.py')}, 18:44:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:44:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:44:14 INFO - 'installer_path': 'installer.exe', 18:44:14 INFO - 'log_level': 'info', 18:44:14 INFO - 'log_name': 'talos', 18:44:14 INFO - 'log_to_console': True, 18:44:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:44:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:44:14 INFO - 'opt_config_files': (), 18:44:14 INFO - 'pip_index': False, 18:44:14 INFO - 'sps_profile': False, 18:44:14 INFO - 'sps_profile_interval': 0, 18:44:14 INFO - 'suite': 'dromaeojs-e10s', 18:44:14 INFO - 'system_bits': '32', 18:44:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:44:14 INFO - 'title': 'talos-linux64-ix-048', 18:44:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:44:14 INFO - 'use_talos_json': True, 18:44:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:44:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:44:14 INFO - 'work_dir': 'build'} 18:44:14 INFO - ##### 18:44:14 INFO - ##### Running clobber step. 18:44:14 INFO - ##### 18:44:14 INFO - Running pre-action listener: _resource_record_pre_action 18:44:14 INFO - Running main action method: clobber 18:44:14 INFO - rmtree: /builds/slave/test-pgo/build 18:44:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:44:15 INFO - Running post-action listener: _resource_record_post_action 18:44:15 INFO - ##### 18:44:15 INFO - ##### Running read-buildbot-config step. 18:44:15 INFO - ##### 18:44:15 INFO - Running pre-action listener: _resource_record_pre_action 18:44:15 INFO - Running main action method: read_buildbot_config 18:44:15 INFO - Using buildbot properties: 18:44:15 INFO - { 18:44:15 INFO - "project": "", 18:44:15 INFO - "product": "firefox", 18:44:15 INFO - "script_repo_revision": "production", 18:44:15 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 18:44:15 INFO - "repository": "", 18:44:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 18:44:15 INFO - "buildid": "20160226163041", 18:44:15 INFO - "pgo_build": "True", 18:44:15 INFO - "basedir": "/builds/slave/test-pgo", 18:44:15 INFO - "buildnumber": 717, 18:44:15 INFO - "slavename": "talos-linux64-ix-048", 18:44:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:44:15 INFO - "platform": "ubuntu64_hw", 18:44:15 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 18:44:15 INFO - "branch": "mozilla-inbound", 18:44:15 INFO - "repo_path": "integration/mozilla-inbound", 18:44:15 INFO - "revision": "2d8118073de1024df419bb3879e7a7e0e2427aea", 18:44:15 INFO - "stage_platform": "linux64-pgo", 18:44:15 INFO - "builduid": "084ed894a4844740ac33cf82506a9412", 18:44:15 INFO - "slavebuilddir": "test" 18:44:15 INFO - } 18:44:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 18:44:15 INFO - Running post-action listener: _resource_record_post_action 18:44:15 INFO - ##### 18:44:15 INFO - ##### Running download-and-extract step. 18:44:15 INFO - ##### 18:44:15 INFO - Running pre-action listener: _resource_record_pre_action 18:44:15 INFO - Running main action method: download_and_extract 18:44:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:44:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:15 INFO - https://queue.taskcluster.net/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:44:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/test_packages.json 18:44:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/test_packages.json 18:44:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:44:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:44:17 INFO - Downloaded 1448 bytes. 18:44:17 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:44:17 INFO - Using the following test package requirements: 18:44:17 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 18:44:17 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:44:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:44:17 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:44:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:44:17 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:44:17 INFO - u'jsshell-linux-x86_64.zip'], 18:44:17 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:44:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:44:17 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 18:44:17 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:44:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:44:17 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:44:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:44:17 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:44:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:44:17 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 18:44:17 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:44:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:44:17 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:44: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')]} 18:44:17 INFO - https://queue.taskcluster.net/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:44:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 18:44:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 18:44:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 18:44:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:44:18 INFO - Downloaded 23370843 bytes. 18:44:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:44:18 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:44:19 INFO - Return code: 0 18:44:19 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:44: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')]} 18:44:19 INFO - https://queue.taskcluster.net/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:44:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 18:44:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 18:44:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 18:44:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:44:21 INFO - Downloaded 23370843 bytes. 18:44:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:44:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:44:22 INFO - Return code: 0 18:44:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:22 INFO - https://queue.taskcluster.net/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:44:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 18:44:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 18:44:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 18:44:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:44:23 INFO - Downloaded 10713410 bytes. 18:44:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:44:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 18:44:23 INFO - Return code: 0 18:44: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')]} 18:44:23 INFO - https://queue.taskcluster.net/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:44:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 18:44:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 18:44:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 18:44:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:44:25 INFO - Downloaded 56628352 bytes. 18:44:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 18:44:25 INFO - mkdir: /builds/slave/test-pgo/properties 18:44:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:44:25 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:44:25 INFO - Contents: 18:44:25 INFO - build_url:https://queue.taskcluster.net/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 18:44:25 INFO - Running post-action listener: _resource_record_post_action 18:44:25 INFO - Running post-action listener: set_extra_try_arguments 18:44:25 INFO - ##### 18:44:25 INFO - ##### Running populate-webroot step. 18:44:25 INFO - ##### 18:44:25 INFO - Running pre-action listener: _resource_record_pre_action 18:44:25 INFO - Running main action method: populate_webroot 18:44:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:44:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:44:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:44:25 INFO - '--tppagecycles', 18:44:25 INFO - '7'], 18:44:25 INFO - 'tests': ['tsvgm']}}, 18:44:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:44:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:44:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:44:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:44:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:44:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:44:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:44:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:25 INFO - 'talos_options': ['--e10s'], 18:44:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:44:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:25 INFO - 'tests': ['damp', 'tps']}, 18:44:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:25 INFO - 'talos_options': ['--e10s'], 18:44:25 INFO - 'tests': ['damp', 'tps']}, 18:44:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:44:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:44:25 INFO - 'other': {'tests': ['a11yr', 18:44:25 INFO - 'ts_paint', 18:44:25 INFO - 'tpaint', 18:44:25 INFO - 'sessionrestore', 18:44:25 INFO - 'sessionrestore_no_auto_restore']}, 18:44:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:44:25 INFO - 'tests': ['a11yr', 18:44:25 INFO - 'ts_paint', 18:44:25 INFO - 'tpaint', 18:44:25 INFO - 'sessionrestore', 18:44:25 INFO - 'sessionrestore_no_auto_restore']}, 18:44:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:44:25 INFO - 'tests': ['a11yr', 18:44:25 INFO - 'ts_paint', 18:44:25 INFO - 'tpaint', 18:44:25 INFO - 'sessionrestore', 18:44:25 INFO - 'sessionrestore_no_auto_restore']}, 18:44:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:44:25 INFO - 'tests': ['a11yr', 18:44:25 INFO - 'ts_paint', 18:44:25 INFO - 'tpaint', 18:44:25 INFO - 'sessionrestore', 18:44:25 INFO - 'sessionrestore_no_auto_restore']}, 18:44:25 INFO - 'other_l64': {'tests': ['a11yr', 18:44:25 INFO - 'ts_paint', 18:44:25 INFO - 'tpaint', 18:44:25 INFO - 'sessionrestore', 18:44:25 INFO - 'sessionrestore_no_auto_restore']}, 18:44:25 INFO - 'other_nol64': {'tests': ['a11yr', 18:44:25 INFO - 'ts_paint', 18:44:25 INFO - 'tpaint', 18:44:25 INFO - 'sessionrestore', 18:44:25 INFO - 'sessionrestore_no_auto_restore']}, 18:44:25 INFO - 'svgr': {'tests': ['tsvgx', 18:44:25 INFO - 'tsvgr_opacity', 18:44:25 INFO - 'tart', 18:44:25 INFO - 'tscrollx', 18:44:25 INFO - 'cart']}, 18:44:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:44:25 INFO - 'tests': ['tsvgx', 18:44:25 INFO - 'tsvgr_opacity', 18:44:25 INFO - 'tart', 18:44:25 INFO - 'tscrollx', 18:44:25 INFO - 'cart']}, 18:44:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:25 INFO - 'tests': ['tp5o']}, 18:44:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:25 INFO - 'talos_options': ['--e10s'], 18:44:25 INFO - 'tests': ['tp5o']}, 18:44:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:25 INFO - 'talos_options': ['--xperf_path', 18:44:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:44:25 INFO - 'tests': ['tp5n']}, 18:44:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:25 INFO - 'talos_options': ['--e10s', 18:44:25 INFO - '--xperf_path', 18:44:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:44:25 INFO - 'tests': ['tp5n']}}, 18:44:25 INFO - 'talos.zip': {'path': '', 18:44:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:44:25 INFO - Running post-action listener: _resource_record_post_action 18:44:25 INFO - ##### 18:44:25 INFO - ##### Running create-virtualenv step. 18:44:25 INFO - ##### 18:44:25 INFO - Running pre-action listener: _resource_record_pre_action 18:44:25 INFO - Running main action method: create_virtualenv 18:44:25 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:44:25 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 18:44:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:44:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:44:26 INFO - Using real prefix '/usr' 18:44:26 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:44:26 INFO - Installing distribute.............................................................................................................................................................................................done. 18:44:28 INFO - Installing pip.................done. 18:44:28 INFO - Return code: 0 18:44:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:44: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')]} 18:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44: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')]} 18:44:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7b2478ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1897670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19268c0>, '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 0x19277c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1927c50>, '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': 'fa44defc139c4ba8574fe040000001db-1456534520.652117-185683663', '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 18:44: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 18:44: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 pip>=1.5 18:44:28 INFO - Using env: {'DISPLAY': ':0', 18:44:28 INFO - 'HOME': '/home/cltbld', 18:44:28 INFO - 'LANG': 'en_US.UTF-8', 18:44:28 INFO - 'LANGUAGE': 'en_US:en', 18:44:28 INFO - 'LOGNAME': 'cltbld', 18:44:28 INFO - 'MAIL': '/var/mail/cltbld', 18:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:28 INFO - 'MOZ_NO_REMOTE': '1', 18:44:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:28 INFO - 'NO_EM_RESTART': '1', 18:44:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:44:28 INFO - 'PWD': '/builds/slave/test-pgo', 18:44:28 INFO - 'SHELL': '/bin/bash', 18:44:28 INFO - 'SHLVL': '1', 18:44:28 INFO - 'TERM': 'linux', 18:44:28 INFO - 'TMOUT': '86400', 18:44:28 INFO - 'USER': 'cltbld', 18:44:28 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1456534520.652117-185683663', 18:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:28 INFO - '_': '/tools/buildbot/bin/python'} 18:44:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:28 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 18:44:28 INFO - Cleaning up... 18:44:28 INFO - Return code: 0 18:44:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:44: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')]} 18:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44: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')]} 18:44:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44: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', '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 0x7f7b2478ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1897670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19268c0>, '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 0x19277c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1927c50>, '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': 'fa44defc139c4ba8574fe040000001db-1456534520.652117-185683663', '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 18:44: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 18:44: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 psutil>=0.7.1 18:44:28 INFO - Using env: {'DISPLAY': ':0', 18:44:28 INFO - 'HOME': '/home/cltbld', 18:44:28 INFO - 'LANG': 'en_US.UTF-8', 18:44:28 INFO - 'LANGUAGE': 'en_US:en', 18:44:28 INFO - 'LOGNAME': 'cltbld', 18:44:28 INFO - 'MAIL': '/var/mail/cltbld', 18:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:28 INFO - 'MOZ_NO_REMOTE': '1', 18:44:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:28 INFO - 'NO_EM_RESTART': '1', 18:44:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:44:28 INFO - 'PWD': '/builds/slave/test-pgo', 18:44:28 INFO - 'SHELL': '/bin/bash', 18:44:28 INFO - 'SHLVL': '1', 18:44:28 INFO - 'TERM': 'linux', 18:44:28 INFO - 'TMOUT': '86400', 18:44:28 INFO - 'USER': 'cltbld', 18:44:28 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1456534520.652117-185683663', 18:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:28 INFO - '_': '/tools/buildbot/bin/python'} 18:44:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:28 INFO - Downloading/unpacking psutil>=0.7.1 18:44: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 18:44: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 18:44: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 18:44: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 18:44: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 18:44: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 18:44:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:44:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:44:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:44:30 INFO - Installing collected packages: psutil 18:44:30 INFO - Running setup.py install for psutil 18:44:30 INFO - building 'psutil._psutil_linux' extension 18:44:30 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 18:44:31 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 18:44:31 INFO - building 'psutil._psutil_posix' extension 18:44:31 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 18:44:31 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 18:44:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:44:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:44:31 INFO - Successfully installed psutil 18:44:31 INFO - Cleaning up... 18:44:31 INFO - Return code: 0 18:44:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:44:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:31 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 0x7f7b2478ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1897670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19268c0>, '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 0x19277c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1927c50>, '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': 'fa44defc139c4ba8574fe040000001db-1456534520.652117-185683663', '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 18:44:31 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 18:44:31 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 18:44:31 INFO - Using env: {'DISPLAY': ':0', 18:44:31 INFO - 'HOME': '/home/cltbld', 18:44:31 INFO - 'LANG': 'en_US.UTF-8', 18:44:31 INFO - 'LANGUAGE': 'en_US:en', 18:44:31 INFO - 'LOGNAME': 'cltbld', 18:44:31 INFO - 'MAIL': '/var/mail/cltbld', 18:44:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:31 INFO - 'MOZ_NO_REMOTE': '1', 18:44:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:31 INFO - 'NO_EM_RESTART': '1', 18:44:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:44:31 INFO - 'PWD': '/builds/slave/test-pgo', 18:44:31 INFO - 'SHELL': '/bin/bash', 18:44:31 INFO - 'SHLVL': '1', 18:44:31 INFO - 'TERM': 'linux', 18:44:31 INFO - 'TMOUT': '86400', 18:44:31 INFO - 'USER': 'cltbld', 18:44:31 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1456534520.652117-185683663', 18:44:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:31 INFO - '_': '/tools/buildbot/bin/python'} 18:44:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:44: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 18:44: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 18:44: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 18:44: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 18:44: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 18:44: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 18:44:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:44:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:44:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:44:33 INFO - Installing collected packages: mozsystemmonitor 18:44:33 INFO - Running setup.py install for mozsystemmonitor 18:44:33 INFO - Successfully installed mozsystemmonitor 18:44:33 INFO - Cleaning up... 18:44:33 INFO - Return code: 0 18:44:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:33 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 0x7f7b2478ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1897670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19268c0>, '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 0x19277c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1927c50>, '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': 'fa44defc139c4ba8574fe040000001db-1456534520.652117-185683663', '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 18:44:33 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 18:44:33 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 18:44:33 INFO - Using env: {'DISPLAY': ':0', 18:44:33 INFO - 'HOME': '/home/cltbld', 18:44:33 INFO - 'LANG': 'en_US.UTF-8', 18:44:33 INFO - 'LANGUAGE': 'en_US:en', 18:44:33 INFO - 'LOGNAME': 'cltbld', 18:44:33 INFO - 'MAIL': '/var/mail/cltbld', 18:44:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:33 INFO - 'MOZ_NO_REMOTE': '1', 18:44:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:33 INFO - 'NO_EM_RESTART': '1', 18:44:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:44:33 INFO - 'PWD': '/builds/slave/test-pgo', 18:44:33 INFO - 'SHELL': '/bin/bash', 18:44:33 INFO - 'SHLVL': '1', 18:44:33 INFO - 'TERM': 'linux', 18:44:33 INFO - 'TMOUT': '86400', 18:44:33 INFO - 'USER': 'cltbld', 18:44:33 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1456534520.652117-185683663', 18:44:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:33 INFO - '_': '/tools/buildbot/bin/python'} 18:44:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:33 INFO - Downloading/unpacking blobuploader==1.2.4 18:44:33 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 18:44:33 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 18:44:33 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 18:44:33 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 18:44:33 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 18:44:33 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 18:44:35 INFO - Downloading blobuploader-1.2.4.tar.gz 18:44:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:44:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:44:35 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 18:44:35 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 18:44:35 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 18:44:35 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 18:44:35 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 18:44:35 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 18:44:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:44:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:44: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 18:44: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 18:44: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 18:44: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 18:44: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 18:44: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 18:44:36 INFO - Downloading docopt-0.6.1.tar.gz 18:44:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:44:36 INFO - Installing collected packages: blobuploader, requests, docopt 18:44:36 INFO - Running setup.py install for blobuploader 18:44:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:44:36 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:44:36 INFO - Running setup.py install for requests 18:44:36 INFO - Running setup.py install for docopt 18:44:36 INFO - Successfully installed blobuploader requests docopt 18:44:36 INFO - Cleaning up... 18:44:37 INFO - Return code: 0 18:44:37 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:44:37 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')]} 18:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:37 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')]} 18:44:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:37 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 0x7f7b2478ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1897670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19268c0>, '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 0x19277c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1927c50>, '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': 'fa44defc139c4ba8574fe040000001db-1456534520.652117-185683663', '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 18:44:37 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 18:44:37 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 18:44:37 INFO - Using env: {'DISPLAY': ':0', 18:44:37 INFO - 'HOME': '/home/cltbld', 18:44:37 INFO - 'LANG': 'en_US.UTF-8', 18:44:37 INFO - 'LANGUAGE': 'en_US:en', 18:44:37 INFO - 'LOGNAME': 'cltbld', 18:44:37 INFO - 'MAIL': '/var/mail/cltbld', 18:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:37 INFO - 'MOZ_NO_REMOTE': '1', 18:44:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:37 INFO - 'NO_EM_RESTART': '1', 18:44:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:44:37 INFO - 'PWD': '/builds/slave/test-pgo', 18:44:37 INFO - 'SHELL': '/bin/bash', 18:44:37 INFO - 'SHLVL': '1', 18:44:37 INFO - 'TERM': 'linux', 18:44:37 INFO - 'TMOUT': '86400', 18:44:37 INFO - 'USER': 'cltbld', 18:44:37 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1456534520.652117-185683663', 18:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:37 INFO - '_': '/tools/buildbot/bin/python'} 18:44:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:44:37 INFO - Running setup.py (path:/tmp/pip-S_MFZK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:44:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:44:37 INFO - Running setup.py (path:/tmp/pip-MU1e_W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:44:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:44:37 INFO - Running setup.py (path:/tmp/pip-ydYCjP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:44:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:44:37 INFO - Running setup.py (path:/tmp/pip-D3KWOA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:44:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:44:37 INFO - Running setup.py (path:/tmp/pip-6U25WD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:44:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:44:37 INFO - Running setup.py (path:/tmp/pip-6l4Lqu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:44:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:44:37 INFO - Running setup.py (path:/tmp/pip-8pmp7R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:44:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:44:37 INFO - Running setup.py (path:/tmp/pip-IqlCuq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:44:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:44:37 INFO - Running setup.py (path:/tmp/pip-w5bCVd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:44:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:44:37 INFO - Running setup.py (path:/tmp/pip-f7n0nJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:44:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:44:37 INFO - Running setup.py (path:/tmp/pip-4MxH3H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:44:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:44:38 INFO - Running setup.py (path:/tmp/pip-0klxgB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:44:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:44:38 INFO - Running setup.py (path:/tmp/pip-8pfBVz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:44:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:44:38 INFO - Running setup.py (path:/tmp/pip-ncpQy1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:44:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:44:38 INFO - Running setup.py (path:/tmp/pip-guHGWK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:44:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:44:38 INFO - Running setup.py (path:/tmp/pip-VAVwQ_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:44:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:44:38 INFO - Running setup.py (path:/tmp/pip-LgmoSd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:44:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:44:38 INFO - Running setup.py install for manifestparser 18:44:38 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:44:38 INFO - Running setup.py install for mozcrash 18:44:38 INFO - Running setup.py install for mozdebug 18:44:38 INFO - Running setup.py install for mozdevice 18:44:38 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:44:38 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:44:38 INFO - Running setup.py install for mozfile 18:44:38 INFO - Running setup.py install for mozhttpd 18:44:39 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:44:39 INFO - Running setup.py install for mozinfo 18:44:39 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:44:39 INFO - Running setup.py install for mozInstall 18:44:39 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:44:39 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:44:39 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:44:39 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:44:39 INFO - Running setup.py install for mozleak 18:44:39 INFO - Running setup.py install for mozlog 18:44:39 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:44:39 INFO - Running setup.py install for moznetwork 18:44:39 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:44:39 INFO - Running setup.py install for mozprocess 18:44:39 INFO - Running setup.py install for mozprofile 18:44:39 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:44:39 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:44:39 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:44:39 INFO - Running setup.py install for mozrunner 18:44:39 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:44:39 INFO - Running setup.py install for mozscreenshot 18:44:40 INFO - Running setup.py install for moztest 18:44:40 INFO - Running setup.py install for mozversion 18:44:40 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:44:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:44:40 INFO - Cleaning up... 18:44:40 INFO - Return code: 0 18:44:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:40 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 0x7f7b2478ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1897670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19268c0>, '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 0x19277c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1927c50>, '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': 'fa44defc139c4ba8574fe040000001db-1456534520.652117-185683663', '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 18:44:40 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 18:44:40 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 18:44:40 INFO - Using env: {'DISPLAY': ':0', 18:44:40 INFO - 'HOME': '/home/cltbld', 18:44:40 INFO - 'LANG': 'en_US.UTF-8', 18:44:40 INFO - 'LANGUAGE': 'en_US:en', 18:44:40 INFO - 'LOGNAME': 'cltbld', 18:44:40 INFO - 'MAIL': '/var/mail/cltbld', 18:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:40 INFO - 'MOZ_NO_REMOTE': '1', 18:44:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:40 INFO - 'NO_EM_RESTART': '1', 18:44:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:44:40 INFO - 'PWD': '/builds/slave/test-pgo', 18:44:40 INFO - 'SHELL': '/bin/bash', 18:44:40 INFO - 'SHLVL': '1', 18:44:40 INFO - 'TERM': 'linux', 18:44:40 INFO - 'TMOUT': '86400', 18:44:40 INFO - 'USER': 'cltbld', 18:44:40 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1456534520.652117-185683663', 18:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:40 INFO - '_': '/tools/buildbot/bin/python'} 18:44:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:44:40 INFO - Running setup.py (path:/tmp/pip-WYcESZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:44:40 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)) 18:44:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:44:40 INFO - Running setup.py (path:/tmp/pip-qusJb0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:44:40 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)) 18:44:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:44:40 INFO - Running setup.py (path:/tmp/pip-uMFhiQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:44:40 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)) 18:44:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:44:40 INFO - Running setup.py (path:/tmp/pip-Axelks-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:44:40 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)) 18:44:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:44:40 INFO - Running setup.py (path:/tmp/pip-n_Jgzk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:44:40 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)) 18:44:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:44:40 INFO - Running setup.py (path:/tmp/pip-ztZlpH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:44:40 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)) 18:44:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:44:40 INFO - Running setup.py (path:/tmp/pip-vQlDba-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:44:40 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)) 18:44:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:44:40 INFO - Running setup.py (path:/tmp/pip-j6LOzp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:44:41 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)) 18:44:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:44:41 INFO - Running setup.py (path:/tmp/pip-2i3xTn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:44:41 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)) 18:44:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:44:41 INFO - Running setup.py (path:/tmp/pip-oRTtmI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:44:41 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)) 18:44:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:44:41 INFO - Running setup.py (path:/tmp/pip-NoXo5N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:44:41 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)) 18:44:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:44:41 INFO - Running setup.py (path:/tmp/pip-f_rhj6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:44:41 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)) 18:44:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:44:41 INFO - Running setup.py (path:/tmp/pip-kZhJN4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:44:41 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)) 18:44:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:44:41 INFO - Running setup.py (path:/tmp/pip-SFf_o_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:44:41 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)) 18:44:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:44:41 INFO - Running setup.py (path:/tmp/pip-KVujtE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:44:41 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)) 18:44:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:44:41 INFO - Running setup.py (path:/tmp/pip-3Hqmy5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:44:41 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)) 18:44:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:44:41 INFO - Running setup.py (path:/tmp/pip-msTrSQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:44:41 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)) 18:44:41 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)) 18:44:41 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)) 18:44:41 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)) 18:44:41 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)) 18:44:41 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)) 18:44:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:44: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 18:44: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 18:44: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 18:44: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 18:44: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 18:44: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 18:44:43 INFO - Downloading blessings-1.6.tar.gz 18:44:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:44:43 INFO - Installing collected packages: blessings 18:44:43 INFO - Running setup.py install for blessings 18:44:43 INFO - Successfully installed blessings 18:44:43 INFO - Cleaning up... 18:44:43 INFO - Return code: 0 18:44:43 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:44:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:44:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:44:43 INFO - Reading from file tmpfile_stdout 18:44:43 INFO - Current package versions: 18:44:43 INFO - argparse == 1.2.1 18:44:43 INFO - blessings == 1.6 18:44:43 INFO - blobuploader == 1.2.4 18:44:43 INFO - docopt == 0.6.1 18:44:43 INFO - manifestparser == 1.1 18:44:43 INFO - mozInstall == 1.12 18:44:43 INFO - mozcrash == 0.16 18:44:43 INFO - mozdebug == 0.1 18:44:43 INFO - mozdevice == 0.48 18:44:43 INFO - mozfile == 1.2 18:44:43 INFO - mozhttpd == 0.7 18:44:43 INFO - mozinfo == 0.9 18:44:43 INFO - mozleak == 0.1 18:44:43 INFO - mozlog == 3.1 18:44:43 INFO - moznetwork == 0.27 18:44:43 INFO - mozprocess == 0.22 18:44:43 INFO - mozprofile == 0.28 18:44:43 INFO - mozrunner == 6.11 18:44:43 INFO - mozscreenshot == 0.1 18:44:43 INFO - mozsystemmonitor == 0.0 18:44:43 INFO - moztest == 0.7 18:44:43 INFO - mozversion == 1.4 18:44:43 INFO - psutil == 3.1.1 18:44:43 INFO - requests == 1.2.3 18:44:43 INFO - wsgiref == 0.1.2 18:44:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:44:43 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')]} 18:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:43 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')]} 18:44:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:43 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 0x7f7b2478ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1897670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19268c0>, '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 0x19277c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1927c50>, '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': 'fa44defc139c4ba8574fe040000001db-1456534520.652117-185683663', '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 18:44:43 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 18:44:43 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 18:44:43 INFO - Using env: {'DISPLAY': ':0', 18:44:43 INFO - 'HOME': '/home/cltbld', 18:44:43 INFO - 'LANG': 'en_US.UTF-8', 18:44:43 INFO - 'LANGUAGE': 'en_US:en', 18:44:43 INFO - 'LOGNAME': 'cltbld', 18:44:43 INFO - 'MAIL': '/var/mail/cltbld', 18:44:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:43 INFO - 'MOZ_NO_REMOTE': '1', 18:44:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:43 INFO - 'NO_EM_RESTART': '1', 18:44:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:44:43 INFO - 'PWD': '/builds/slave/test-pgo', 18:44:43 INFO - 'SHELL': '/bin/bash', 18:44:43 INFO - 'SHLVL': '1', 18:44:43 INFO - 'TERM': 'linux', 18:44:43 INFO - 'TMOUT': '86400', 18:44:43 INFO - 'USER': 'cltbld', 18:44:43 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1456534520.652117-185683663', 18:44:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:43 INFO - '_': '/tools/buildbot/bin/python'} 18:44:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:44 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)) 18:44:44 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)) 18:44:44 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)) 18:44:44 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)) 18:44:44 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)) 18:44:44 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)) 18:44:44 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)) 18:44:44 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)) 18:44:44 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)) 18:44:44 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)) 18:44:44 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)) 18:44:44 INFO - Cleaning up... 18:44:44 INFO - Return code: 0 18:44:44 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:44 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 0x7f7b2478ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1897670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19268c0>, '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 0x19277c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1927c50>, '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': 'fa44defc139c4ba8574fe040000001db-1456534520.652117-185683663', '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 18:44:44 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 18:44:44 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 18:44:44 INFO - Using env: {'DISPLAY': ':0', 18:44:44 INFO - 'HOME': '/home/cltbld', 18:44:44 INFO - 'LANG': 'en_US.UTF-8', 18:44:44 INFO - 'LANGUAGE': 'en_US:en', 18:44:44 INFO - 'LOGNAME': 'cltbld', 18:44:44 INFO - 'MAIL': '/var/mail/cltbld', 18:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:44 INFO - 'MOZ_NO_REMOTE': '1', 18:44:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:44 INFO - 'NO_EM_RESTART': '1', 18:44:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:44:44 INFO - 'PWD': '/builds/slave/test-pgo', 18:44:44 INFO - 'SHELL': '/bin/bash', 18:44:44 INFO - 'SHLVL': '1', 18:44:44 INFO - 'TERM': 'linux', 18:44:44 INFO - 'TMOUT': '86400', 18:44:44 INFO - 'USER': 'cltbld', 18:44:44 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1456534520.652117-185683663', 18:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:44 INFO - '_': '/tools/buildbot/bin/python'} 18:44:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:44 INFO - Downloading/unpacking jsonschema 18:44:44 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 18:44:44 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 18:44:44 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 18:44:44 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 18:44:44 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 18:44:44 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 18:44:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:44:46 INFO - Downloading/unpacking functools32 (from jsonschema) 18:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:46 INFO - Downloading functools32-3.2.3-2.tar.gz 18:44:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:44:46 INFO - warning: no files found matching '*.txt' 18:44:46 INFO - no previously-included directories found matching 'build' 18:44:46 INFO - no previously-included directories found matching 'dist' 18:44:46 INFO - no previously-included directories found matching '.git*' 18:44:46 INFO - Installing collected packages: jsonschema, functools32 18:44:46 INFO - Running setup.py install for functools32 18:44:46 INFO - warning: no files found matching '*.txt' 18:44:46 INFO - no previously-included directories found matching 'build' 18:44:46 INFO - no previously-included directories found matching 'dist' 18:44:46 INFO - no previously-included directories found matching '.git*' 18:44:46 INFO - Successfully installed jsonschema functools32 18:44:46 INFO - Cleaning up... 18:44:46 INFO - Return code: 0 18:44:46 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:46 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 0x7f7b2478ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1897670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19268c0>, '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 0x19277c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1927c50>, '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': 'fa44defc139c4ba8574fe040000001db-1456534520.652117-185683663', '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 18:44:46 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 18:44:46 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 18:44:46 INFO - Using env: {'DISPLAY': ':0', 18:44:46 INFO - 'HOME': '/home/cltbld', 18:44:46 INFO - 'LANG': 'en_US.UTF-8', 18:44:46 INFO - 'LANGUAGE': 'en_US:en', 18:44:46 INFO - 'LOGNAME': 'cltbld', 18:44:46 INFO - 'MAIL': '/var/mail/cltbld', 18:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:46 INFO - 'MOZ_NO_REMOTE': '1', 18:44:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:46 INFO - 'NO_EM_RESTART': '1', 18:44:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:44:46 INFO - 'PWD': '/builds/slave/test-pgo', 18:44:46 INFO - 'SHELL': '/bin/bash', 18:44:46 INFO - 'SHLVL': '1', 18:44:46 INFO - 'TERM': 'linux', 18:44:46 INFO - 'TMOUT': '86400', 18:44:46 INFO - 'USER': 'cltbld', 18:44:46 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1456534520.652117-185683663', 18:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:46 INFO - '_': '/tools/buildbot/bin/python'} 18:44:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:46 INFO - Downloading/unpacking flake8 18:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:44:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:44:48 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 18:44:48 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 18:44:48 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 18:44:48 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 18:44:48 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 18:44:48 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 18:44:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:44:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:44:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:44:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:44:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:44:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:44:49 INFO - no previously-included directories found matching 'docs/_build' 18:44:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:44:49 INFO - Running setup.py install for pep8 18:44:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:44:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:44:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:44:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:44:49 INFO - no previously-included directories found matching 'docs/_build' 18:44:49 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:44:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:44:49 INFO - Cleaning up... 18:44:49 INFO - Return code: 0 18:44:49 INFO - Running post-action listener: _resource_record_post_action 18:44:49 INFO - Running post-action listener: _start_resource_monitoring 18:44:49 INFO - Starting resource monitoring. 18:44:49 INFO - ##### 18:44:49 INFO - ##### Running install step. 18:44:49 INFO - ##### 18:44:49 INFO - Running pre-action listener: _resource_record_pre_action 18:44:49 INFO - Running main action method: install 18:44:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:44:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:44:50 INFO - Reading from file tmpfile_stdout 18:44:50 INFO - Detecting whether we're running mozinstall >=1.0... 18:44:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:44:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:44:50 INFO - Reading from file tmpfile_stdout 18:44:50 INFO - Output received: 18:44:50 INFO - Usage: mozinstall [options] installer 18:44:50 INFO - Options: 18:44:50 INFO - -h, --help show this help message and exit 18:44:50 INFO - -d DEST, --destination=DEST 18:44:50 INFO - Directory to install application into. [default: 18:44:50 INFO - "/builds/slave/test-pgo"] 18:44:50 INFO - --app=APP Application being installed. [default: firefox] 18:44:50 INFO - mkdir: /builds/slave/test-pgo/build/application 18:44:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 18:44:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 18:45:06 INFO - Reading from file tmpfile_stdout 18:45:06 INFO - Output received: 18:45:06 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:45:06 INFO - Running post-action listener: _resource_record_post_action 18:45:06 INFO - ##### 18:45:06 INFO - ##### Running run-tests step. 18:45:06 INFO - ##### 18:45:06 INFO - Running pre-action listener: _resource_record_pre_action 18:45:06 INFO - Running main action method: run_tests 18:45:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:45:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:45:06 INFO - Python 2.7.3 18:45:06 INFO - Return code: 0 18:45:06 INFO - grabbing minidump binary from tooltool 18:45:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:06 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 0x19268c0>, '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 0x19277c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1927c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:45:06 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 18:45:06 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 18:45:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:45:06 INFO - Return code: 0 18:45:06 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:45:06 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:45:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:45:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:45:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:45:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:45:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:45:07 INFO - Return code: 0 18:45:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 18:45:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:45:07 INFO - Using env: {'DISPLAY': ':0', 18:45:07 INFO - 'HOME': '/home/cltbld', 18:45:07 INFO - 'LANG': 'en_US.UTF-8', 18:45:07 INFO - 'LANGUAGE': 'en_US:en', 18:45:07 INFO - 'LOGNAME': 'cltbld', 18:45:07 INFO - 'MAIL': '/var/mail/cltbld', 18:45:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:45:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:07 INFO - 'MOZ_NO_REMOTE': '1', 18:45:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:45:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:07 INFO - 'NO_EM_RESTART': '1', 18:45:07 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:45:07 INFO - 'PWD': '/builds/slave/test-pgo', 18:45:07 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:45:07 INFO - 'SHELL': '/bin/bash', 18:45:07 INFO - 'SHLVL': '1', 18:45:07 INFO - 'TERM': 'linux', 18:45:07 INFO - 'TMOUT': '86400', 18:45:07 INFO - 'USER': 'cltbld', 18:45:07 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1456534520.652117-185683663', 18:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:07 INFO - '_': '/tools/buildbot/bin/python'} 18:45:07 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:45:07 INFO - mozversion application_buildid: 20160226163041 18:45:07 INFO - mozversion application_changeset: 2d8118073de1024df419bb3879e7a7e0e2427aea 18:45:07 INFO - mozversion application_display_name: Nightly 18:45:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:45:07 INFO - mozversion application_name: Firefox 18:45:07 INFO - mozversion application_remotingname: firefox 18:45:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:45:07 INFO - mozversion application_vendor: Mozilla 18:45:07 INFO - mozversion application_version: 47.0a1 18:45:07 INFO - mozversion platform_buildid: 20160226163041 18:45:07 INFO - mozversion platform_changeset: 2d8118073de1024df419bb3879e7a7e0e2427aea 18:45:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:45:07 INFO - mozversion platform_version: 47.0a1 18:45:07 INFO - using testdate: 1456541107 18:45:07 INFO - actual date: 1456541107 18:45:07 INFO - starting webserver on 'localhost:43272' 18:45:07 INFO - SUITE-START | Running 2 tests 18:45:07 INFO - TEST-START | dromaeo_css 18:45:07 INFO - operating with platform_type : linux_ 18:45:07 INFO - Initialising browser for dromaeo_css test... 18:45:07 INFO - TEST-INFO | started process 17284 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNpWYCv/profile http://localhost:43272/getInfo.html) 18:45:11 INFO - PROCESS | 17284 | 18:45:11 INFO - PROCESS | 17284 | (process:17366): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:45:12 INFO - PROCESS | 17284 | __metrics Screen width/height:1600/1200 18:45:12 INFO - PROCESS | 17284 | colorDepth:24 18:45:12 INFO - PROCESS | 17284 | Browser inner width/height: 1024/697 18:45:12 INFO - PROCESS | 17284 | __metrics 18:45:13 ERROR - PROCESS | 17284 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 18:45:13 INFO - PROCESS | 17284 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 18:45:13 INFO - PROCESS | 17284 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 18:45:13 INFO - PROCESS | 17284 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 18:45:13 INFO - PROCESS | 17284 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 18:45:13 INFO - PROCESS | 17284 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 18:45:13 INFO - PROCESS | 17284 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 18:45:13 INFO - PROCESS | 17284 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 18:45:13 INFO - PROCESS | 17284 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 18:45:13 INFO - PROCESS | 17284 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 18:45:14 INFO - TEST-INFO | 17284: exit 0 18:45:14 INFO - Browser initialized. 18:45:14 INFO - Running cycle 1/1 for dromaeo_css test... 18:45:14 INFO - TEST-INFO | started process 17419 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNpWYCv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:45:15 INFO - PROCESS | 17419 | 18:45:15 INFO - PROCESS | 17419 | (process:17476): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:45:26 INFO - PROCESS | 17419 | RSS: Main: 157941760 18:45:26 INFO - PROCESS | 17419 | 18:46:15 INFO - PROCESS | 17419 | 1456541175736 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] 18:48:24 INFO - PROCESS | 17419 | Cycle 1(1): loaded http://localhost:43272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43272/tests/dromaeo/cssquery-ext.html) 18:48:25 INFO - PROCESS | 17419 | RSS: Main: 165613568 18:48:25 INFO - PROCESS | 17419 | 18:51:27 INFO - PROCESS | 17419 | Cycle 1(1): loaded http://localhost:43272/tests/dromaeo/cssquery-ext.html (next: http://localhost:43272/tests/dromaeo/cssquery-jquery.html) 18:51:27 INFO - PROCESS | 17419 | RSS: Main: 162889728 18:51:27 INFO - PROCESS | 17419 | 18:54:29 INFO - PROCESS | 17419 | Cycle 1(1): loaded http://localhost:43272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43272/tests/dromaeo/cssquery-mootools.html) 18:54:30 INFO - PROCESS | 17419 | RSS: Main: 162930688 18:54:30 INFO - PROCESS | 17419 | 18:57:31 INFO - PROCESS | 17419 | Cycle 1(1): loaded http://localhost:43272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43272/tests/dromaeo/cssquery-prototype.html) 18:57:32 INFO - PROCESS | 17419 | RSS: Main: 161083392 18:57:32 INFO - PROCESS | 17419 | 19:00:34 INFO - PROCESS | 17419 | Cycle 1(1): loaded http://localhost:43272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43272/tests/dromaeo/cssquery-yui.html) 19:00:35 INFO - PROCESS | 17419 | RSS: Main: 162353152 19:00:35 INFO - PROCESS | 17419 | 19:03:37 INFO - PROCESS | 17419 | Cycle 1(1): loaded http://localhost:43272/tests/dromaeo/cssquery-yui.html (next: http://localhost:43272/tests/dromaeo/cssquery-dojo.html) 19:03:37 INFO - PROCESS | 17419 | RSS: Main: 164487168 19:03:37 INFO - PROCESS | 17419 | 19:03:37 INFO - PROCESS | 17419 | __start_tp_report 19:03:37 INFO - PROCESS | 17419 | _x_x_mozilla_page_load 19:03:37 INFO - PROCESS | 17419 | _x_x_mozilla_page_load_details 19:03:37 INFO - PROCESS | 17419 | |i|pagename|runs| 19:03:37 INFO - PROCESS | 17419 | |0;dojo.html;3182.856771445285;3208.743300535957;3237.384896869596;3256.544083828264;3259.9674003259975;5146.742662866851;5263.49996750309;5275.103232450488;5297.284866543016;5297.629165958385;5183.17069268917;5247.396549396821;5255.816046438375;5262.763175657095;5274.393444753854;4731.597814185799;4751.073540659573;4783.043391321732;4804.159272127364;4870.610351171916;754.6135683491236;4828.348172996635;4834.033193361324;4836.2987366831785;4847.054824309261;4789.952100478986;4801.519848015206;4815;4827.8551643450755;4853.174960256747;4770.403699537558;4772.546608072227;4782.904341913142;4801.4718380978065;4855.635827312965;4729.929051064237;4766.975100353406;4816.20532612122;4841.176999910023;4894.241392584119;4976.651634385595;5056.064628043824;5063.924041139349;5073.974630126862;5131.281620573122;5624;5627.155926611041;5630.774769009235;5632.127020311858;5643.943560564424;5526.696031718254;5538.6399884007815;5575.163725441175;5621.044422448153;5639.069553523664;5315.229291752713;5348.037353276409;5354.089804733205;5354.5180933715765;5365.356157261153;5645.717714114277;5831.708414579254;5834.095715164156;5847.035239185572;5876.500497457679;5558.082916318843;5618.381977982419;5626.887462250732;5629.0712032514175;5676.545876329884;5660.235868157828;5677.574181936371;5681;5683.772649094072;5686.772529098873;5512.6692398456225;5635.126555383922;5640.069388550925;5662.37713851476;5665.291838520185;5430.8913821723345;5525.143602741581;5663.461971112738;5676.716164191774;5715.31416230055;4362.345648152739;4364.650827933758;4414.139242847678;4416.050549131952;4486.327050942319;3937.409388591734;3969.7419667722083;3988.461557689675;4003.739756915791;4047.838086476567;5154.896902061938;5179.093658609803;5217.921731174036;5371.919421208685;5378.677279363251;5619.80330688424;5642.520385767174;5682.062459694104;5686.2039314496005;5694.088945768657;5333.2266821310695;5338.706371149547;5339.492748188916;5366.812161574326;5403.054465468527;4643.233866412072;4776.785044672998;4861;4865.464798872121;4891.657583969088;5892.175095486636;5899.528037756969;5908.645481271137;5910.763569457259;5941.316748573883;5657.830265092054;5661.348944871393;5661.943380566142;5666.320041595035;5673.205751194753;5723.513501352431;5877;5919.644821310735;5926.525877929669;5987.700614969322;5549;5611.270534830446;5612.466815652507;5613.887722245614;5615.382307946041;5527.972360138174;5622.718864056699;5688.175214593944;5696.658200507983;5700.201971724045;5533.529649979797;5558.166275058774;5580.2466666999435;5592.245046918614;5628.015097358028;5433.4566543345345;5502.284702988586;5538.6399884007415;5549.639273447213;5558.805441809517;5280.128778751463;5377.354717433933;5386.7037312946595;5397.27136836522;5481.506664400223;5425.972870135624;5447.373552041566;5569.025420551468;5605.747741351567;5613.214150018919;5435.864103397446;5450.182472629137;5473.343198816167;5477.643953143033;5480.068388373907 19:03:37 INFO - PROCESS | 17419 | |1;ext.html;518.7198912587203;545.187670371147;558.1432501110793;565.2736233939389;580.6283978253921;35860.82069589652;36215.275694486096;36578;36669.26661466769;36737.63262367376;37386.25227495449;37792.43311350332;37821;37881.242375152484;38050.42924356137;8237.299829514499;8495.490270583785;8537.146285371444;8600.526971016592;8600.56997150143;8415.789605259857;8495.36284778644;8529.95735021324;8640.783980400478;8794.6921857735;8731.345149113842;8737.344699147558;8800.11998800118;8806.119388061175;8822.602982865754;8536.44513106646;8589.61346739395;8591.6992905248;8597.441166324168;8601.698940537113;8527.31781457488;8635.6977505787;8645.481271123752;8659.090795466449;8686.348523860735;31245.375092498023;37232.62767372346;37636.43545346822;37723.43414848752;37891.05272368213;2957.5267957126757;3225.1775797171804;3403.5575375201315;3561.4479755637917;4080.204360149772;27618.309542261402;28686.83439264662;28923.56614650782;29508.55737163923;29518.26204344887;3992.840286388541;4012.558618551957;4027.7784721840285;4140.441040459529;4182.477190351206;173978;174973;175254.1237293818;175388.99999999872;175532;42257.57742422536;43064;43114.568854311685;57845.42154578485;58168.41831581714;40282.19435611271;40357.394639080434;40424.79787601043;40574.18851622951;40821.1835763289;14868.330925108396;14988.850111498745;15036.699266014619;15084.396624135132;15099.622509437351;11752.353620550952;11757.88242117585;11760.823587646191;11778.411079446165;11794.646160615195;14112;14206.502772402917;14271;14331;14397.568072957829;5699.287589051369;5738.856528586819;5817.7963771267805;5865.853353666107;5883.17635531026;924.1405492891676;948.9715308540755;970.96601618943;1001.6093723447862;1076.4832880217539;27598.724012759616;28190.85904570464;28364;28460.573091403647;28618.141455756362;1071.9517621707041;1086.1365214654368;1090.7109615951779;1150.9424528773527;1170;14711.411543538139;14891.255437228312;15021.924890375696;15045.398184072734;15063.17152556598;295125;296045;296497;298630;298856;52420.47579524156;52731.73634131805;52964;53103.468965310625;53126;1320.1155225998411;1354.634248752851;1358.1647286918671;1360.6870419803304;1361.611940596925;27308;28249.858750706117;28562.428751425272;28891.85554072216;28935.85532072326;46384.7680761594;46720.53279467162;46863.765681171375;47011;47030.294545582525;230568;232210;232573;232723;234656;32490.512642310856;32545.674543254263;33319.16702082467;33345.333093338486;33351.666483334855;43252.56747432485;43892.341614876445;44256;44480.33279500875;44530.55469445264;37425.62574374222;37551.624483754815;37872.43191352077;38222.426663599515;38323.616763832004;36089.63910360863;37318.813405933884;37320.253594928494;37364.439533406476;38029.239415210985;30983.535246970863;35553.28893422169;35897.1025724359;36105.27789444144;36852.81573592115;30506.32342139352;31565.684343156274;31732.682673173895;32226.83886580552;32591.511127333582;24091.51816963686;24096;24430.511389772462;24686.259412217663;24792.132275370277 19:03:37 INFO - PROCESS | 17419 | |2;jquery.html;357.11791874071037;359.1309032142214;360.8394264552274;366.25284419783645;368.2303984672035;16503.339866405346;16629.41797037104;17425;17457.912710436445;17476.650466990654;16160.191990400492;16271;16354;16374.590635234124;16459;5276.973615131928;5298.4436634153435;5493.093639549469;5493.890122197554;5518.834434966958;5338.439463856297;5472.452754724515;5473.753681084341;5480.177973303997;5499.450054994489;5233.555147812441;5424.186372044185;5434.483724046209;5443.863903402407;5450.454954504537;5386.811461598845;5428.375736790261;5441.29263195786;5441.755121019563;5463.453654634544;4813.879653008703;4836.806527738886;4845.53967373099;4859.319695242633;5058.671186372874;18341.63316733658;19076.23695052196;19329.613407731908;19666.80333196664;19727.506812329662;2122.36329101269;2160.243914629867;2218.43429925368;2514.9874250628814;2625.698044724843;8916.286697064284;8972.282217422591;9393.76515587109;9434.764130896714;9444.338896277264;1845.5847434327304;1860.6836837737617;1907.9523011924673;1909.9045047747695;1914.2917120665304;48683.75658121722;58738;61256.387436125515;66135.66932165356;67264;9935.453550054817;10040.246981476419;10278.074973252295;10343.586256549654;10471.528781204865;13641.317934103256;13673.316334183251;13677.726445471035;13710;13790.931045344709;7493.190699877686;7576.886346704804;7754.767356979187;7757.4181936355;7829.41279404047;7396.889046664304;7459.776206713699;7505.737299194502;7529.962350188323;7559.433042521833;4354.564543545684;4447.733136011785;4487.057717879216;4492.944158122838;4513.751743654065;1852.8239817217343;1853.3605905962422;1864.3474783825823;1867.430433717702;1884.3875740384156;927.1562877781187;983.4050399508337;985.5466485416645;1008.4907121903392;1018.6231094494937;15845.128517931395;16250.674986500204;16496.587585310222;16672.33310667584;17110.230039648246;782.3584660578272;796.1918652567648;803.9437239393186;817.7097130518699;843.8312337532395;8171.79570510742;8546.31629469641;8665.653373864974;8736.78158046054;8816.42632107254;378304;399076;400495;405309;406519;48006;73000.63499682468;73490.63254683692;73948;74184.25815741881;945.7257395355407;1029.9691009269584;1040.3601784902382;1061.2571200159919;1064.8988346107108;14328.570142895729;15121.773173402187;15409.383624654889;15537.06777593348;15679.608009799389;31049;31853.36293274168;32638.34723305568;32927.341453171284;33013.83493082519;37225.255494890494;43477.56522434862;45280;45741;46136.53863461322;7851.4111441643245;7935.1271360149185;8034.076081250731;8059.153788852321;8065.024069103108;9299.86050209261;11907.166498345032;12315.753684926072;12509.56216532417;12706.809397859224;6310.895593271068;9680.612775488902;10095.697129086138;10666.73333166677;11496.252743571642;10470.738231544272;10578.153747700011;10997.670069897917;11245.71885702864;11432;11139.220254582102;11230.157738169833;11441.313521188755;11462.885371146182;11794.705132371759;7589.1272503662785;7851.411144164096;7852.489588176751;7902.565358905315;8169.79575510617;10449.268551201343;10835.891641083488;10891.455427228766;11131.72170695739;11167.720806979565 19:03:37 INFO - PROCESS | 17419 | |3;mootools.html;1447.4933773179384;1470.9926450367745;1653.2560347843466;1817.064211930855;1817.3639226270798;6525.216973963119;7147.89278160828;7257.5282606630535;7396.519226250297;7398.556086634806;7192.784216473514;7229.89155162673;7286.56280623163;7296.452766042555;7302.123745150576;2218.6561083032116;2231.1744654477866;2246.2475070851283;2246.6742322363248;2248.2580748353084;2169.4142581502983;2181.5745929543746;2211.845170838042;2218.190360518407;2228.6434170532716;2198.6152423325934;2218.7559368469456;2218.966715499269;2225.2434172381386;2242.7757224277525;2202.427368884086;2217.0355895185567;2220.3782940776446;2223.3663405929315;2225.2322948582714;2192.2875065603585;2214.1254204589095;2231;2233.486298151418;2240.1487434774845;7357.0803649543805;7386.0767404074495;7431.071116110486;7433.962830185815;7440.55356678601;4373.715708478971;4450.732956022616;4480.5967462928165;4485.596296333346;4499.775011249424;2826.985865070682;2974.107767669712;3006.6241719785025;3008.7743419243643;3024.5765592817024;908.52756566585;943.2077055273535;965.3435663748648;965.4207475514635;981.018981018981;9576.329656924088;9577.952110239405;9600.135987761136;9635.421874687541;9642.132208101304;4088.1619268049976;4110.712250142521;4178.6865985051245;4183.5398106208295;4183.853565125206;8372.958135209406;8382.706605268786;8397.496150230883;8398.202170793766;8410.411271211078;4445.066536027406;4470.463544374696;4481.977590112028;4486.237339652267;4491.169133710208;3684.1342284563107;4036.414719865603;4087.9386809197886;4103.8974025649595;4117.464729585135;3534.3638145134123;3547.255076433926;3566.465030245432;3641.890743277706;3652.5799533054037;1174.0431548288118;1196.216478206776;1197.0842305636022;1199.4662375242933;1204.8252953370568;1078.3691540448926;1093.1254996003165;1228.81567764836;1264.0772236267392;1293.0819118425834;6931.965340173368;6997.265287144878;7075.610841403669;7080.822979425556;7081.433485321162;473.26407436435983;475.7716296177785;476.5948943398153;484.27600736898563;487.2399057470358;5544.16837474374;5595.804146854841;5599.720013999284;5607.663540187602;5644.6613203207935;8048.275655191061;8153.9184608153155;8351.08138104808;8391.706290279812;8427.241548260687;8174.83650327002;8210.055843578066;8249.175082491704;8268.09051004389;8279.54462504556;6646.933530664728;6730.831729206809;6766.7969960901255;6769.695363708645;6822.317768223237;6876.96845473183;6904.171499420102;6939.444844412334;6953.061336719478;6982.68577913985;7767.339776119094;7878.251566101211;7918.683252669829;7930.563818990011;8038.276555110068;7490.325870671666;7673.961630191813;7694.846103078019;7695.769126926201;8166.101728809945;5861.912071319019;6288.371162883675;6481.060246264171;6492.188476440445;6510.47916166715;6888.380045795902;6908.723651054102;6931.826704332432;6955.75654852098;6994.790156295319;6283.622982621057;6324.114623952558;6440.484761218998;6482.57863238888;6558.573692709959;6345.270293916259;6409.262934762375;6416.743330266924;6463.741450341934;6507.934920650733;6455.612663240033;6491.188601424822;6504.577202481823;6618.933810661832;6666.83332916681;5854.268216472941;5893.970530147321;5930.05119180929;6017.127516510169;6051.152838602511;6025.698715064142;6038.8792224154395;6062.090686397076;6067.726952287246;6076.240469941257 19:03:37 INFO - PROCESS | 17419 | |4;prototype.html;324.4500571531255;325.24218570730187;328.96710328967123;333.85310463396104;336.4045639218583;6241.563090583655;6250.374962503747;6265.561410701247;6304.842378940517;6360.17317748692;6191.102290167934;6216.906746398808;6217.378262173792;6233.501319894409;6239.376062393759;4590.42619672541;4681.063787242548;4704.529547045302;4732.9763351183365;4769.737664428464;4706.10583989041;4710.97644511777;4714.622830173595;4749.90500189996;4757.286407038937;4676.48558658549;4683.274092515666;4690.64820138491;4692.991006933508;4708.458527269357;4697.741624210684;4699.38907941967;4700.55344742249;4709.882252943669;4717.646176536739;4061.208064427438;4063.227986682521;4063.6545893599077;4066.9593304066875;4072.5723799000975;5951;5953.255843019622;5971.373005834368;5982;5982.132590774313;5285.86785330366;5470.370907345667;5471.261379713727;5475.0418676731415;5480.7533660985355;6559.8032059038305;6636.203655561315;6647.169103862017;6648.401643852028;6660.0342950272425;4465.68740188187;4469.687121901468;4471.664625153094;4476.082403107355;4479.10417916418;6885.655717214169;6893.4829887758615;6952.687129079153;6954.40887524561;6974.581525108459;4545.36364908913;4547.136044151601;4557.658175636774;4559.293309537027;4559.540946897027;4430.246858034142;4582.335561343587;4585.839495617637;4594.379758732595;4610.792514336863;5401.540869026177;5407.675539467645;5423.647462914898;5468.37113731918;5483.890322193533;6671.933280667228;6681.064650948871;6710.362515561014;6727.327267273234;6734.8653026940165;1610.6698126883962;1621.8459246371576;1627.2270671430977;1631.0458381846752;1632.5918520369908;1007.8538611901233;1025.487256371814;1035.782485678001;1036.1192985962023;1048.9475526223657;6226.40849119333;6242.282137554149;6270.278917924497;6291.937080629135;6322.146510221153;6832.795016149524;6863.931360686429;6891.483138764613;6892.241853396123;6918.342757438036;6128.938710612926;6252.531060170505;6385.936140638627;6408.2630497492455;6471.932131198394;3693.612170722089;3745.756525825813;3748.981255093707;3755.399136138205;3764.378877485239;7309.5248808827255;7310.59791711461;7348.448866335047;7357.77926662201;7358.632068396559;7077.929220707727;7114.786556403316;7133.678984445713;7137.4290056795335;7138.286171382821;7091;7312.853742925112;7324.121105467378;7332.816679582947;7336.926630733731;6878.45234822161;6894.551854129466;6925.89611155823;6929.09449901261;6944.722211111499;6799.218089919525;6861.313868613299;6884.208316043519;6885.8967115492305;6912.585244885323;7283.271672832886;7291.562506249642;7295.306945840137;7296.19741828409;7327.450441217036;4487.08014856947;4561.224591819465;4572.771361431982;4599.080183963154;4615.330777037378;6882.793516194522;6899.758508452381;6919.169699636076;6931.584104953517;6932.584044957319;6678.799636010733;6704.363085506869;6704.899426508508;6708.731650733916;6711.966440167768;6732.596044237362;6734.696938637871;6736.629485378156;6739.59562426256;6745.988101784772;6413.807585772434;6527.184101987252;6559.8032059038305;6567.2447668518735;6572.34276572339;6691.063251144941;6728.024436456784;6730.990351447322;6779.593224406552;6784.219814721173;6572.901406479003;6585.670716464062;6590.50571207171;6604.405603495708;6624.9337506624315 19:03:37 INFO - PROCESS | 17419 | |5;yui.html;771.1594362145261;805.4925396999889;807.1824380871259;816.8971887951262;830.3896635972559;13706.725865482684;13885.4445822167;13888.861111388884;13931.094478858893;13935;13336.599902002956;13404.396802143903;13408.396622152002;13421.261830599313;13439;821.8150916043887;828.8963879515061;833.3041910005153;835.8411901738681;839.7019058234331;841.9326453883705;843.4517563583659;844.9281811046069;847.6270441005969;850.408965768791;873.3668090634271;877.026500584354;878.802269489363;880.1242763450376;884.0275696733606;872.7599910024699;873.1007062725339;873.9825203495958;875.3522393428881;876.3996662286354;645.3481983196958;648.4099469482795;648.8864448721455;649.5712829532486;649.8375406148463;14019.789703154462;14038.92980535101;14066.437342506288;14078.788818167735;14112.082714623619;12733.363331833463;12908.290044047573;12984.350782460933;13039.674008149777;13105.2136871788;10730.141588672888;10805.243632945698;10821.513031913582;10846.29499082565;10942.726431839188;3646.453032045188;3662.157703728131;3683.9631603684156;3690.907727306812;3768.5100936878302;41971.160576788294;42124.15751684949;42334.78832605848;42578;46197.30704039409;10281.948590257001;10290.12533934624;10373.222008349405;10459.058684718411;10471.47642617866;17813.109344532983;17819.376321828673;17851.28594856217;17926.5518362042;17955.551111222063;7580.317771400601;7621.466497345133;7673.53958762476;7680.423968202295;7898.802529936683;4161.542230354658;4331.371951067141;4345.913081738411;4347.456567929009;4407;2943.5290353543332;2986.910392688223;2990.7009299070355;2991.5064014437376;2991.970080299213;583.7256489449952;595.9940400596025;599.9670018148956;601.7111786342492;602.5962605054624;592.7078967850042;603.1494503317834;637.3212528656966;670;688.9621070841051;8029.959850200712;8354.498730076215;8497.957510212409;8683.782905427415;8781.429207101519;672.825065482978;694.8783962806489;707.67093301615;713.4363852556422;714.3927661487797;3788.6021967693546;3864.8260828262796;3881.359575669983;3887.261420330128;3896.12337224128;52242.738786305825;52793;52876.47123528716;53039.93920121576;53311.46688533065;46045.30932036022;47509.28736068962;47911.520884791404;47960.760196199495;48562.27156592654;42867.35698964518;43451.78274108609;43501.564984350385;44088.338674919905;44319.556804432184;7435.962820185864;7618.923810762043;7789.805254868674;7793.61031948389;7872.56700881457;32566.34867302688;32682.182945426553;33322.66677333292;33584.49623255702;33679.66320336765;39999.600003999585;40692.18615627612;41202.1759564801;41328;41395.172096558505;10147.441890696082;10210.948945255226;10222.437765922945;10401.375917444977;10525.894741052798;10791.676249712207;10995.670129896116;11003.724906877393;11070.446477676245;11338.433078345884;10595.364278143335;10799.784004319712;10879.401632910265;10885.276413749543;10944.56221751153;9963.302568820112;10119.59521619127;10217.995118255945;10338.12125969301;10384.584616615251;10381.377117372982;10402.427866467417;10405.271630985759;10417.739556511147;10554.577816887238;8950.865737013819;9245.630174792934;9302.953485232802;9419.952900235456;9526.333156678966;8531.23218910301;8626.482411055356;8923.41997770143;9051.773705657411;9193.816123677356 19:03:37 INFO - PROCESS | 17419 | __end_tp_report 19:03:37 INFO - PROCESS | 17419 | __start_cc_report 19:03:37 INFO - PROCESS | 17419 | _x_x_mozilla_cycle_collect,313 19:03:37 INFO - PROCESS | 17419 | __end_cc_report 19:03:37 INFO - PROCESS | 17419 | __startTimestamp1456542217968__endTimestamp 19:03:37 INFO - PROCESS | 17419 | 19:03:37 INFO - PROCESS | 17419 | ------- Summary: start ------- 19:03:37 INFO - PROCESS | 17419 | Number of tests: 6 19:03:37 INFO - PROCESS | 17419 | 19:03:37 INFO - PROCESS | 17419 | [#0] dojo.html Cycles:165 Average:5229.86 Median:5447.37 stddev:667.76 (12.3%) stddev-sans-first:650.21 19:03:37 INFO - PROCESS | 17419 | Values: 3182.9 3208.7 3237.4 3256.5 3260.0 5146.7 5263.5 5275.1 5297.3 5297.6 5183.2 5247.4 5255.8 5262.8 5274.4 4731.6 4751.1 4783.0 4804.2 4870.6 754.6 4828.3 4834.0 4836.3 4847.1 4790.0 4801.5 4815.0 4827.9 4853.2 4770.4 4772.5 4782.9 4801.5 4855.6 4729.9 4767.0 4816.2 4841.2 4894.2 4976.7 5056.1 5063.9 5074.0 5131.3 5624.0 5627.2 5630.8 5632.1 5643.9 5526.7 5538.6 5575.2 5621.0 5639.1 5315.2 5348.0 5354.1 5354.5 5365.4 5645.7 5831.7 5834.1 5847.0 5876.5 5558.1 5618.4 5626.9 5629.1 5676.5 5660.2 5677.6 5681.0 5683.8 5686.8 5512.7 5635.1 5640.1 5662.4 5665.3 5430.9 5525.1 5663.5 5676.7 5715.3 4362.3 4364.7 4414.1 4416.1 4486.3 3937.4 3969.7 3988.5 4003.7 4047.8 5154.9 5179.1 5217.9 5371.9 5378.7 5619.8 5642.5 5682.1 5686.2 5694.1 5333.2 5338.7 5339.5 5366.8 5403.1 4643.2 4776.8 4861.0 4865.5 4891.7 5892.2 5899.5 5908.6 5910.8 5941.3 5657.8 5661.3 5661.9 5666.3 5673.2 5723.5 5877.0 5919.6 5926.5 5987.7 5549.0 5611.3 5612.5 5613.9 5615.4 5528.0 5622.7 5688.2 5696.7 5700.2 5533.5 5558.2 5580.2 5592.2 5628.0 5433.5 5502.3 5538.6 5549.6 5558.8 5280.1 5377.4 5386.7 5397.3 5481.5 5426.0 5447.4 5569.0 5605.7 5613.2 5435.9 5450.2 5473.3 5477.6 5480.1 19:03:37 INFO - PROCESS | 17419 | 19:03:37 INFO - PROCESS | 17419 | [#1] ext.html Cycles:180 Average:40263.44 Median:36703.45 stddev:62555.50 (170.4%) stddev-sans-first:62659.80 19:03:37 INFO - PROCESS | 17419 | Values: 518.7 545.2 558.1 565.3 580.6 35860.8 36215.3 36578.0 36669.3 36737.6 37386.3 37792.4 37821.0 37881.2 38050.4 8237.3 8495.5 8537.1 8600.5 8600.6 8415.8 8495.4 8530.0 8640.8 8794.7 8731.3 8737.3 8800.1 8806.1 8822.6 8536.4 8589.6 8591.7 8597.4 8601.7 8527.3 8635.7 8645.5 8659.1 8686.3 31245.4 37232.6 37636.4 37723.4 37891.1 2957.5 3225.2 3403.6 3561.4 4080.2 27618.3 28686.8 28923.6 29508.6 29518.3 3992.8 4012.6 4027.8 4140.4 4182.5 173978.0 174973.0 175254.1 175389.0 175532.0 42257.6 43064.0 43114.6 57845.4 58168.4 40282.2 40357.4 40424.8 40574.2 40821.2 14868.3 14988.9 15036.7 15084.4 15099.6 11752.4 11757.9 11760.8 11778.4 11794.6 14112.0 14206.5 14271.0 14331.0 14397.6 5699.3 5738.9 5817.8 5865.9 5883.2 924.1 949.0 971.0 1001.6 1076.5 27598.7 28190.9 28364.0 28460.6 28618.1 1072.0 1086.1 1090.7 1150.9 1170.0 14711.4 14891.3 15021.9 15045.4 15063.2 295125.0 296045.0 296497.0 298630.0 298856.0 52420.5 52731.7 52964.0 53103.5 53126.0 1320.1 1354.6 1358.2 1360.7 1361.6 27308.0 28249.9 28562.4 28891.9 28935.9 46384.8 46720.5 46863.8 47011.0 47030.3 230568.0 232210.0 232573.0 232723.0 234656.0 32490.5 32545.7 33319.2 33345.3 33351.7 43252.6 43892.3 44256.0 44480.3 44530.6 37425.6 37551.6 37872.4 38222.4 38323.6 36089.6 37318.8 37320.3 37364.4 38029.2 30983.5 35553.3 35897.1 36105.3 36852.8 30506.3 31565.7 31732.7 32226.8 32591.5 24091.5 24096.0 24430.5 24686.3 24792.1 19:03:37 INFO - PROCESS | 17419 | 19:03:37 INFO - PROCESS | 17419 | [#2] jquery.html Cycles:180 Average:23744.87 Median:402902.00 stddev:65270.83 (16.2%) stddev-sans-first:65430.31 19:03:37 INFO - PROCESS | 17419 | Values: 357.1 359.1 360.8 366.3 368.2 16503.3 16629.4 17425.0 17457.9 17476.7 16160.2 16271.0 16354.0 16374.6 16459.0 5277.0 5298.4 5493.1 5493.9 5518.8 5338.4 5472.5 5473.8 5480.2 5499.5 5233.6 5424.2 5434.5 5443.9 5450.5 5386.8 5428.4 5441.3 5441.8 5463.5 4813.9 4836.8 4845.5 4859.3 5058.7 18341.6 19076.2 19329.6 19666.8 19727.5 2122.4 2160.2 2218.4 2515.0 2625.7 8916.3 8972.3 9393.8 9434.8 9444.3 1845.6 1860.7 1908.0 1909.9 1914.3 48683.8 58738.0 61256.4 66135.7 67264.0 9935.5 10040.2 10278.1 10343.6 10471.5 13641.3 13673.3 13677.7 13710.0 13790.9 7493.2 7576.9 7754.8 7757.4 7829.4 7396.9 7459.8 7505.7 7530.0 7559.4 4354.6 4447.7 4487.1 4492.9 4513.8 1852.8 1853.4 1864.3 1867.4 1884.4 927.2 983.4 985.5 1008.5 1018.6 15845.1 16250.7 16496.6 16672.3 17110.2 782.4 796.2 803.9 817.7 843.8 8171.8 8546.3 8665.7 8736.8 8816.4 378304.0 399076.0 400495.0 405309.0 406519.0 48006.0 73000.6 73490.6 73948.0 74184.3 945.7 1030.0 1040.4 1061.3 1064.9 14328.6 15121.8 15409.4 15537.1 15679.6 31049.0 31853.4 32638.3 32927.3 33013.8 37225.3 43477.6 45280.0 45741.0 46136.5 7851.4 7935.1 8034.1 8059.2 8065.0 9299.9 11907.2 12315.8 12509.6 12706.8 6310.9 9680.6 10095.7 10666.7 11496.3 10470.7 10578.2 10997.7 11245.7 11432.0 11139.2 11230.2 11441.3 11462.9 11794.7 7589.1 7851.4 7852.5 7902.6 8169.8 10449.3 10835.9 10891.5 11131.7 11167.7 19:03:37 INFO - PROCESS | 17419 | 19:03:37 INFO - PROCESS | 17419 | [#3] mootools.html Cycles:180 Average:5087.56 Median:6179.93 stddev:2561.41 (41.4%) stddev-sans-first:2553.98 19:03:37 INFO - PROCESS | 17419 | Values: 1447.5 1471.0 1653.3 1817.1 1817.4 6525.2 7147.9 7257.5 7396.5 7398.6 7192.8 7229.9 7286.6 7296.5 7302.1 2218.7 2231.2 2246.2 2246.7 2248.3 2169.4 2181.6 2211.8 2218.2 2228.6 2198.6 2218.8 2219.0 2225.2 2242.8 2202.4 2217.0 2220.4 2223.4 2225.2 2192.3 2214.1 2231.0 2233.5 2240.1 7357.1 7386.1 7431.1 7434.0 7440.6 4373.7 4450.7 4480.6 4485.6 4499.8 2827.0 2974.1 3006.6 3008.8 3024.6 908.5 943.2 965.3 965.4 981.0 9576.3 9578.0 9600.1 9635.4 9642.1 4088.2 4110.7 4178.7 4183.5 4183.9 8373.0 8382.7 8397.5 8398.2 8410.4 4445.1 4470.5 4482.0 4486.2 4491.2 3684.1 4036.4 4087.9 4103.9 4117.5 3534.4 3547.3 3566.5 3641.9 3652.6 1174.0 1196.2 1197.1 1199.5 1204.8 1078.4 1093.1 1228.8 1264.1 1293.1 6932.0 6997.3 7075.6 7080.8 7081.4 473.3 475.8 476.6 484.3 487.2 5544.2 5595.8 5599.7 5607.7 5644.7 8048.3 8153.9 8351.1 8391.7 8427.2 8174.8 8210.1 8249.2 8268.1 8279.5 6646.9 6730.8 6766.8 6769.7 6822.3 6877.0 6904.2 6939.4 6953.1 6982.7 7767.3 7878.3 7918.7 7930.6 8038.3 7490.3 7674.0 7694.8 7695.8 8166.1 5861.9 6288.4 6481.1 6492.2 6510.5 6888.4 6908.7 6931.8 6955.8 6994.8 6283.6 6324.1 6440.5 6482.6 6558.6 6345.3 6409.3 6416.7 6463.7 6507.9 6455.6 6491.2 6504.6 6618.9 6666.8 5854.3 5894.0 5930.1 6017.1 6051.2 6025.7 6038.9 6062.1 6067.7 6076.2 19:03:37 INFO - PROCESS | 17419 | 19:03:37 INFO - PROCESS | 17419 | [#4] prototype.html Cycles:180 Average:5552.69 Median:6259.05 stddev:1732.41 (27.7%) stddev-sans-first:1692.25 19:03:37 INFO - PROCESS | 17419 | Values: 324.5 325.2 329.0 333.9 336.4 6241.6 6250.4 6265.6 6304.8 6360.2 6191.1 6216.9 6217.4 6233.5 6239.4 4590.4 4681.1 4704.5 4733.0 4769.7 4706.1 4711.0 4714.6 4749.9 4757.3 4676.5 4683.3 4690.6 4693.0 4708.5 4697.7 4699.4 4700.6 4709.9 4717.6 4061.2 4063.2 4063.7 4067.0 4072.6 5951.0 5953.3 5971.4 5982.0 5982.1 5285.9 5470.4 5471.3 5475.0 5480.8 6559.8 6636.2 6647.2 6648.4 6660.0 4465.7 4469.7 4471.7 4476.1 4479.1 6885.7 6893.5 6952.7 6954.4 6974.6 4545.4 4547.1 4557.7 4559.3 4559.5 4430.2 4582.3 4585.8 4594.4 4610.8 5401.5 5407.7 5423.6 5468.4 5483.9 6671.9 6681.1 6710.4 6727.3 6734.9 1610.7 1621.8 1627.2 1631.0 1632.6 1007.9 1025.5 1035.8 1036.1 1048.9 6226.4 6242.3 6270.3 6291.9 6322.1 6832.8 6863.9 6891.5 6892.2 6918.3 6128.9 6252.5 6385.9 6408.3 6471.9 3693.6 3745.8 3749.0 3755.4 3764.4 7309.5 7310.6 7348.4 7357.8 7358.6 7077.9 7114.8 7133.7 7137.4 7138.3 7091.0 7312.9 7324.1 7332.8 7336.9 6878.5 6894.6 6925.9 6929.1 6944.7 6799.2 6861.3 6884.2 6885.9 6912.6 7283.3 7291.6 7295.3 7296.2 7327.5 4487.1 4561.2 4572.8 4599.1 4615.3 6882.8 6899.8 6919.2 6931.6 6932.6 6678.8 6704.4 6704.9 6708.7 6712.0 6732.6 6734.7 6736.6 6739.6 6746.0 6413.8 6527.2 6559.8 6567.2 6572.3 6691.1 6728.0 6731.0 6779.6 6784.2 6572.9 6585.7 6590.5 6604.4 6624.9 19:03:37 INFO - PROCESS | 17419 | 19:03:37 INFO - PROCESS | 17419 | [#5] yui.html Cycles:180 Average:13085.71 Median:4338.64 stddev:14653.97 (337.8%) stddev-sans-first:14665.89 19:03:37 INFO - PROCESS | 17419 | Values: 771.2 805.5 807.2 816.9 830.4 13706.7 13885.4 13888.9 13931.1 13935.0 13336.6 13404.4 13408.4 13421.3 13439.0 821.8 828.9 833.3 835.8 839.7 841.9 843.5 844.9 847.6 850.4 873.4 877.0 878.8 880.1 884.0 872.8 873.1 874.0 875.4 876.4 645.3 648.4 648.9 649.6 649.8 14019.8 14038.9 14066.4 14078.8 14112.1 12733.4 12908.3 12984.4 13039.7 13105.2 10730.1 10805.2 10821.5 10846.3 10942.7 3646.5 3662.2 3684.0 3690.9 3768.5 41971.2 42124.2 42334.8 42578.0 46197.3 10281.9 10290.1 10373.2 10459.1 10471.5 17813.1 17819.4 17851.3 17926.6 17955.6 7580.3 7621.5 7673.5 7680.4 7898.8 4161.5 4331.4 4345.9 4347.5 4407.0 2943.5 2986.9 2990.7 2991.5 2992.0 583.7 596.0 600.0 601.7 602.6 592.7 603.1 637.3 670.0 689.0 8030.0 8354.5 8498.0 8683.8 8781.4 672.8 694.9 707.7 713.4 714.4 3788.6 3864.8 3881.4 3887.3 3896.1 52242.7 52793.0 52876.5 53039.9 53311.5 46045.3 47509.3 47911.5 47960.8 48562.3 42867.4 43451.8 43501.6 44088.3 44319.6 7436.0 7618.9 7789.8 7793.6 7872.6 32566.3 32682.2 33322.7 33584.5 33679.7 39999.6 40692.2 41202.2 41328.0 41395.2 10147.4 10210.9 10222.4 10401.4 10525.9 10791.7 10995.7 11003.7 11070.4 11338.4 10595.4 10799.8 10879.4 10885.3 10944.6 9963.3 10119.6 10218.0 10338.1 10384.6 10381.4 10402.4 10405.3 10417.7 10554.6 8950.9 9245.6 9303.0 9420.0 9526.3 8531.2 8626.5 8923.4 9051.8 9193.8 19:03:37 INFO - PROCESS | 17419 | -------- Summary: end -------- 19:03:37 INFO - PROCESS | 17419 | 19:03:38 INFO - PROCESS | 17419 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:38 INFO - PROCESS | 17419 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:38 INFO - PROCESS | 17419 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:38 INFO - PROCESS | 17419 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:38 INFO - PROCESS | 17419 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:38 INFO - PROCESS | 17419 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:38 INFO - PROCESS | 17419 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:38 INFO - PROCESS | 17419 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:38 INFO - TEST-INFO | 17419: exit 0 19:03:38 INFO - TEST-OK | dromaeo_css | took 1110829ms 19:03:38 INFO - TEST-START | kraken 19:03:38 INFO - operating with platform_type : linux_ 19:03:38 INFO - Initialising browser for kraken test... 19:03:38 INFO - TEST-INFO | started process 17657 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpujoouV/profile http://localhost:43272/getInfo.html) 19:03:42 INFO - PROCESS | 17657 | 19:03:42 INFO - PROCESS | 17657 | (process:17730): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:03:43 INFO - PROCESS | 17657 | __metrics Screen width/height:1600/1200 19:03:43 INFO - PROCESS | 17657 | colorDepth:24 19:03:43 INFO - PROCESS | 17657 | Browser inner width/height: 1024/697 19:03:43 INFO - PROCESS | 17657 | __metrics 19:03:43 ERROR - PROCESS | 17657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 19:03:43 INFO - PROCESS | 17657 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:43 INFO - PROCESS | 17657 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:43 INFO - PROCESS | 17657 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:43 INFO - PROCESS | 17657 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:43 INFO - PROCESS | 17657 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:43 INFO - PROCESS | 17657 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:43 INFO - PROCESS | 17657 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:43 INFO - PROCESS | 17657 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:43 INFO - PROCESS | 17657 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:44 INFO - TEST-INFO | 17657: exit 0 19:03:44 INFO - Browser initialized. 19:03:44 INFO - Running cycle 1/1 for kraken test... 19:03:44 INFO - TEST-INFO | started process 17782 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpujoouV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:03:45 INFO - PROCESS | 17782 | 19:03:45 INFO - PROCESS | 17782 | (process:17844): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:03:56 INFO - PROCESS | 17782 | RSS: Main: 158187520 19:03:56 INFO - PROCESS | 17782 | 19:03:58 INFO - PROCESS | 17782 | Cycle 1(1): loaded http://localhost:43272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43272/tests/kraken/driver.html?testName=audio-beat-detection) 19:03:59 INFO - PROCESS | 17782 | RSS: Main: 165289984 19:03:59 INFO - PROCESS | 17782 | 19:04:02 INFO - PROCESS | 17782 | Cycle 1(1): loaded http://localhost:43272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43272/tests/kraken/driver.html?testName=audio-dft) 19:04:02 INFO - PROCESS | 17782 | RSS: Main: 169463808 19:04:02 INFO - PROCESS | 17782 | 19:04:05 INFO - PROCESS | 17782 | Cycle 1(1): loaded http://localhost:43272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43272/tests/kraken/driver.html?testName=audio-fft) 19:04:06 INFO - PROCESS | 17782 | RSS: Main: 161775616 19:04:06 INFO - PROCESS | 17782 | 19:04:08 INFO - PROCESS | 17782 | Cycle 1(1): loaded http://localhost:43272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43272/tests/kraken/driver.html?testName=audio-oscillator) 19:04:08 INFO - PROCESS | 17782 | RSS: Main: 160501760 19:04:08 INFO - PROCESS | 17782 | 19:04:11 INFO - PROCESS | 17782 | Cycle 1(1): loaded http://localhost:43272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:04:11 INFO - PROCESS | 17782 | RSS: Main: 162529280 19:04:11 INFO - PROCESS | 17782 | 19:04:14 INFO - PROCESS | 17782 | Cycle 1(1): loaded http://localhost:43272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43272/tests/kraken/driver.html?testName=imaging-darkroom) 19:04:15 INFO - PROCESS | 17782 | RSS: Main: 162525184 19:04:15 INFO - PROCESS | 17782 | 19:04:18 INFO - PROCESS | 17782 | Cycle 1(1): loaded http://localhost:43272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43272/tests/kraken/driver.html?testName=imaging-desaturate) 19:04:19 INFO - PROCESS | 17782 | RSS: Main: 162320384 19:04:19 INFO - PROCESS | 17782 | 19:04:22 INFO - PROCESS | 17782 | Cycle 1(1): loaded http://localhost:43272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43272/tests/kraken/driver.html?testName=json-parse-financial) 19:04:22 INFO - PROCESS | 17782 | RSS: Main: 164556800 19:04:22 INFO - PROCESS | 17782 | 19:04:24 INFO - PROCESS | 17782 | Cycle 1(1): loaded http://localhost:43272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:04:24 INFO - PROCESS | 17782 | RSS: Main: 163250176 19:04:24 INFO - PROCESS | 17782 | 19:04:26 INFO - PROCESS | 17782 | Cycle 1(1): loaded http://localhost:43272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43272/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:04:27 INFO - PROCESS | 17782 | RSS: Main: 163065856 19:04:27 INFO - PROCESS | 17782 | 19:04:29 INFO - PROCESS | 17782 | Cycle 1(1): loaded http://localhost:43272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:04:30 INFO - PROCESS | 17782 | RSS: Main: 165445632 19:04:30 INFO - PROCESS | 17782 | 19:04:32 INFO - PROCESS | 17782 | Cycle 1(1): loaded http://localhost:43272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:04:33 INFO - PROCESS | 17782 | RSS: Main: 163504128 19:04:33 INFO - PROCESS | 17782 | 19:04:35 INFO - PROCESS | 17782 | Cycle 1(1): loaded http://localhost:43272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:04:36 INFO - PROCESS | 17782 | RSS: Main: 165224448 19:04:36 INFO - PROCESS | 17782 | 19:04:38 INFO - PROCESS | 17782 | Cycle 1(1): loaded http://localhost:43272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43272/tests/kraken/driver.html?testName=ai-astar) 19:04:38 INFO - PROCESS | 17782 | RSS: Main: 166551552 19:04:38 INFO - PROCESS | 17782 | 19:04:38 INFO - PROCESS | 17782 | __start_tp_report 19:04:38 INFO - PROCESS | 17782 | _x_x_mozilla_page_load 19:04:38 INFO - PROCESS | 17782 | _x_x_mozilla_page_load_details 19:04:38 INFO - PROCESS | 17782 | |i|pagename|runs| 19:04:38 INFO - PROCESS | 17782 | |0;ai-astar;115;110;113;112;113;124;113;113;113;112 19:04:38 INFO - PROCESS | 17782 | |1;audio-beat-detection;164;128;159;166;126;153;153;127;169;131 19:04:38 INFO - PROCESS | 17782 | |2;audio-dft;164;164;162;164;162;162;164;164;172;163 19:04:38 INFO - PROCESS | 17782 | |3;audio-fft;73;72;72;73;72;151;74;73;73;73 19:04:38 INFO - PROCESS | 17782 | |4;audio-oscillator;96;96;141;96;97;96;143;96;96;143 19:04:38 INFO - PROCESS | 17782 | |5;imaging-gaussian-blur;119;115;115;115;115;116;116;115;116;118 19:04:38 INFO - PROCESS | 17782 | |6;imaging-darkroom;146;146;146;146;147;151;146;146;146;146 19:04:38 INFO - PROCESS | 17782 | |7;imaging-desaturate;96;96;96;97;97;96;97;97;96;96 19:04:38 INFO - PROCESS | 17782 | |8;json-parse-financial;58;59;58;57;59;58;58;65;57;56 19:04:38 INFO - PROCESS | 17782 | |9;json-stringify-tinderbox;67;68;72;67;69;67;69;67;69;68 19:04:38 INFO - PROCESS | 17782 | |10;stanford-crypto-aes;90;84;84;84;90;83;83;81;85;83 19:04:38 INFO - PROCESS | 17782 | |11;stanford-crypto-ccm;124;119;122;117;130;124;124;123;123;122 19:04:38 INFO - PROCESS | 17782 | |12;stanford-crypto-pbkdf2;146;160;155;153;144;142;158;151;152;142 19:04:38 INFO - PROCESS | 17782 | |13;stanford-crypto-sha256-iterative;73;69;72;73;71;70;69;69;70;68 19:04:38 INFO - PROCESS | 17782 | __end_tp_report 19:04:38 INFO - PROCESS | 17782 | __start_cc_report 19:04:38 INFO - PROCESS | 17782 | _x_x_mozilla_cycle_collect,797 19:04:38 INFO - PROCESS | 17782 | __end_cc_report 19:04:38 INFO - PROCESS | 17782 | __startTimestamp1456542278281__endTimestamp 19:04:38 INFO - PROCESS | 17782 | 19:04:38 INFO - PROCESS | 17782 | ------- Summary: start ------- 19:04:38 INFO - PROCESS | 17782 | Number of tests: 14 19:04:38 INFO - PROCESS | 17782 | 19:04:38 INFO - PROCESS | 17782 | [#0] ai-astar Cycles:10 Average:113.80 Median:113.00 stddev:3.79 (3.4%) stddev-sans-first:4.00 19:04:38 INFO - PROCESS | 17782 | Values: 115.0 110.0 113.0 112.0 113.0 124.0 113.0 113.0 113.0 112.0 19:04:38 INFO - PROCESS | 17782 | 19:04:38 INFO - PROCESS | 17782 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:156.00 stddev:17.65 (11.3%) stddev-sans-first:17.70 19:04:38 INFO - PROCESS | 17782 | Values: 164.0 128.0 159.0 166.0 126.0 153.0 153.0 127.0 169.0 131.0 19:04:38 INFO - PROCESS | 17782 | 19:04:38 INFO - PROCESS | 17782 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:2.92 (1.8%) stddev-sans-first:3.10 19:04:38 INFO - PROCESS | 17782 | Values: 164.0 164.0 162.0 164.0 162.0 162.0 164.0 164.0 172.0 163.0 19:04:38 INFO - PROCESS | 17782 | 19:04:38 INFO - PROCESS | 17782 | [#3] audio-fft Cycles:10 Average:80.60 Median:73.00 stddev:24.74 (33.9%) stddev-sans-first:26.09 19:04:38 INFO - PROCESS | 17782 | Values: 73.0 72.0 72.0 73.0 72.0 151.0 74.0 73.0 73.0 73.0 19:04:38 INFO - PROCESS | 17782 | 19:04:38 INFO - PROCESS | 17782 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:96.00 stddev:22.32 (23.3%) stddev-sans-first:23.09 19:04:38 INFO - PROCESS | 17782 | Values: 96.0 96.0 141.0 96.0 97.0 96.0 143.0 96.0 96.0 143.0 19:04:38 INFO - PROCESS | 17782 | 19:04:38 INFO - PROCESS | 17782 | [#5] imaging-gaussian-blur Cycles:10 Average:116.00 Median:116.00 stddev:1.41 (1.2%) stddev-sans-first:1.00 19:04:38 INFO - PROCESS | 17782 | Values: 119.0 115.0 115.0 115.0 115.0 116.0 116.0 115.0 116.0 118.0 19:04:38 INFO - PROCESS | 17782 | 19:04:38 INFO - PROCESS | 17782 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.00 stddev:1.58 (1.1%) stddev-sans-first:1.66 19:04:38 INFO - PROCESS | 17782 | Values: 146.0 146.0 146.0 146.0 147.0 151.0 146.0 146.0 146.0 146.0 19:04:38 INFO - PROCESS | 17782 | 19:04:38 INFO - PROCESS | 17782 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 19:04:38 INFO - PROCESS | 17782 | Values: 96.0 96.0 96.0 97.0 97.0 96.0 97.0 97.0 96.0 96.0 19:04:38 INFO - PROCESS | 17782 | 19:04:38 INFO - PROCESS | 17782 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:58.00 stddev:2.46 (4.2%) stddev-sans-first:2.60 19:04:38 INFO - PROCESS | 17782 | Values: 58.0 59.0 58.0 57.0 59.0 58.0 58.0 65.0 57.0 56.0 19:04:38 INFO - PROCESS | 17782 | 19:04:38 INFO - PROCESS | 17782 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.50 stddev:1.57 (2.3%) stddev-sans-first:1.59 19:04:38 INFO - PROCESS | 17782 | Values: 67.0 68.0 72.0 67.0 69.0 67.0 69.0 67.0 69.0 68.0 19:04:38 INFO - PROCESS | 17782 | 19:04:38 INFO - PROCESS | 17782 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.00 stddev:2.98 (3.6%) stddev-sans-first:2.47 19:04:38 INFO - PROCESS | 17782 | Values: 90.0 84.0 84.0 84.0 90.0 83.0 83.0 81.0 85.0 83.0 19:04:38 INFO - PROCESS | 17782 | 19:04:38 INFO - PROCESS | 17782 | [#11] stanford-crypto-ccm Cycles:10 Average:122.80 Median:123.50 stddev:3.43 (2.8%) stddev-sans-first:3.61 19:04:38 INFO - PROCESS | 17782 | Values: 124.0 119.0 122.0 117.0 130.0 124.0 124.0 123.0 123.0 122.0 19:04:38 INFO - PROCESS | 17782 | 19:04:38 INFO - PROCESS | 17782 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.30 Median:152.50 stddev:6.52 (4.3%) stddev-sans-first:6.72 19:04:38 INFO - PROCESS | 17782 | Values: 146.0 160.0 155.0 153.0 144.0 142.0 158.0 151.0 152.0 142.0 19:04:38 INFO - PROCESS | 17782 | 19:04:38 INFO - PROCESS | 17782 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.50 stddev:1.78 (2.5%) stddev-sans-first:1.62 19:04:38 INFO - PROCESS | 17782 | Values: 73.0 69.0 72.0 73.0 71.0 70.0 69.0 69.0 70.0 68.0 19:04:38 INFO - PROCESS | 17782 | -------- Summary: end -------- 19:04:38 INFO - PROCESS | 17782 | 19:04:38 INFO - PROCESS | 17782 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:04:38 INFO - PROCESS | 17782 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:04:38 INFO - PROCESS | 17782 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:04:38 INFO - PROCESS | 17782 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:04:38 INFO - PROCESS | 17782 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:04:38 INFO - PROCESS | 17782 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:04:38 INFO - PROCESS | 17782 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:04:39 INFO - TEST-INFO | 17782: exit 0 19:04:39 INFO - TEST-OK | kraken | took 60538ms 19:04:39 INFO - SUITE-END | took 1171s 19:04:39 INFO - Completed test suite (00:19:31) 19:04:39 INFO - Working with test: dromaeo_css 19:04:39 INFO - Generating results file: dromaeo_css 19:04:39 INFO - Working with test: kraken 19:04:39 INFO - Generating results file: kraken 19:04:39 INFO - javascript benchmark 19:04:39 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:04:39 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 19:04:39 INFO - process_Request line: dromaeo_css 6760.59 graph.html#tests=[[72,63,43]] 19:04:39 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:04:39 INFO - process_Request line: kraken 1530.10 graph.html#tests=[[232,63,43]] 19:04:39 INFO - RETURN: dromaeo_css: 6760.59 19:04:39 INFO - RETURN: kraken: 1530.10 19:04:39 INFO - javascript benchmark 19:04:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3182.856771445285, 3208.743300535957, 3237.384896869596, 3256.544083828264, 3259.9674003259975, 5146.742662866851, 5263.49996750309, 5275.103232450488, 5297.284866543016, 5297.629165958385, 5183.17069268917, 5247.396549396821, 5255.816046438375, 5262.763175657095, 5274.393444753854, 4731.597814185799, 4751.073540659573, 4783.043391321732, 4804.159272127364, 4870.610351171916, 754.6135683491236, 4828.348172996635, 4834.033193361324, 4836.2987366831785, 4847.054824309261, 4789.952100478986, 4801.519848015206, 4815.0, 4827.8551643450755, 4853.174960256747, 4770.403699537558, 4772.546608072227, 4782.904341913142, 4801.4718380978065, 4855.635827312965, 4729.929051064237, 4766.975100353406, 4816.20532612122, 4841.176999910023, 4894.241392584119, 4976.651634385595, 5056.064628043824, 5063.924041139349, 5073.974630126862, 5131.281620573122, 5624.0, 5627.155926611041, 5630.774769009235, 5632.127020311858, 5643.943560564424, 5526.696031718254, 5538.6399884007815, 5575.163725441175, 5621.044422448153, 5639.069553523664, 5315.229291752713, 5348.037353276409, 5354.089804733205, 5354.5180933715765, 5365.356157261153, 5645.717714114277, 5831.708414579254, 5834.095715164156, 5847.035239185572, 5876.500497457679, 5558.082916318843, 5618.381977982419, 5626.887462250732, 5629.0712032514175, 5676.545876329884, 5660.235868157828, 5677.574181936371, 5681.0, 5683.772649094072, 5686.772529098873, 5512.6692398456225, 5635.126555383922, 5640.069388550925, 5662.37713851476, 5665.291838520185, 5430.8913821723345, 5525.143602741581, 5663.461971112738, 5676.716164191774, 5715.31416230055, 4362.345648152739, 4364.650827933758, 4414.139242847678, 4416.050549131952, 4486.327050942319, 3937.409388591734, 3969.7419667722083, 3988.461557689675, 4003.739756915791, 4047.838086476567, 5154.896902061938, 5179.093658609803, 5217.921731174036, 5371.919421208685, 5378.677279363251, 5619.80330688424, 5642.520385767174, 5682.062459694104, 5686.2039314496005, 5694.088945768657, 5333.2266821310695, 5338.706371149547, 5339.492748188916, 5366.812161574326, 5403.054465468527, 4643.233866412072, 4776.785044672998, 4861.0, 4865.464798872121, 4891.657583969088, 5892.175095486636, 5899.528037756969, 5908.645481271137, 5910.763569457259, 5941.316748573883, 5657.830265092054, 5661.348944871393, 5661.943380566142, 5666.320041595035, 5673.205751194753, 5723.513501352431, 5877.0, 5919.644821310735, 5926.525877929669, 5987.700614969322, 5549.0, 5611.270534830446, 5612.466815652507, 5613.887722245614, 5615.382307946041, 5527.972360138174, 5622.718864056699, 5688.175214593944, 5696.658200507983, 5700.201971724045, 5533.529649979797, 5558.166275058774, 5580.2466666999435, 5592.245046918614, 5628.015097358028, 5433.4566543345345, 5502.284702988586, 5538.6399884007415, 5549.639273447213, 5558.805441809517, 5280.128778751463, 5377.354717433933, 5386.7037312946595, 5397.27136836522, 5481.506664400223, 5425.972870135624, 5447.373552041566, 5569.025420551468, 5605.747741351567, 5613.214150018919, 5435.864103397446, 5450.182472629137, 5473.343198816167, 5477.643953143033, 5480.068388373907], "unit": "score", "name": "dojo.html", "value": 5189.936366004406}, {"lowerIsBetter": false, "replicates": [518.7198912587203, 545.187670371147, 558.1432501110793, 565.2736233939389, 580.6283978253921, 35860.82069589652, 36215.275694486096, 36578.0, 36669.26661466769, 36737.63262367376, 37386.25227495449, 37792.43311350332, 37821.0, 37881.242375152484, 38050.42924356137, 8237.299829514499, 8495.490270583785, 8537.146285371444, 8600.526971016592, 8600.56997150143, 8415.789605259857, 8495.36284778644, 8529.95735021324, 8640.783980400478, 8794.6921857735, 8731.345149113842, 8737.344699147558, 8800.11998800118, 8806.119388061175, 8822.602982865754, 8536.44513106646, 8589.61346739395, 8591.6992905248, 8597.441166324168, 8601.698940537113, 8527.31781457488, 8635.6977505787, 8645.481271123752, 8659.090795466449, 8686.348523860735, 31245.375092498023, 37232.62767372346, 37636.43545346822, 37723.43414848752, 37891.05272368213, 2957.5267957126757, 3225.1775797171804, 3403.5575375201315, 3561.4479755637917, 4080.204360149772, 27618.309542261402, 28686.83439264662, 28923.56614650782, 29508.55737163923, 29518.26204344887, 3992.840286388541, 4012.558618551957, 4027.7784721840285, 4140.441040459529, 4182.477190351206, 173978.0, 174973.0, 175254.1237293818, 175388.99999999872, 175532.0, 42257.57742422536, 43064.0, 43114.568854311685, 57845.42154578485, 58168.41831581714, 40282.19435611271, 40357.394639080434, 40424.79787601043, 40574.18851622951, 40821.1835763289, 14868.330925108396, 14988.850111498745, 15036.699266014619, 15084.396624135132, 15099.622509437351, 11752.353620550952, 11757.88242117585, 11760.823587646191, 11778.411079446165, 11794.646160615195, 14112.0, 14206.502772402917, 14271.0, 14331.0, 14397.568072957829, 5699.287589051369, 5738.856528586819, 5817.7963771267805, 5865.853353666107, 5883.17635531026, 924.1405492891676, 948.9715308540755, 970.96601618943, 1001.6093723447862, 1076.4832880217539, 27598.724012759616, 28190.85904570464, 28364.0, 28460.573091403647, 28618.141455756362, 1071.9517621707041, 1086.1365214654368, 1090.7109615951779, 1150.9424528773527, 1170.0, 14711.411543538139, 14891.255437228312, 15021.924890375696, 15045.398184072734, 15063.17152556598, 295125.0, 296045.0, 296497.0, 298630.0, 298856.0, 52420.47579524156, 52731.73634131805, 52964.0, 53103.468965310625, 53126.0, 1320.1155225998411, 1354.634248752851, 1358.1647286918671, 1360.6870419803304, 1361.611940596925, 27308.0, 28249.858750706117, 28562.428751425272, 28891.85554072216, 28935.85532072326, 46384.7680761594, 46720.53279467162, 46863.765681171375, 47011.0, 47030.294545582525, 230568.0, 232210.0, 232573.0, 232723.0, 234656.0, 32490.512642310856, 32545.674543254263, 33319.16702082467, 33345.333093338486, 33351.666483334855, 43252.56747432485, 43892.341614876445, 44256.0, 44480.33279500875, 44530.55469445264, 37425.62574374222, 37551.624483754815, 37872.43191352077, 38222.426663599515, 38323.616763832004, 36089.63910360863, 37318.813405933884, 37320.253594928494, 37364.439533406476, 38029.239415210985, 30983.535246970863, 35553.28893422169, 35897.1025724359, 36105.27789444144, 36852.81573592115, 30506.32342139352, 31565.684343156274, 31732.682673173895, 32226.83886580552, 32591.511127333582, 24091.51816963686, 24096.0, 24430.511389772462, 24686.259412217663, 24792.132275370277], "unit": "score", "name": "ext.html", "value": 17400.294007634122}, {"lowerIsBetter": false, "replicates": [357.11791874071037, 359.1309032142214, 360.8394264552274, 366.25284419783645, 368.2303984672035, 16503.339866405346, 16629.41797037104, 17425.0, 17457.912710436445, 17476.650466990654, 16160.191990400492, 16271.0, 16354.0, 16374.590635234124, 16459.0, 5276.973615131928, 5298.4436634153435, 5493.093639549469, 5493.890122197554, 5518.834434966958, 5338.439463856297, 5472.452754724515, 5473.753681084341, 5480.177973303997, 5499.450054994489, 5233.555147812441, 5424.186372044185, 5434.483724046209, 5443.863903402407, 5450.454954504537, 5386.811461598845, 5428.375736790261, 5441.29263195786, 5441.755121019563, 5463.453654634544, 4813.879653008703, 4836.806527738886, 4845.53967373099, 4859.319695242633, 5058.671186372874, 18341.63316733658, 19076.23695052196, 19329.613407731908, 19666.80333196664, 19727.506812329662, 2122.36329101269, 2160.243914629867, 2218.43429925368, 2514.9874250628814, 2625.698044724843, 8916.286697064284, 8972.282217422591, 9393.76515587109, 9434.764130896714, 9444.338896277264, 1845.5847434327304, 1860.6836837737617, 1907.9523011924673, 1909.9045047747695, 1914.2917120665304, 48683.75658121722, 58738.0, 61256.387436125515, 66135.66932165356, 67264.0, 9935.453550054817, 10040.246981476419, 10278.074973252295, 10343.586256549654, 10471.528781204865, 13641.317934103256, 13673.316334183251, 13677.726445471035, 13710.0, 13790.931045344709, 7493.190699877686, 7576.886346704804, 7754.767356979187, 7757.4181936355, 7829.41279404047, 7396.889046664304, 7459.776206713699, 7505.737299194502, 7529.962350188323, 7559.433042521833, 4354.564543545684, 4447.733136011785, 4487.057717879216, 4492.944158122838, 4513.751743654065, 1852.8239817217343, 1853.3605905962422, 1864.3474783825823, 1867.430433717702, 1884.3875740384156, 927.1562877781187, 983.4050399508337, 985.5466485416645, 1008.4907121903392, 1018.6231094494937, 15845.128517931395, 16250.674986500204, 16496.587585310222, 16672.33310667584, 17110.230039648246, 782.3584660578272, 796.1918652567648, 803.9437239393186, 817.7097130518699, 843.8312337532395, 8171.79570510742, 8546.31629469641, 8665.653373864974, 8736.78158046054, 8816.42632107254, 378304.0, 399076.0, 400495.0, 405309.0, 406519.0, 48006.0, 73000.63499682468, 73490.63254683692, 73948.0, 74184.25815741881, 945.7257395355407, 1029.9691009269584, 1040.3601784902382, 1061.2571200159919, 1064.8988346107108, 14328.570142895729, 15121.773173402187, 15409.383624654889, 15537.06777593348, 15679.608009799389, 31049.0, 31853.36293274168, 32638.34723305568, 32927.341453171284, 33013.83493082519, 37225.255494890494, 43477.56522434862, 45280.0, 45741.0, 46136.53863461322, 7851.4111441643245, 7935.1271360149185, 8034.076081250731, 8059.153788852321, 8065.024069103108, 9299.86050209261, 11907.166498345032, 12315.753684926072, 12509.56216532417, 12706.809397859224, 6310.895593271068, 9680.612775488902, 10095.697129086138, 10666.73333166677, 11496.252743571642, 10470.738231544272, 10578.153747700011, 10997.670069897917, 11245.71885702864, 11432.0, 11139.220254582102, 11230.157738169833, 11441.313521188755, 11462.885371146182, 11794.705132371759, 7589.1272503662785, 7851.411144164096, 7852.489588176751, 7902.565358905315, 8169.79575510617, 10449.268551201343, 10835.891641083488, 10891.455427228766, 11131.72170695739, 11167.720806979565], "unit": "score", "name": "jquery.html", "value": 8227.679692863661}, {"lowerIsBetter": false, "replicates": [1447.4933773179384, 1470.9926450367745, 1653.2560347843466, 1817.064211930855, 1817.3639226270798, 6525.216973963119, 7147.89278160828, 7257.5282606630535, 7396.519226250297, 7398.556086634806, 7192.784216473514, 7229.89155162673, 7286.56280623163, 7296.452766042555, 7302.123745150576, 2218.6561083032116, 2231.1744654477866, 2246.2475070851283, 2246.6742322363248, 2248.2580748353084, 2169.4142581502983, 2181.5745929543746, 2211.845170838042, 2218.190360518407, 2228.6434170532716, 2198.6152423325934, 2218.7559368469456, 2218.966715499269, 2225.2434172381386, 2242.7757224277525, 2202.427368884086, 2217.0355895185567, 2220.3782940776446, 2223.3663405929315, 2225.2322948582714, 2192.2875065603585, 2214.1254204589095, 2231.0, 2233.486298151418, 2240.1487434774845, 7357.0803649543805, 7386.0767404074495, 7431.071116110486, 7433.962830185815, 7440.55356678601, 4373.715708478971, 4450.732956022616, 4480.5967462928165, 4485.596296333346, 4499.775011249424, 2826.985865070682, 2974.107767669712, 3006.6241719785025, 3008.7743419243643, 3024.5765592817024, 908.52756566585, 943.2077055273535, 965.3435663748648, 965.4207475514635, 981.018981018981, 9576.329656924088, 9577.952110239405, 9600.135987761136, 9635.421874687541, 9642.132208101304, 4088.1619268049976, 4110.712250142521, 4178.6865985051245, 4183.5398106208295, 4183.853565125206, 8372.958135209406, 8382.706605268786, 8397.496150230883, 8398.202170793766, 8410.411271211078, 4445.066536027406, 4470.463544374696, 4481.977590112028, 4486.237339652267, 4491.169133710208, 3684.1342284563107, 4036.414719865603, 4087.9386809197886, 4103.8974025649595, 4117.464729585135, 3534.3638145134123, 3547.255076433926, 3566.465030245432, 3641.890743277706, 3652.5799533054037, 1174.0431548288118, 1196.216478206776, 1197.0842305636022, 1199.4662375242933, 1204.8252953370568, 1078.3691540448926, 1093.1254996003165, 1228.81567764836, 1264.0772236267392, 1293.0819118425834, 6931.965340173368, 6997.265287144878, 7075.610841403669, 7080.822979425556, 7081.433485321162, 473.26407436435983, 475.7716296177785, 476.5948943398153, 484.27600736898563, 487.2399057470358, 5544.16837474374, 5595.804146854841, 5599.720013999284, 5607.663540187602, 5644.6613203207935, 8048.275655191061, 8153.9184608153155, 8351.08138104808, 8391.706290279812, 8427.241548260687, 8174.83650327002, 8210.055843578066, 8249.175082491704, 8268.09051004389, 8279.54462504556, 6646.933530664728, 6730.831729206809, 6766.7969960901255, 6769.695363708645, 6822.317768223237, 6876.96845473183, 6904.171499420102, 6939.444844412334, 6953.061336719478, 6982.68577913985, 7767.339776119094, 7878.251566101211, 7918.683252669829, 7930.563818990011, 8038.276555110068, 7490.325870671666, 7673.961630191813, 7694.846103078019, 7695.769126926201, 8166.101728809945, 5861.912071319019, 6288.371162883675, 6481.060246264171, 6492.188476440445, 6510.47916166715, 6888.380045795902, 6908.723651054102, 6931.826704332432, 6955.75654852098, 6994.790156295319, 6283.622982621057, 6324.114623952558, 6440.484761218998, 6482.57863238888, 6558.573692709959, 6345.270293916259, 6409.262934762375, 6416.743330266924, 6463.741450341934, 6507.934920650733, 6455.612663240033, 6491.188601424822, 6504.577202481823, 6618.933810661832, 6666.83332916681, 5854.268216472941, 5893.970530147321, 5930.05119180929, 6017.127516510169, 6051.152838602511, 6025.698715064142, 6038.8792224154395, 6062.090686397076, 6067.726952287246, 6076.240469941257], "unit": "score", "name": "mootools.html", "value": 4167.829349927652}, {"lowerIsBetter": false, "replicates": [324.4500571531255, 325.24218570730187, 328.96710328967123, 333.85310463396104, 336.4045639218583, 6241.563090583655, 6250.374962503747, 6265.561410701247, 6304.842378940517, 6360.17317748692, 6191.102290167934, 6216.906746398808, 6217.378262173792, 6233.501319894409, 6239.376062393759, 4590.42619672541, 4681.063787242548, 4704.529547045302, 4732.9763351183365, 4769.737664428464, 4706.10583989041, 4710.97644511777, 4714.622830173595, 4749.90500189996, 4757.286407038937, 4676.48558658549, 4683.274092515666, 4690.64820138491, 4692.991006933508, 4708.458527269357, 4697.741624210684, 4699.38907941967, 4700.55344742249, 4709.882252943669, 4717.646176536739, 4061.208064427438, 4063.227986682521, 4063.6545893599077, 4066.9593304066875, 4072.5723799000975, 5951.0, 5953.255843019622, 5971.373005834368, 5982.0, 5982.132590774313, 5285.86785330366, 5470.370907345667, 5471.261379713727, 5475.0418676731415, 5480.7533660985355, 6559.8032059038305, 6636.203655561315, 6647.169103862017, 6648.401643852028, 6660.0342950272425, 4465.68740188187, 4469.687121901468, 4471.664625153094, 4476.082403107355, 4479.10417916418, 6885.655717214169, 6893.4829887758615, 6952.687129079153, 6954.40887524561, 6974.581525108459, 4545.36364908913, 4547.136044151601, 4557.658175636774, 4559.293309537027, 4559.540946897027, 4430.246858034142, 4582.335561343587, 4585.839495617637, 4594.379758732595, 4610.792514336863, 5401.540869026177, 5407.675539467645, 5423.647462914898, 5468.37113731918, 5483.890322193533, 6671.933280667228, 6681.064650948871, 6710.362515561014, 6727.327267273234, 6734.8653026940165, 1610.6698126883962, 1621.8459246371576, 1627.2270671430977, 1631.0458381846752, 1632.5918520369908, 1007.8538611901233, 1025.487256371814, 1035.782485678001, 1036.1192985962023, 1048.9475526223657, 6226.40849119333, 6242.282137554149, 6270.278917924497, 6291.937080629135, 6322.146510221153, 6832.795016149524, 6863.931360686429, 6891.483138764613, 6892.241853396123, 6918.342757438036, 6128.938710612926, 6252.531060170505, 6385.936140638627, 6408.2630497492455, 6471.932131198394, 3693.612170722089, 3745.756525825813, 3748.981255093707, 3755.399136138205, 3764.378877485239, 7309.5248808827255, 7310.59791711461, 7348.448866335047, 7357.77926662201, 7358.632068396559, 7077.929220707727, 7114.786556403316, 7133.678984445713, 7137.4290056795335, 7138.286171382821, 7091.0, 7312.853742925112, 7324.121105467378, 7332.816679582947, 7336.926630733731, 6878.45234822161, 6894.551854129466, 6925.89611155823, 6929.09449901261, 6944.722211111499, 6799.218089919525, 6861.313868613299, 6884.208316043519, 6885.8967115492305, 6912.585244885323, 7283.271672832886, 7291.562506249642, 7295.306945840137, 7296.19741828409, 7327.450441217036, 4487.08014856947, 4561.224591819465, 4572.771361431982, 4599.080183963154, 4615.330777037378, 6882.793516194522, 6899.758508452381, 6919.169699636076, 6931.584104953517, 6932.584044957319, 6678.799636010733, 6704.363085506869, 6704.899426508508, 6708.731650733916, 6711.966440167768, 6732.596044237362, 6734.696938637871, 6736.629485378156, 6739.59562426256, 6745.988101784772, 6413.807585772434, 6527.184101987252, 6559.8032059038305, 6567.2447668518735, 6572.34276572339, 6691.063251144941, 6728.024436456784, 6730.990351447322, 6779.593224406552, 6784.219814721173, 6572.901406479003, 6585.670716464062, 6590.50571207171, 6604.405603495708, 6624.9337506624315], "unit": "score", "name": "prototype.html", "value": 4974.935589742312}, {"lowerIsBetter": false, "replicates": [771.1594362145261, 805.4925396999889, 807.1824380871259, 816.8971887951262, 830.3896635972559, 13706.725865482684, 13885.4445822167, 13888.861111388884, 13931.094478858893, 13935.0, 13336.599902002956, 13404.396802143903, 13408.396622152002, 13421.261830599313, 13439.0, 821.8150916043887, 828.8963879515061, 833.3041910005153, 835.8411901738681, 839.7019058234331, 841.9326453883705, 843.4517563583659, 844.9281811046069, 847.6270441005969, 850.408965768791, 873.3668090634271, 877.026500584354, 878.802269489363, 880.1242763450376, 884.0275696733606, 872.7599910024699, 873.1007062725339, 873.9825203495958, 875.3522393428881, 876.3996662286354, 645.3481983196958, 648.4099469482795, 648.8864448721455, 649.5712829532486, 649.8375406148463, 14019.789703154462, 14038.92980535101, 14066.437342506288, 14078.788818167735, 14112.082714623619, 12733.363331833463, 12908.290044047573, 12984.350782460933, 13039.674008149777, 13105.2136871788, 10730.141588672888, 10805.243632945698, 10821.513031913582, 10846.29499082565, 10942.726431839188, 3646.453032045188, 3662.157703728131, 3683.9631603684156, 3690.907727306812, 3768.5100936878302, 41971.160576788294, 42124.15751684949, 42334.78832605848, 42578.0, 46197.30704039409, 10281.948590257001, 10290.12533934624, 10373.222008349405, 10459.058684718411, 10471.47642617866, 17813.109344532983, 17819.376321828673, 17851.28594856217, 17926.5518362042, 17955.551111222063, 7580.317771400601, 7621.466497345133, 7673.53958762476, 7680.423968202295, 7898.802529936683, 4161.542230354658, 4331.371951067141, 4345.913081738411, 4347.456567929009, 4407.0, 2943.5290353543332, 2986.910392688223, 2990.7009299070355, 2991.5064014437376, 2991.970080299213, 583.7256489449952, 595.9940400596025, 599.9670018148956, 601.7111786342492, 602.5962605054624, 592.7078967850042, 603.1494503317834, 637.3212528656966, 670.0, 688.9621070841051, 8029.959850200712, 8354.498730076215, 8497.957510212409, 8683.782905427415, 8781.429207101519, 672.825065482978, 694.8783962806489, 707.67093301615, 713.4363852556422, 714.3927661487797, 3788.6021967693546, 3864.8260828262796, 3881.359575669983, 3887.261420330128, 3896.12337224128, 52242.738786305825, 52793.0, 52876.47123528716, 53039.93920121576, 53311.46688533065, 46045.30932036022, 47509.28736068962, 47911.520884791404, 47960.760196199495, 48562.27156592654, 42867.35698964518, 43451.78274108609, 43501.564984350385, 44088.338674919905, 44319.556804432184, 7435.962820185864, 7618.923810762043, 7789.805254868674, 7793.61031948389, 7872.56700881457, 32566.34867302688, 32682.182945426553, 33322.66677333292, 33584.49623255702, 33679.66320336765, 39999.600003999585, 40692.18615627612, 41202.1759564801, 41328.0, 41395.172096558505, 10147.441890696082, 10210.948945255226, 10222.437765922945, 10401.375917444977, 10525.894741052798, 10791.676249712207, 10995.670129896116, 11003.724906877393, 11070.446477676245, 11338.433078345884, 10595.364278143335, 10799.784004319712, 10879.401632910265, 10885.276413749543, 10944.56221751153, 9963.302568820112, 10119.59521619127, 10217.995118255945, 10338.12125969301, 10384.584616615251, 10381.377117372982, 10402.427866467417, 10405.271630985759, 10417.739556511147, 10554.577816887238, 8950.865737013819, 9245.630174792934, 9302.953485232802, 9419.952900235456, 9526.333156678966, 8531.23218910301, 8626.482411055356, 8923.41997770143, 9051.773705657411, 9193.816123677356], "unit": "score", "name": "yui.html", "value": 6196.9339311754}], "name": "dromaeo_css", "value": 6760.5905684101}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 110.0, 113.0, 112.0, 113.0, 124.0, 113.0, 113.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 113.8}, {"lowerIsBetter": true, "replicates": [164.0, 128.0, 159.0, 166.0, 126.0, 153.0, 153.0, 127.0, 169.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 147.6}, {"lowerIsBetter": true, "replicates": [164.0, 164.0, 162.0, 164.0, 162.0, 162.0, 164.0, 164.0, 172.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.1}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 72.0, 73.0, 72.0, 151.0, 74.0, 73.0, 73.0, 73.0], "unit": "score", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 141.0, 96.0, 97.0, 96.0, 143.0, 96.0, 96.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 115.0, 115.0, 115.0, 116.0, 116.0, 115.0, 116.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.0}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 151.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 97.0, 96.0, 97.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 58.0, 57.0, 59.0, 58.0, 58.0, 65.0, 57.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.5}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 72.0, 67.0, 69.0, 67.0, 69.0, 67.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [90.0, 84.0, 84.0, 84.0, 90.0, 83.0, 83.0, 81.0, 85.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [124.0, 119.0, 122.0, 117.0, 130.0, 124.0, 124.0, 123.0, 123.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.8}, {"lowerIsBetter": true, "replicates": [146.0, 160.0, 155.0, 153.0, 144.0, 142.0, 158.0, 151.0, 152.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.3}, {"lowerIsBetter": true, "replicates": [73.0, 69.0, 72.0, 73.0, 71.0, 70.0, 69.0, 69.0, 70.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1530.1}]} 19:04:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1530.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6760.59"}}} 19:04:39 INFO - Return code: 0 19:04:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:04:39 ERROR - # TBPL SUCCESS # 19:04:39 INFO - Running post-action listener: _resource_record_post_action 19:04:39 INFO - Running post-run listener: _resource_record_post_run 19:04:40 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 538845184; Read time: 44; Write time: 612804 19:04:40 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 241102848; Read time: 0; Write time: 349184 19:04:40 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297742336; Read time: 44; Write time: 263620 19:04:40 INFO - Running post-run listener: _upload_blobber_files 19:04:40 INFO - Blob upload gear active. 19:04:40 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:04:40 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 19:04:40 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', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 19:04:40 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 Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 19:04:41 INFO - (blobuploader) - INFO - Open directory for files ... 19:04:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:04:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:04:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:04:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:04:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:04:41 INFO - (blobuploader) - INFO - Done attempting. 19:04:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:04:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:04:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:04:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:04:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:04:42 INFO - (blobuploader) - INFO - Done attempting. 19:04:42 INFO - (blobuploader) - INFO - Iteration through files over. 19:04:42 INFO - Return code: 0 19:04:42 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:04:42 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:04:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a6c329dc0777c2eaf4f64b962a2403c522a1895e8bc1af66f501267fa686ee75cf222db3209ff1144fe1e5924264d8f7697071b262ff60fafca6bdf3c3cd09fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa7f034c2dcb5ff9c60be07035d9f7aadc038c178f461866e14debbd0729d7f0ac14deaee4c4a0abdc188a44bf7a0e3a232ad38e86a23738241326ff1b9e55e6"} 19:04:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:04:42 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:04:42 INFO - Contents: 19:04:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a6c329dc0777c2eaf4f64b962a2403c522a1895e8bc1af66f501267fa686ee75cf222db3209ff1144fe1e5924264d8f7697071b262ff60fafca6bdf3c3cd09fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa7f034c2dcb5ff9c60be07035d9f7aadc038c178f461866e14debbd0729d7f0ac14deaee4c4a0abdc188a44bf7a0e3a232ad38e86a23738241326ff1b9e55e6"} 19:04:42 INFO - Running post-run listener: copy_logs_to_upload_dir 19:04:42 INFO - Copying logs to upload dir... 19:04:42 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:04:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.059884 ========= master_lag: 109.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 17 secs) (at 2016-02-26 19:06:31.657988) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 19:06:31.662187) ========= 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=fa44defc139c4ba8574fe040000001db-1456534520.652117-185683663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a6c329dc0777c2eaf4f64b962a2403c522a1895e8bc1af66f501267fa686ee75cf222db3209ff1144fe1e5924264d8f7697071b262ff60fafca6bdf3c3cd09fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa7f034c2dcb5ff9c60be07035d9f7aadc038c178f461866e14debbd0729d7f0ac14deaee4c4a0abdc188a44bf7a0e3a232ad38e86a23738241326ff1b9e55e6"} build_url:https://queue.taskcluster.net/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011453 build_url: 'https://queue.taskcluster.net/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a6c329dc0777c2eaf4f64b962a2403c522a1895e8bc1af66f501267fa686ee75cf222db3209ff1144fe1e5924264d8f7697071b262ff60fafca6bdf3c3cd09fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa7f034c2dcb5ff9c60be07035d9f7aadc038c178f461866e14debbd0729d7f0ac14deaee4c4a0abdc188a44bf7a0e3a232ad38e86a23738241326ff1b9e55e6"}' ========= master_lag: 0.53 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 19:06:32.207986) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 19:06:32.208344) ========= 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=fa44defc139c4ba8574fe040000001db-1456534520.652117-185683663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002199 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 19:06:32.249597) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 19:06:32.249929) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 19:06:32.262294) ========= ========= Total master_lag: 109.87 =========