builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-024 starttime: 1460339233.41 results: success (0) buildid: 20160410163003 builduid: dcc5ae9ec32a487b9d28b1d4a11c5168 revision: 8803d34bd9f8278b62c542e0ec5446148ce08fe7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.410607) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.411069) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.411401) ========= 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=7cf709767345e0a0c5a90e72000001d4-1460331992.103744-1351850826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006387 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.448747) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.449061) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.490283) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.490575) ========= 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=7cf709767345e0a0c5a90e72000001d4-1460331992.103744-1351850826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.542861) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.543158) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.543583) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.543899) ========= 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=7cf709767345e0a0c5a90e72000001d4-1460331992.103744-1351850826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-10 18:47:14-- 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% 39.3M=0s 2016-04-10 18:47:14 (39.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.155902 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.718867) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.719176) ========= 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=7cf709767345e0a0c5a90e72000001d4-1460331992.103744-1351850826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018968 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.768921) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.769362) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 8803d34bd9f8278b62c542e0ec5446148ce08fe7 --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 8803d34bd9f8278b62c542e0ec5446148ce08fe7 --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=7cf709767345e0a0c5a90e72000001d4-1460331992.103744-1351850826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-10 18:47:14,279 truncating revision to first 12 chars 2016-04-10 18:47:14,279 Setting DEBUG logging. 2016-04-10 18:47:14,279 attempt 1/10 2016-04-10 18:47:14,279 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/8803d34bd9f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-10 18:47:14,956 unpacking tar archive at: mozilla-inbound-8803d34bd9f8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.979902 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:14.761929) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:14.762256) ========= echo 8803d34bd9f8278b62c542e0ec5446148ce08fe7 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8803d34bd9f8278b62c542e0ec5446148ce08fe7'] 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=7cf709767345e0a0c5a90e72000001d4-1460331992.103744-1351850826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 8803d34bd9f8278b62c542e0ec5446148ce08fe7 program finished with exit code 0 elapsedTime=0.004245 script_repo_revision: '8803d34bd9f8278b62c542e0ec5446148ce08fe7' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:14.811973) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:14.812300) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:14.822076) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-10 18:47:14.822447) ========= /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=7cf709767345e0a0c5a90e72000001d4-1460331992.103744-1351850826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:47:15 INFO - MultiFileLogger online at 20160410 18:47:15 in /builds/slave/test-pgo 18:47:15 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:47:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:47:15 INFO - {'append_to_log': False, 18:47:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:47:15 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:47:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:47:15 INFO - 'branch': 'Mozilla-Inbound', 18:47:15 INFO - 'buildbot_json_path': 'buildprops.json', 18:47:15 INFO - 'config_files': ('talos/linux_config.py',), 18:47:15 INFO - 'default_actions': ('clobber', 18:47:15 INFO - 'read-buildbot-config', 18:47:15 INFO - 'download-and-extract', 18:47:15 INFO - 'populate-webroot', 18:47:15 INFO - 'create-virtualenv', 18:47:15 INFO - 'install', 18:47:15 INFO - 'run-tests'), 18:47:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:47:15 INFO - 'download_minidump_stackwalk': True, 18:47:15 INFO - 'download_symbols': 'ondemand', 18:47:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:47:15 INFO - 'tooltool.py': '/tools/tooltool.py', 18:47:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:47:15 INFO - '/tools/misc-python/virtualenv.py')}, 18:47:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:47:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:47:15 INFO - 'installer_path': 'installer.exe', 18:47:15 INFO - 'log_level': 'info', 18:47:15 INFO - 'log_name': 'talos', 18:47:15 INFO - 'log_to_console': True, 18:47:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:47:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:47:15 INFO - 'opt_config_files': (), 18:47:15 INFO - 'pip_index': False, 18:47:15 INFO - 'sps_profile': False, 18:47:15 INFO - 'sps_profile_interval': 0, 18:47:15 INFO - 'suite': 'dromaeojs-e10s', 18:47:15 INFO - 'system_bits': '32', 18:47:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:47:15 INFO - 'title': 'talos-linux64-ix-024', 18:47:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:47:15 INFO - 'use_talos_json': True, 18:47:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:47:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:47:15 INFO - 'work_dir': 'build'} 18:47:15 INFO - ##### 18:47:15 INFO - ##### Running clobber step. 18:47:15 INFO - ##### 18:47:15 INFO - Running pre-action listener: _resource_record_pre_action 18:47:15 INFO - Running main action method: clobber 18:47:15 INFO - rmtree: /builds/slave/test-pgo/build 18:47:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:47:16 INFO - Running post-action listener: _resource_record_post_action 18:47:16 INFO - ##### 18:47:16 INFO - ##### Running read-buildbot-config step. 18:47:16 INFO - ##### 18:47:16 INFO - Running pre-action listener: _resource_record_pre_action 18:47:16 INFO - Running main action method: read_buildbot_config 18:47:16 INFO - Using buildbot properties: 18:47:16 INFO - { 18:47:16 INFO - "project": "", 18:47:16 INFO - "product": "firefox", 18:47:16 INFO - "script_repo_revision": "production", 18:47:16 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 18:47:16 INFO - "repository": "", 18:47:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 18:47:16 INFO - "buildid": "20160410163003", 18:47:16 INFO - "pgo_build": "True", 18:47:16 INFO - "basedir": "/builds/slave/test-pgo", 18:47:16 INFO - "buildnumber": 466, 18:47:16 INFO - "slavename": "talos-linux64-ix-024", 18:47:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:47:16 INFO - "platform": "ubuntu64_hw", 18:47:16 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 18:47:16 INFO - "branch": "mozilla-inbound", 18:47:16 INFO - "repo_path": "integration/mozilla-inbound", 18:47:16 INFO - "revision": "8803d34bd9f8278b62c542e0ec5446148ce08fe7", 18:47:16 INFO - "stage_platform": "linux64-pgo", 18:47:16 INFO - "builduid": "dcc5ae9ec32a487b9d28b1d4a11c5168", 18:47:16 INFO - "slavebuilddir": "test" 18:47:16 INFO - } 18:47:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 18:47:16 INFO - Running post-action listener: _resource_record_post_action 18:47:16 INFO - ##### 18:47:16 INFO - ##### Running download-and-extract step. 18:47:16 INFO - ##### 18:47:16 INFO - Running pre-action listener: _resource_record_pre_action 18:47:16 INFO - Running main action method: download_and_extract 18:47:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:47:16 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:47:16 INFO - https://queue.taskcluster.net/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:47:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:47:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:47:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:47:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:47:25 INFO - Downloaded 1361 bytes. 18:47:25 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:47:25 INFO - Using the following test package requirements: 18:47:25 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:47:25 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:47:25 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:47:25 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:25 INFO - u'jsshell-linux-x86_64.zip'], 18:47:25 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:47:25 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:47:25 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:47:25 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:47:25 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:47:25 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:47:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:47:25 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:47:25 INFO - https://queue.taskcluster.net/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:47:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:47:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:47:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:47:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:47:36 INFO - Downloaded 23762467 bytes. 18:47:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:47:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:47:37 INFO - Return code: 0 18:47:37 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:47: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:47:37 INFO - https://queue.taskcluster.net/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:47:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:47:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:47:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:47:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:47:38 INFO - Downloaded 23762467 bytes. 18:47:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:47:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:47:40 INFO - Return code: 0 18:47: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:47:40 INFO - https://queue.taskcluster.net/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:47:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:47:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:47:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:47:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:47:41 INFO - Downloaded 10841046 bytes. 18:47:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:47:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 18:47:41 INFO - Return code: 0 18:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:41 INFO - https://queue.taskcluster.net/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:47:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:47:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:47:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:47:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:47:44 INFO - Downloaded 57786549 bytes. 18:47:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:47:44 INFO - mkdir: /builds/slave/test-pgo/properties 18:47:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:47:44 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:47:44 INFO - Contents: 18:47:44 INFO - build_url:https://queue.taskcluster.net/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:47:45 INFO - Running post-action listener: _resource_record_post_action 18:47:45 INFO - Running post-action listener: set_extra_try_arguments 18:47:45 INFO - ##### 18:47:45 INFO - ##### Running populate-webroot step. 18:47:45 INFO - ##### 18:47:45 INFO - Running pre-action listener: _resource_record_pre_action 18:47:45 INFO - Running main action method: populate_webroot 18:47:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:47:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:47:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:47:45 INFO - '--tppagecycles', 18:47:45 INFO - '7'], 18:47:45 INFO - 'tests': ['tsvgm']}}, 18:47:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:47:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:47:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:47:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:47:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:47:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:47:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:45 INFO - 'talos_options': ['--disable-e10s'], 18:47:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:47:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:47:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:45 INFO - 'talos_options': ['--disable-e10s'], 18:47:45 INFO - 'tests': ['damp', 'tps']}, 18:47:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:45 INFO - 'tests': ['damp', 'tps']}, 18:47:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:47:45 INFO - 'tests': ['dromaeo_dom']}, 18:47:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:47:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:47:45 INFO - 'tests': ['a11yr', 18:47:45 INFO - 'ts_paint', 18:47:45 INFO - 'tpaint', 18:47:45 INFO - 'sessionrestore', 18:47:45 INFO - 'sessionrestore_no_auto_restore', 18:47:45 INFO - 'tabpaint']}, 18:47:45 INFO - 'other-e10s': {'tests': ['a11yr', 18:47:45 INFO - 'ts_paint', 18:47:45 INFO - 'tpaint', 18:47:45 INFO - 'sessionrestore', 18:47:45 INFO - 'sessionrestore_no_auto_restore', 18:47:45 INFO - 'tabpaint']}, 18:47:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:47:45 INFO - 'ts_paint', 18:47:45 INFO - 'tpaint', 18:47:45 INFO - 'sessionrestore', 18:47:45 INFO - 'sessionrestore_no_auto_restore', 18:47:45 INFO - 'tabpaint']}, 18:47:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:47:45 INFO - 'ts_paint', 18:47:45 INFO - 'tpaint', 18:47:45 INFO - 'sessionrestore', 18:47:45 INFO - 'sessionrestore_no_auto_restore', 18:47:45 INFO - 'tabpaint']}, 18:47:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:47:45 INFO - 'tests': ['a11yr', 18:47:45 INFO - 'ts_paint', 18:47:45 INFO - 'tpaint', 18:47:45 INFO - 'sessionrestore', 18:47:45 INFO - 'sessionrestore_no_auto_restore', 18:47:45 INFO - 'tabpaint']}, 18:47:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:47:45 INFO - 'tests': ['a11yr', 18:47:45 INFO - 'ts_paint', 18:47:45 INFO - 'tpaint', 18:47:45 INFO - 'sessionrestore', 18:47:45 INFO - 'sessionrestore_no_auto_restore', 18:47:45 INFO - 'tabpaint']}, 18:47:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:47:45 INFO - 'tests': ['tsvgx', 18:47:45 INFO - 'tsvgr_opacity', 18:47:45 INFO - 'tart', 18:47:45 INFO - 'tscrollx', 18:47:45 INFO - 'cart']}, 18:47:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:47:45 INFO - 'tsvgr_opacity', 18:47:45 INFO - 'tart', 18:47:45 INFO - 'tscrollx', 18:47:45 INFO - 'cart']}, 18:47:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:45 INFO - 'talos_options': ['--disable-e10s'], 18:47:45 INFO - 'tests': ['tp5o']}, 18:47:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:45 INFO - 'tests': ['tp5o']}, 18:47:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:45 INFO - 'talos_options': ['--disable-e10s', 18:47:45 INFO - '--xperf_path', 18:47:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:47:45 INFO - 'tests': ['tp5n']}, 18:47:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:45 INFO - 'talos_options': ['--xperf_path', 18:47:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:47:45 INFO - 'tests': ['tp5n']}}, 18:47:45 INFO - 'talos.zip': {'path': '', 18:47:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:47:45 INFO - Running post-action listener: _resource_record_post_action 18:47:45 INFO - ##### 18:47:45 INFO - ##### Running create-virtualenv step. 18:47:45 INFO - ##### 18:47:45 INFO - Running pre-action listener: _resource_record_pre_action 18:47:45 INFO - Running main action method: create_virtualenv 18:47:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:47:45 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:47:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:47:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:47:45 INFO - Using real prefix '/usr' 18:47:45 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:47:46 INFO - Installing distribute.............................................................................................................................................................................................done. 18:47:48 INFO - Installing pip.................done. 18:47:48 INFO - Return code: 0 18:47:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:48 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 0x7f0639dd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c08d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8b0>, '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 0x23507b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2350c60>, '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': '7cf709767345e0a0c5a90e72000001d4-1460331992.103744-1351850826', '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:47:48 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:47:48 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:47:48 INFO - Using env: {'DISPLAY': ':0', 18:47:48 INFO - 'HOME': '/home/cltbld', 18:47:48 INFO - 'LANG': 'en_US.UTF-8', 18:47:48 INFO - 'LANGUAGE': 'en_US:en', 18:47:48 INFO - 'LOGNAME': 'cltbld', 18:47:48 INFO - 'MAIL': '/var/mail/cltbld', 18:47:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:48 INFO - 'MOZ_NO_REMOTE': '1', 18:47:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:48 INFO - 'NO_EM_RESTART': '1', 18:47:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:48 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:48 INFO - 'SHELL': '/bin/bash', 18:47:48 INFO - 'SHLVL': '1', 18:47:48 INFO - 'TERM': 'linux', 18:47:48 INFO - 'TMOUT': '86400', 18:47:48 INFO - 'USER': 'cltbld', 18:47:48 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1460331992.103744-1351850826', 18:47:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:48 INFO - '_': '/tools/buildbot/bin/python'} 18:47:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:48 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:47:48 INFO - Cleaning up... 18:47:48 INFO - Return code: 0 18:47:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:48 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 0x7f0639dd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c08d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8b0>, '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 0x23507b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2350c60>, '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': '7cf709767345e0a0c5a90e72000001d4-1460331992.103744-1351850826', '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:47:48 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:47:48 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:47:48 INFO - Using env: {'DISPLAY': ':0', 18:47:48 INFO - 'HOME': '/home/cltbld', 18:47:48 INFO - 'LANG': 'en_US.UTF-8', 18:47:48 INFO - 'LANGUAGE': 'en_US:en', 18:47:48 INFO - 'LOGNAME': 'cltbld', 18:47:48 INFO - 'MAIL': '/var/mail/cltbld', 18:47:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:48 INFO - 'MOZ_NO_REMOTE': '1', 18:47:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:48 INFO - 'NO_EM_RESTART': '1', 18:47:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:48 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:48 INFO - 'SHELL': '/bin/bash', 18:47:48 INFO - 'SHLVL': '1', 18:47:48 INFO - 'TERM': 'linux', 18:47:48 INFO - 'TMOUT': '86400', 18:47:48 INFO - 'USER': 'cltbld', 18:47:48 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1460331992.103744-1351850826', 18:47:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:48 INFO - '_': '/tools/buildbot/bin/python'} 18:47:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:48 INFO - Downloading/unpacking psutil>=0.7.1 18:47: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:47: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:47: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:47: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:47: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:47: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:47:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:47:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:47:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:47:50 INFO - Installing collected packages: psutil 18:47:50 INFO - Running setup.py install for psutil 18:47:50 INFO - building 'psutil._psutil_linux' extension 18:47:50 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:47:51 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:47:51 INFO - building 'psutil._psutil_posix' extension 18:47:51 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:47:51 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:47:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:47:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:47:51 INFO - Successfully installed psutil 18:47:51 INFO - Cleaning up... 18:47:51 INFO - Return code: 0 18:47:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:51 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 0x7f0639dd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c08d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8b0>, '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 0x23507b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2350c60>, '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': '7cf709767345e0a0c5a90e72000001d4-1460331992.103744-1351850826', '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:47:51 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:47:51 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:47:51 INFO - Using env: {'DISPLAY': ':0', 18:47:51 INFO - 'HOME': '/home/cltbld', 18:47:51 INFO - 'LANG': 'en_US.UTF-8', 18:47:51 INFO - 'LANGUAGE': 'en_US:en', 18:47:51 INFO - 'LOGNAME': 'cltbld', 18:47:51 INFO - 'MAIL': '/var/mail/cltbld', 18:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:51 INFO - 'MOZ_NO_REMOTE': '1', 18:47:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:51 INFO - 'NO_EM_RESTART': '1', 18:47:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:51 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:51 INFO - 'SHELL': '/bin/bash', 18:47:51 INFO - 'SHLVL': '1', 18:47:51 INFO - 'TERM': 'linux', 18:47:51 INFO - 'TMOUT': '86400', 18:47:51 INFO - 'USER': 'cltbld', 18:47:51 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1460331992.103744-1351850826', 18:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:51 INFO - '_': '/tools/buildbot/bin/python'} 18:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:47:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:47:53 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:47:53 INFO - Installing collected packages: mozsystemmonitor 18:47:53 INFO - Running setup.py install for mozsystemmonitor 18:47:53 INFO - Successfully installed mozsystemmonitor 18:47:53 INFO - Cleaning up... 18:47:53 INFO - Return code: 0 18:47:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:47:53 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:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:53 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:47:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:53 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 0x7f0639dd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c08d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8b0>, '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 0x23507b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2350c60>, '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': '7cf709767345e0a0c5a90e72000001d4-1460331992.103744-1351850826', '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:47:53 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:47:53 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:47:53 INFO - Using env: {'DISPLAY': ':0', 18:47:53 INFO - 'HOME': '/home/cltbld', 18:47:53 INFO - 'LANG': 'en_US.UTF-8', 18:47:53 INFO - 'LANGUAGE': 'en_US:en', 18:47:53 INFO - 'LOGNAME': 'cltbld', 18:47:53 INFO - 'MAIL': '/var/mail/cltbld', 18:47:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:53 INFO - 'MOZ_NO_REMOTE': '1', 18:47:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:53 INFO - 'NO_EM_RESTART': '1', 18:47:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:53 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:53 INFO - 'SHELL': '/bin/bash', 18:47:53 INFO - 'SHLVL': '1', 18:47:53 INFO - 'TERM': 'linux', 18:47:53 INFO - 'TMOUT': '86400', 18:47:53 INFO - 'USER': 'cltbld', 18:47:53 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1460331992.103744-1351850826', 18:47:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:53 INFO - '_': '/tools/buildbot/bin/python'} 18:47:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:53 INFO - Downloading/unpacking blobuploader==1.2.4 18:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:55 INFO - Downloading blobuploader-1.2.4.tar.gz 18:47:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:47:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:47:55 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:47:55 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:47:55 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:47:55 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:47:55 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:47:55 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:47:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:47:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:56 INFO - Downloading docopt-0.6.1.tar.gz 18:47:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:47:56 INFO - Installing collected packages: blobuploader, requests, docopt 18:47:56 INFO - Running setup.py install for blobuploader 18:47:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:47:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:47:56 INFO - Running setup.py install for requests 18:47:56 INFO - Running setup.py install for docopt 18:47:57 INFO - Successfully installed blobuploader requests docopt 18:47:57 INFO - Cleaning up... 18:47:57 INFO - Return code: 0 18:47:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:47:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:57 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 0x7f0639dd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c08d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8b0>, '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 0x23507b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2350c60>, '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': '7cf709767345e0a0c5a90e72000001d4-1460331992.103744-1351850826', '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:47:57 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:47:57 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:47:57 INFO - Using env: {'DISPLAY': ':0', 18:47:57 INFO - 'HOME': '/home/cltbld', 18:47:57 INFO - 'LANG': 'en_US.UTF-8', 18:47:57 INFO - 'LANGUAGE': 'en_US:en', 18:47:57 INFO - 'LOGNAME': 'cltbld', 18:47:57 INFO - 'MAIL': '/var/mail/cltbld', 18:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:57 INFO - 'MOZ_NO_REMOTE': '1', 18:47:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:57 INFO - 'NO_EM_RESTART': '1', 18:47:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:57 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:57 INFO - 'SHELL': '/bin/bash', 18:47:57 INFO - 'SHLVL': '1', 18:47:57 INFO - 'TERM': 'linux', 18:47:57 INFO - 'TMOUT': '86400', 18:47:57 INFO - 'USER': 'cltbld', 18:47:57 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1460331992.103744-1351850826', 18:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:57 INFO - '_': '/tools/buildbot/bin/python'} 18:47:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:47:57 INFO - Running setup.py (path:/tmp/pip-8JW1ly-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:47:57 INFO - Running setup.py (path:/tmp/pip-fTeKxn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:47:57 INFO - Running setup.py (path:/tmp/pip-InrKbv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:47:57 INFO - Running setup.py (path:/tmp/pip-ohyCEN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:47:57 INFO - Running setup.py (path:/tmp/pip-DTbZXR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:47:57 INFO - Running setup.py (path:/tmp/pip-vi5YAp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:47:57 INFO - Running setup.py (path:/tmp/pip-Ft2Frs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:47:57 INFO - Running setup.py (path:/tmp/pip-VchfkN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:47:57 INFO - Running setup.py (path:/tmp/pip-23sJyu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:47:57 INFO - Running setup.py (path:/tmp/pip-7RdvBz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:47:58 INFO - Running setup.py (path:/tmp/pip-zeIa4H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:47:58 INFO - Running setup.py (path:/tmp/pip-3J8y6W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:47:58 INFO - Running setup.py (path:/tmp/pip-Sm4XxV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:47:58 INFO - Running setup.py (path:/tmp/pip-d8f8jJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:47:58 INFO - Running setup.py (path:/tmp/pip-e4DMLC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:47:58 INFO - Running setup.py (path:/tmp/pip-fQddLa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:47:58 INFO - Running setup.py (path:/tmp/pip-z0yFnN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:47:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:47:58 INFO - Running setup.py install for manifestparser 18:47:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:47:58 INFO - Running setup.py install for mozcrash 18:47:58 INFO - Running setup.py install for mozdebug 18:47:58 INFO - Running setup.py install for mozdevice 18:47:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:47:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:47:59 INFO - Running setup.py install for mozfile 18:47:59 INFO - Running setup.py install for mozhttpd 18:47:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:47:59 INFO - Running setup.py install for mozinfo 18:47:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:47:59 INFO - Running setup.py install for mozInstall 18:47:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:47:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:47:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:47:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:47:59 INFO - Running setup.py install for mozleak 18:47:59 INFO - Running setup.py install for mozlog 18:47:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:47:59 INFO - Running setup.py install for moznetwork 18:47:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:47:59 INFO - Running setup.py install for mozprocess 18:47:59 INFO - Running setup.py install for mozprofile 18:47:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:47:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:47:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:47:59 INFO - Running setup.py install for mozrunner 18:48:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:48:00 INFO - Running setup.py install for mozscreenshot 18:48:00 INFO - Running setup.py install for moztest 18:48:00 INFO - Running setup.py install for mozversion 18:48:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:48:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:48:00 INFO - Cleaning up... 18:48:00 INFO - Return code: 0 18:48:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:00 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 0x7f0639dd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c08d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8b0>, '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 0x23507b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2350c60>, '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': '7cf709767345e0a0c5a90e72000001d4-1460331992.103744-1351850826', '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:48:00 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:48:00 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:48:00 INFO - Using env: {'DISPLAY': ':0', 18:48:00 INFO - 'HOME': '/home/cltbld', 18:48:00 INFO - 'LANG': 'en_US.UTF-8', 18:48:00 INFO - 'LANGUAGE': 'en_US:en', 18:48:00 INFO - 'LOGNAME': 'cltbld', 18:48:00 INFO - 'MAIL': '/var/mail/cltbld', 18:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:00 INFO - 'MOZ_NO_REMOTE': '1', 18:48:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:00 INFO - 'NO_EM_RESTART': '1', 18:48:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:48:00 INFO - 'PWD': '/builds/slave/test-pgo', 18:48:00 INFO - 'SHELL': '/bin/bash', 18:48:00 INFO - 'SHLVL': '1', 18:48:00 INFO - 'TERM': 'linux', 18:48:00 INFO - 'TMOUT': '86400', 18:48:00 INFO - 'USER': 'cltbld', 18:48:00 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1460331992.103744-1351850826', 18:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:00 INFO - '_': '/tools/buildbot/bin/python'} 18:48:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:48:00 INFO - Running setup.py (path:/tmp/pip-zWruhV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:48:00 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:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:48:00 INFO - Running setup.py (path:/tmp/pip-AT8O0M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:48:00 INFO - Running setup.py (path:/tmp/pip-VpNUkA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:48:00 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:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:48:00 INFO - Running setup.py (path:/tmp/pip-RViXBX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:48:00 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:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:48:00 INFO - Running setup.py (path:/tmp/pip-Q53tMY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:48:00 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:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:48:00 INFO - Running setup.py (path:/tmp/pip-qUGyP2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 18:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:48:01 INFO - Running setup.py (path:/tmp/pip-0Oaqgc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:48:01 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:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:48:01 INFO - Running setup.py (path:/tmp/pip-yOGowm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:48:01 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:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:48:01 INFO - Running setup.py (path:/tmp/pip-LpFGet-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:48:01 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:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:48:01 INFO - Running setup.py (path:/tmp/pip-YtdHSg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:48:01 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:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:48:01 INFO - Running setup.py (path:/tmp/pip-Ifpevf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:48:01 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:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:48:01 INFO - Running setup.py (path:/tmp/pip-v2wv_g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:48:01 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:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:48:01 INFO - Running setup.py (path:/tmp/pip-zzmrOs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:48:01 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:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:48:01 INFO - Running setup.py (path:/tmp/pip-oQxtqv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:48:01 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:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:48:01 INFO - Running setup.py (path:/tmp/pip-pzYDuE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:48:01 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:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:48:01 INFO - Running setup.py (path:/tmp/pip-zv6ZB7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:48:01 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:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:48:01 INFO - Running setup.py (path:/tmp/pip-3ewu1U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:48:01 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:48:01 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:48:01 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:48:01 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:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:48:01 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:48:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:03 INFO - Downloading blessings-1.6.tar.gz 18:48:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:48:03 INFO - Installing collected packages: blessings 18:48:03 INFO - Running setup.py install for blessings 18:48:03 INFO - Successfully installed blessings 18:48:03 INFO - Cleaning up... 18:48:03 INFO - Return code: 0 18:48:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:48:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:48:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:48:04 INFO - Reading from file tmpfile_stdout 18:48:04 INFO - Current package versions: 18:48:04 INFO - argparse == 1.2.1 18:48:04 INFO - blessings == 1.6 18:48:04 INFO - blobuploader == 1.2.4 18:48:04 INFO - docopt == 0.6.1 18:48:04 INFO - manifestparser == 1.1 18:48:04 INFO - mozInstall == 1.12 18:48:04 INFO - mozcrash == 0.17 18:48:04 INFO - mozdebug == 0.1 18:48:04 INFO - mozdevice == 0.48 18:48:04 INFO - mozfile == 1.2 18:48:04 INFO - mozhttpd == 0.7 18:48:04 INFO - mozinfo == 0.9 18:48:04 INFO - mozleak == 0.1 18:48:04 INFO - mozlog == 3.1 18:48:04 INFO - moznetwork == 0.27 18:48:04 INFO - mozprocess == 0.22 18:48:04 INFO - mozprofile == 0.28 18:48:04 INFO - mozrunner == 6.11 18:48:04 INFO - mozscreenshot == 0.1 18:48:04 INFO - mozsystemmonitor == 0.0 18:48:04 INFO - moztest == 0.7 18:48:04 INFO - mozversion == 1.4 18:48:04 INFO - psutil == 3.1.1 18:48:04 INFO - requests == 1.2.3 18:48:04 INFO - wsgiref == 0.1.2 18:48:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0639dd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c08d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8b0>, '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 0x23507b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2350c60>, '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': '7cf709767345e0a0c5a90e72000001d4-1460331992.103744-1351850826', '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:48:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 18:48:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:48:04 INFO - Using env: {'DISPLAY': ':0', 18:48:04 INFO - 'HOME': '/home/cltbld', 18:48:04 INFO - 'LANG': 'en_US.UTF-8', 18:48:04 INFO - 'LANGUAGE': 'en_US:en', 18:48:04 INFO - 'LOGNAME': 'cltbld', 18:48:04 INFO - 'MAIL': '/var/mail/cltbld', 18:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:04 INFO - 'MOZ_NO_REMOTE': '1', 18:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:04 INFO - 'NO_EM_RESTART': '1', 18:48:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:48:04 INFO - 'PWD': '/builds/slave/test-pgo', 18:48:04 INFO - 'SHELL': '/bin/bash', 18:48:04 INFO - 'SHLVL': '1', 18:48:04 INFO - 'TERM': 'linux', 18:48:04 INFO - 'TMOUT': '86400', 18:48:04 INFO - 'USER': 'cltbld', 18:48:04 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1460331992.103744-1351850826', 18:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:04 INFO - '_': '/tools/buildbot/bin/python'} 18:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:04 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:48:04 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:48:04 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:48:04 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:48:04 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:48:04 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:48:04 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:48:04 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:48:04 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:48:04 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:48:04 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:48:04 INFO - Cleaning up... 18:48:04 INFO - Return code: 0 18:48:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:04 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 0x7f0639dd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c08d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8b0>, '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 0x23507b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2350c60>, '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': '7cf709767345e0a0c5a90e72000001d4-1460331992.103744-1351850826', '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:48:04 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:48:04 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:48:04 INFO - Using env: {'DISPLAY': ':0', 18:48:04 INFO - 'HOME': '/home/cltbld', 18:48:04 INFO - 'LANG': 'en_US.UTF-8', 18:48:04 INFO - 'LANGUAGE': 'en_US:en', 18:48:04 INFO - 'LOGNAME': 'cltbld', 18:48:04 INFO - 'MAIL': '/var/mail/cltbld', 18:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:04 INFO - 'MOZ_NO_REMOTE': '1', 18:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:04 INFO - 'NO_EM_RESTART': '1', 18:48:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:48:04 INFO - 'PWD': '/builds/slave/test-pgo', 18:48:04 INFO - 'SHELL': '/bin/bash', 18:48:04 INFO - 'SHLVL': '1', 18:48:04 INFO - 'TERM': 'linux', 18:48:04 INFO - 'TMOUT': '86400', 18:48:04 INFO - 'USER': 'cltbld', 18:48:04 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1460331992.103744-1351850826', 18:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:04 INFO - '_': '/tools/buildbot/bin/python'} 18:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:04 INFO - Downloading/unpacking jsonschema 18:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:48:06 INFO - Downloading/unpacking functools32 (from jsonschema) 18:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:06 INFO - Downloading functools32-3.2.3-2.tar.gz 18:48:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:48:06 INFO - warning: no files found matching '*.txt' 18:48:06 INFO - no previously-included directories found matching 'build' 18:48:06 INFO - no previously-included directories found matching 'dist' 18:48:06 INFO - no previously-included directories found matching '.git*' 18:48:06 INFO - Installing collected packages: jsonschema, functools32 18:48:06 INFO - Running setup.py install for functools32 18:48:06 INFO - warning: no files found matching '*.txt' 18:48:06 INFO - no previously-included directories found matching 'build' 18:48:06 INFO - no previously-included directories found matching 'dist' 18:48:06 INFO - no previously-included directories found matching '.git*' 18:48:06 INFO - Successfully installed jsonschema functools32 18:48:06 INFO - Cleaning up... 18:48:06 INFO - Return code: 0 18:48:06 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:48: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:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48: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:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:06 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 0x7f0639dd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c08d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8b0>, '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 0x23507b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2350c60>, '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': '7cf709767345e0a0c5a90e72000001d4-1460331992.103744-1351850826', '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:48:06 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:48:06 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:48:06 INFO - Using env: {'DISPLAY': ':0', 18:48:06 INFO - 'HOME': '/home/cltbld', 18:48:06 INFO - 'LANG': 'en_US.UTF-8', 18:48:06 INFO - 'LANGUAGE': 'en_US:en', 18:48:06 INFO - 'LOGNAME': 'cltbld', 18:48:06 INFO - 'MAIL': '/var/mail/cltbld', 18:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:06 INFO - 'MOZ_NO_REMOTE': '1', 18:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:06 INFO - 'NO_EM_RESTART': '1', 18:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:48:06 INFO - 'PWD': '/builds/slave/test-pgo', 18:48:06 INFO - 'SHELL': '/bin/bash', 18:48:06 INFO - 'SHLVL': '1', 18:48:06 INFO - 'TERM': 'linux', 18:48:06 INFO - 'TMOUT': '86400', 18:48:06 INFO - 'USER': 'cltbld', 18:48:06 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1460331992.103744-1351850826', 18:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:06 INFO - '_': '/tools/buildbot/bin/python'} 18:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:07 INFO - Downloading/unpacking flake8 18:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:48:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:48:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:48:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:48:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:48:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:48:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:48:09 INFO - no previously-included directories found matching 'docs/_build' 18:48:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:48:10 INFO - Running setup.py install for pep8 18:48:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:48:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:48:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:48:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:48:10 INFO - no previously-included directories found matching 'docs/_build' 18:48:10 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:48:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:48:10 INFO - Cleaning up... 18:48:10 INFO - Return code: 0 18:48:10 INFO - Running post-action listener: _resource_record_post_action 18:48:10 INFO - Running post-action listener: _start_resource_monitoring 18:48:10 INFO - Starting resource monitoring. 18:48:10 INFO - ##### 18:48:10 INFO - ##### Running install step. 18:48:10 INFO - ##### 18:48:10 INFO - Running pre-action listener: _resource_record_pre_action 18:48:10 INFO - Running main action method: install 18:48:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:48:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:48:10 INFO - Reading from file tmpfile_stdout 18:48:10 INFO - Detecting whether we're running mozinstall >=1.0... 18:48:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:48:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:48:10 INFO - Reading from file tmpfile_stdout 18:48:10 INFO - Output received: 18:48:10 INFO - Usage: mozinstall [options] installer 18:48:10 INFO - Options: 18:48:10 INFO - -h, --help show this help message and exit 18:48:10 INFO - -d DEST, --destination=DEST 18:48:10 INFO - Directory to install application into. [default: 18:48:10 INFO - "/builds/slave/test-pgo"] 18:48:10 INFO - --app=APP Application being installed. [default: firefox] 18:48:10 INFO - mkdir: /builds/slave/test-pgo/build/application 18:48:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 18:48:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 18:48:26 INFO - Reading from file tmpfile_stdout 18:48:26 INFO - Output received: 18:48:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:48:26 INFO - Running post-action listener: _resource_record_post_action 18:48:26 INFO - ##### 18:48:26 INFO - ##### Running run-tests step. 18:48:26 INFO - ##### 18:48:26 INFO - Running pre-action listener: _resource_record_pre_action 18:48:26 INFO - Running main action method: run_tests 18:48:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:48:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:48:26 INFO - Python 2.7.3 18:48:26 INFO - Return code: 0 18:48:26 INFO - grabbing minidump binary from tooltool 18:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:26 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8b0>, '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 0x23507b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2350c60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:48:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 18:48:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:48:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:48:27 INFO - Return code: 0 18:48:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:48:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:48:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:48:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:48:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:48:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:48:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:48:28 INFO - Return code: 0 18:48:28 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/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 18:48:28 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/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:48:28 INFO - Using env: {'DISPLAY': ':0', 18:48:28 INFO - 'HOME': '/home/cltbld', 18:48:28 INFO - 'LANG': 'en_US.UTF-8', 18:48:28 INFO - 'LANGUAGE': 'en_US:en', 18:48:28 INFO - 'LOGNAME': 'cltbld', 18:48:28 INFO - 'MAIL': '/var/mail/cltbld', 18:48:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:48:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:48:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:28 INFO - 'MOZ_NO_REMOTE': '1', 18:48:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:48:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:28 INFO - 'NO_EM_RESTART': '1', 18:48:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:48:28 INFO - 'PWD': '/builds/slave/test-pgo', 18:48:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:48:28 INFO - 'SHELL': '/bin/bash', 18:48:28 INFO - 'SHLVL': '1', 18:48:28 INFO - 'TERM': 'linux', 18:48:28 INFO - 'TMOUT': '86400', 18:48:28 INFO - 'USER': 'cltbld', 18:48:28 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1460331992.103744-1351850826', 18:48:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:28 INFO - '_': '/tools/buildbot/bin/python'} 18:48:28 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/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:48:28 INFO - mozversion application_buildid: 20160410163003 18:48:28 INFO - mozversion application_changeset: 8803d34bd9f8278b62c542e0ec5446148ce08fe7 18:48:28 INFO - mozversion application_display_name: Nightly 18:48:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:48:28 INFO - mozversion application_name: Firefox 18:48:28 INFO - mozversion application_remotingname: firefox 18:48:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:48:28 INFO - mozversion application_vendor: Mozilla 18:48:28 INFO - mozversion application_version: 48.0a1 18:48:28 INFO - mozversion platform_buildid: 20160410163003 18:48:28 INFO - mozversion platform_changeset: 8803d34bd9f8278b62c542e0ec5446148ce08fe7 18:48:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:48:28 INFO - mozversion platform_version: 48.0a1 18:48:28 INFO - using testdate: 1460339308 18:48:28 INFO - actual date: 1460339308 18:48:28 INFO - starting webserver on 'localhost:59803' 18:48:28 INFO - SUITE-START | Running 2 tests 18:48:28 INFO - TEST-START | dromaeo_css 18:48:28 INFO - operating with platform_type : linux_ 18:48:28 INFO - Initialising browser for dromaeo_css test... 18:48:28 INFO - TEST-INFO | started process 6234 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnouSlx/profile http://localhost:59803/getInfo.html) 18:48:32 INFO - PROCESS | 6234 | 18:48:32 INFO - PROCESS | 6234 | (process:6304): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:48:32 INFO - PROCESS | 6234 | JavaScript error: jar:file:///builds/slave/test-pgo/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 18:48:32 INFO - PROCESS | 6234 | __metrics Screen width/height:1600/1200 18:48:32 INFO - PROCESS | 6234 | colorDepth:24 18:48:32 INFO - PROCESS | 6234 | Browser inner width/height: 1024/697 18:48:32 INFO - PROCESS | 6234 | __metrics 18:48:33 ERROR - PROCESS | 6234 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 18:48:34 INFO - TEST-INFO | 6234: exit 0 18:48:34 INFO - Browser initialized. 18:48:34 INFO - Running cycle 1/1 for dromaeo_css test... 18:48:34 INFO - TEST-INFO | started process 6355 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnouSlx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:48:36 INFO - PROCESS | 6355 | 18:48:36 INFO - PROCESS | 6355 | (process:6415): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:48:46 INFO - PROCESS | 6355 | RSS: Main: 163463168 18:48:46 INFO - PROCESS | 6355 | 18:49:35 INFO - PROCESS | 6355 | 1460339375847 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:51:43 INFO - PROCESS | 6355 | Cycle 1(1): loaded http://localhost:59803/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59803/tests/dromaeo/cssquery-ext.html) 18:51:44 INFO - PROCESS | 6355 | RSS: Main: 166785024 18:51:44 INFO - PROCESS | 6355 | 18:54:46 INFO - PROCESS | 6355 | Cycle 1(1): loaded http://localhost:59803/tests/dromaeo/cssquery-ext.html (next: http://localhost:59803/tests/dromaeo/cssquery-jquery.html) 18:54:47 INFO - PROCESS | 6355 | RSS: Main: 164925440 18:54:47 INFO - PROCESS | 6355 | 18:57:49 INFO - PROCESS | 6355 | Cycle 1(1): loaded http://localhost:59803/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59803/tests/dromaeo/cssquery-mootools.html) 18:57:49 INFO - PROCESS | 6355 | RSS: Main: 165507072 18:57:49 INFO - PROCESS | 6355 | 19:00:51 INFO - PROCESS | 6355 | Cycle 1(1): loaded http://localhost:59803/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59803/tests/dromaeo/cssquery-prototype.html) 19:00:51 INFO - PROCESS | 6355 | RSS: Main: 163692544 19:00:51 INFO - PROCESS | 6355 | 19:03:54 INFO - PROCESS | 6355 | Cycle 1(1): loaded http://localhost:59803/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59803/tests/dromaeo/cssquery-yui.html) 19:03:54 INFO - PROCESS | 6355 | RSS: Main: 165154816 19:03:54 INFO - PROCESS | 6355 | 19:06:57 INFO - PROCESS | 6355 | Cycle 1(1): loaded http://localhost:59803/tests/dromaeo/cssquery-yui.html (next: http://localhost:59803/tests/dromaeo/cssquery-dojo.html) 19:06:57 INFO - PROCESS | 6355 | RSS: Main: 167878656 19:06:57 INFO - PROCESS | 6355 | 19:06:57 INFO - PROCESS | 6355 | __start_tp_report 19:06:57 INFO - PROCESS | 6355 | _x_x_mozilla_page_load 19:06:57 INFO - PROCESS | 6355 | _x_x_mozilla_page_load_details 19:06:57 INFO - PROCESS | 6355 | |i|pagename|runs| 19:06:57 INFO - PROCESS | 6355 | |0;dojo.html;3148.2601588626676;3234.1752853022476;3235.7249633781125;3262.0213935819265;3269.133679574913;5443.401225865156;5447.237386765856;5462.726863656816;5517.779288828452;5526.723663816808;5332.120200166968;5450;5472.753726082326;5477.780888764454;5541.085720856064;4905.190643543811;4954.380702412199;5021.07110184617;5025.246213068032;5067.721275329855;876.5337012897866;4826.251930950691;4879.072976134541;4951.752412379366;5015.0972824891505;4899.216125419915;4933.901321973558;4942.085714142895;4942.258661200831;4967.130752118383;4885.658003939726;4921.138800709861;4946.925796113062;4947.431045429749;4988.077205716954;4912.38595175603;4947.752612369367;4969.055879382906;4976.377952755905;4994.05113028527;5327.38735045467;5333.2266821310695;5334.946650533522;5380.865478363033;5382;5740.196372507852;5861.882762344771;5885.911711324334;5895.764169433218;5914.497267732248;5897.085951677497;5926.259217597801;5930.673812940287;5939.168516407706;5976.103584462322;5519.420460851633;5522.972385138049;5528.640638358494;5530.778768849241;5538.418466061086;5948.940510594925;6031.155638210654;6037.034074548052;6037.275526936795;6119.051547010132;5788.623739456922;5812.738426770806;5813.76744930198;5819.912701309484;5826.184334193216;5825.2135961644635;5831.4168583141345;5831.737571809279;5846.444587764156;5859.1797148399255;5825.912611310834;5868.4424979626865;5903.203067585821;5904.439078287556;5947.1376650385455;5770.07678771403;5810.331811841608;5826.941730582725;5836.941630583725;5850.5612079094235;4343.978280108579;4411.470623525198;4412.624926881251;4425.73445593259;4454.910901782011;3867.1298957734284;3987.980060099681;4014;4034.2738307105;4054.7972601369815;5664.20701101846;5739.253896993364;5740.971295143581;5752.137179423036;5785.82642520725;5823.097419899922;5927.229460170237;5950.761969521257;5959.404059594092;5974.3726908674835;5619.915701264485;5654.3497497788285;5657.094864821609;5677.233573467612;5705.343885453226;4898.828541001048;4905.901881962341;4922.630802689812;4938.135826230396;4998.850034498898;5901.970490147522;6113.476306051851;6123.418275263843;6135.754569817246;6143.508519318444;5941.405859414111;5954.166416701579;5958.851028724143;5959.582829201914;5981.760729570942;6084.11780291864;6126.540509461719;6132.478739307209;6133.601315914451;6149;5643.971780141073;5842.211301474246;5844.561657875762;5872.500837428866;5913.822585322448;5855.648661080349;5862.736176872137;5889.823305300848;5908.3205431375945;5962.52299816005;5719.57103217252;5725.885482290248;5726.685032323096;5738.340090889601;5748.9425105748405;5571.025070612708;5736.225609542658;5767.452092051249;5832.475077243069;5861.35525092231;5668.801591944262;5717.285339332583;5729.914051289151;5746.569007324384;5758.078707406795;5750.166225897138;5792.565557583114;5820.82537523875;5868.2077919480325;5883.35283118848;5559.24950131727;5668.716564171693;5727.942720572741;5729.770809167587;5769.3942136076785 19:06:57 INFO - PROCESS | 6355 | |1;ext.html;597.5130268830902;645.0839807473387;653.5817077070673;655.0403658640092;668.8796266254024;38170;39863.80068099659;39885;39923;40030.399544006825;40492.190156196855;40886.38670419946;40954.79522602383;41139.17721645565;41209.381859272136;8789.472631642106;8916.197542221198;8945.105489451067;8945.926488821318;8954.37319387643;8806.20744133028;8932.374733768638;8939.28485721144;8967.95516022419;8985;8961.865572016424;9001.684941027066;9008.504532250723;9022.052684468135;9028.548572571344;8936.597853096593;8963.865542016874;8985.685501007434;8988.820223595558;9022.052684468168;8729.60716767747;8797.824043519095;8809.603567839398;8814.647414103429;8843.60203790831;32915.341693166;40670;41474.37788433146;41564;41610.79194604038;3322.983385083059;3408.3694516514524;3553.271579326232;3605.260921511084;3656.122530592665;26549.734502655112;27286.727132728618;27305.590416143772;27486.17541473759;27984.860075699493;4022.3966405039187;4033.1731994940965;4094.1811637672286;4163.97918010408;4183.4979802423595;187503;188421;191723;192706;237750.99999999828;34912.65087349094;35385.64614353875;35622.46566301508;35715.10712232215;36542;35008.824955875054;35164.82417587896;35189.29621407558;35218.295634087175;35223;14161.504347347793;14380.137191768526;14382.424703011762;14398.20809855447;14398.85601143996;12466.189697669804;12513.249205047727;12627.242365458102;12629.11596188258;12659.87340126587;8662.740117796477;8673.089325620846;8702.434341767765;8741.650333986696;8777.253933415603;3336.282699219631;3367.5958884933966;3414.3683418567643;3425.5889293284963;3431.4509678451827;941.9576119074658;1032.2825636182931;1085.375908852413;1093.8960798724268;1144.6508814811395;31628.36743265122;32073.67926320707;32286.35427291441;32878.34243315168;33385.83307083449;1088.2654208409292;1122.955081796719;1149.2587281203578;1230.0651504856373;1260.1053252190864;17520.29918803259;18107.54731131732;18221.908890455463;18334.266629334677;18342.63314733698;401095;410586;412530;412926;416685;56957.14564281539;57362.7131864338;58037.70981145067;58221;58420.415795842346;1331.2544974814134;1398.0912406935574;1398.741232871922;1410.9417936547588;1428.764253898116;31276.218094547818;31823.840880795447;32240.35519289648;32388.514172286963;32626.51060234051;47325.29012064753;48408;48555;48607;48652.75673621751;293104;296071;297264;297469;297563;28861.134165975054;28925.132246032652;29210.853945730134;29302.70697293;29354;46858.29712554246;47041.764791175825;47191.76404117957;47906.44888735565;47924.281135782294;39996.600034000454;40724.796376017934;40793;40867;41818.37272440855;38483.42274865823;40102.1979560413;40587.391189131595;40656.1868762629;41243.38134928038;37286.25427491381;38427.42358864675;39171.41242881416;41970;42445.78777106095;39753.40369894512;40979.59020409758;41208.79395603003;41656.58343416527;41673.16653666849;32017.87937422272;32246.677533224367;32522.67477325291;33052.33895322128;33405.99782006544 19:06:57 INFO - PROCESS | 6355 | |2;jquery.html;400.79559424693406;405.446565438177;405.9188162367526;411.51852332770653;417.599104859335;13675;17548.47354579363;18433.81566184338;18448.631027379462;18597.442076737687;15674.451394201205;15732.921335393336;15940.681186376294;17976.280948762032;18669.53326166843;5400.972995135038;5547.528460080898;5661.405552416999;5777.335606405254;5778.451047150535;5580.441955804427;5582.804601838937;5591.916121258185;5620.690862002588;5626.043572592648;5225.320708307933;5537.197106419567;5567.415421380758;5567.610267281292;5588.245586845765;5396.784128634889;5465.9726701366435;5492.313460817398;5499.99999999998;5509.393966663683;5622.353429355636;5643.887122257532;5669.8582535436535;5692.31692196939;5706.258186435778;13665.18008919458;13795.448182072705;19593.80406195934;22571.887140564355;22721.659175112385;2264.1396269417683;2390.354604256841;2401.9911637112455;2520.962185567218;2575.343287461704;10590.09984151348;10621.681349559525;13608.727825443535;14287.071340362947;14303.642408939755;1859.6373707127116;1893.8011508791653;1901.610169915164;1977.8219960203508;2017.6368253714325;74693;78516;78538;78556.60721696354;78791.60604196943;9868.851967220497;9974.850377244347;10076.193904487624;10251.948740256252;10358.585656573803;13586.048976571743;13825.861741382658;13892.09701369428;13909.165450073027;13973.88208943282;7533.171351151369;7602.879681856049;7619.923800762032;7636.732714354971;7744.883826742604;7363.116426028911;7366.742164024234;7442.292982166686;7485.5508669480005;7544.094708634999;4121.5878412158545;4187.204431158131;4234.851780187679;4267.146570685875;4337.783110844445;1819.3359423810214;1826.214727667116;1848.2884089625322;1861.5799460701035;1904.0289452379386;939.5490164720973;946.3753922411175;978.3738407419257;1002.178213864624;1019.99490002551;18182.363617273597;18271.08644567766;18699.906500467412;18778.342758003404;18918;995.7809281957958;1052.7157667429904;1059.8728152621582;1077.8167711489066;1089.54239219528;10031.69904902854;10601.151907847354;10619.469026548642;10635.20235982289;10639.042486176126;502919;505192;516127;516911.8161728643;527836;70281.64859175672;79391.60304198442;79597;86243.56878215694;90208.5489572548;995.2386424385351;1015.2132097624252;1033.132168978062;1034.9586016559404;1057.117307048623;15812.68374632524;15952.122633254818;16000.519984400487;16060;16096.919515402347;33685.663143368256;34414;34901.30197395987;36028.4595731059;36230;52765.472345277594;52784.47215527796;53846.19230711464;54088.18867717066;55351.18812524627;5516.696581688046;8181.877271840808;8516.403851730567;8523;8559.186877246651;11141.777164456827;12406.565770198;12408.689782755504;12467.31429771335;12686;11432.199746017699;11475.942620286845;11523.481443334902;11544.769104618028;11779.411029448665;11026.724331891766;11062.222510127824;11151.665450036511;11326.83009754871;11335.093192544742;11412.714682133013;11593.22033898305;11593.304401735923;11939.522419103487;12189.146759726735;8365.372597055368;8374.120717324593;8418.789530261547;8440.071592124985;8447.366447516584;8441.493510389397;10370;11590.304581725124;11590.71023224426;11734.237274577124 19:06:57 INFO - PROCESS | 6355 | |3;mootools.html;1471.7203731291058;1517.4992252556654;1671.9403491610346;1796.2994432171447;1831.4231017229563;7526.322630963212;8316.168383161681;8332.291755200808;8598.398112132154;8604.096569860169;8371.874421883676;8403.747887563368;8446.239838414542;8447.57762111895;8457.196566326205;2323.7095363079657;2369.1471070414723;2369.893354799038;2383.940401489959;2386.3556839653284;2302.5049614332916;2312.1329501436962;2332.790048895599;2334.124703236286;2345.5660702769956;2335.8481698689616;2348.1077190667525;2369.57347677418;2374.560706269337;2381.0951838301507;2303.2859813457712;2308.9422764430856;2313.699219101523;2324.604817181075;2326.406766274606;2226.265332440291;2228.119892642397;2228.320362289501;2232.174095584628;2235.4634887626853;8475.449095808754;8572.185642363966;8588.398812083156;8638.784030399227;8645.092265312114;5083.974580127113;5320.122179840322;5326.7070311132875;5387.24578559002;5387.973060134714;3324.8670053197843;3341.248219150696;3417.470292104728;3475.3570589441033;3495.1436897959907;1128.5655022816193;1132.835738817875;1139.8062329403938;1153.7692461507731;1159.2406973432414;11785.116116291312;11838.940805295919;11885.405729713566;11888.881111188864;11922;4443.600075993176;4806.327114204014;4808.519148085164;4815.036992601494;4900.240462728283;9926;10010.749731256632;10023.498825058718;10027.147692446224;10038.247131465168;5237.188235823453;5283.894322113536;5291.814786482531;5291.867703307371;5344.118220493575;4427.335899615019;4847.878803029953;4857.465678775332;4943.085529177114;4973.42805577356;3982.7012974027066;3988.1824226033596;4036.9394459083137;4103.4870641169855;4149.33610622299;1238.6284114765535;1243.4777393494574;1307.3332600373878;1323.9602811915659;1348.0765675512305;1378.8827949624194;1405.9929700351433;1410.5063227870164;1423.352374669523;1464.7949287099814;8224.218699223564;8233.300169485541;8278.503289802511;8282.834343313221;8295.668173273121;499.53792741713767;504.9018385012583;505.27997603414985;508.1412413021981;508.64140780749483;6038.728257228435;6103.481204097701;6110.480609148272;6275.968620156961;6604.075429439882;10366;10657.57369705203;10746.94626526878;10808;10924.344539327665;9966.2525310602;10523.21075919309;10538.947305263424;10559.788804223872;10581.62964296246;7765.805854853674;7840.2943735065255;7869.645865936047;7930.1276859545405;7941.880871786928;8153.7553873383895;8213.507189568645;8245.79385515367;8275.95862020686;8308.70919517814;9612.855807162758;9921.950390248003;10014.549345279334;10078.092971632588;10093.293469457067;9974.102330790263;10106.44414557177;10163.7459063524;10181.185505159718;10267.7433064174;6423.03654451836;7395.334419902235;7535.924640753522;7696.653650585849;7700.884486732815;8310.750677479686;8317;8335.916640833757;8337.499750015018;8380.455270407405;7433;7635.923640763522;7695.461317707706;7702.460827742004;7714.267144621252;7349.118105827335;7420.5176663516695;7432.665530051053;7535.208803075818;7590.203028681909;7823.921760782547;7853.489523180975;7872.37021038327;7901.0518737749535;7993.760187194393;6832.692528836114;7045.1898031727005;7048.083749112788;7231.8553628928175;7364.963175184304;7206.063211782434;7307;7366.226546212571;7375.778726638209;7406.666699998621 19:06:57 INFO - PROCESS | 6355 | |4;prototype.html;341.42981221360327;348.84127721886546;348.97208223342136;354.5514923621618;356.0209424083768;5958.106284057393;6001.639901605907;6011.759529618816;6016.639001659898;6024.87950240996;5666.348369937448;5896.233489646351;5910.024845900432;5917.319508256552;5930.318013428457;4530.954690453103;4538.568835960578;4547.63618910488;4548.363229147905;4550.817967281305;4541;4555.567221113989;4557.384753058344;4576.473705523874;4588.128255631436;4504.504504504502;4513.435820522434;4548.772561371935;4567.314902764579;4577.8397756078375;4241.918310830733;4474.127545128701;4484.641228701696;4494.213512635309;4525.601431241447;3887.1642596841816;3905.3165696003084;3918.373060310365;3918.666913312372;3946.3291240489184;5716.857078573027;5723.370429252779;5737.77048918047;5740.856478588027;5752.165935939307;5115;5244.033487442209;5265.578753699733;5266.052110620087;5275.472452754694;6201.5348848836065;6209.285932117819;6213.906791398133;6227.782027629057;6229.345918678564;4127.277726397869;4321.956780432187;4363.781810909473;4367.868963931055;4392.648588112943;6252.687365631746;6464.577792885605;6512.5766825156215;6569.146011018584;6576.145101136869;4417.1386579616665;4426.601605855489;4437.977810110929;4439.223135951195;4455.465344158722;4495.393121928563;4502.369668246448;4504.729716217037;4514.0069184779295;4531.682782205214;4988.326575912278;5210.374755029345;5246.658967167122;5246.790128394821;5264.52619264268;6308.779192728232;6316.4315211630255;6344.302126766052;6345.270293916259;6359.551572644473;1521.8402067782945;1534.5319677498246;1539.3842463014885;1540.8151021877447;1541.8072740907387;1037.6835065305004;1051.006798575339;1051.1538211739623;1053;1073.8335557988523;5993.752342871423;6104.908426373608;6115.938840611626;6153.676959453739;6162.722677479434;6481;6490.707918143695;6499.155109835786;6521.576097553644;6540.672966351759;5879.559033072536;6100.969495152496;6127.142200091991;6180.752769889244;6193.1329613854095;3461.2212252243044;3475;3492.214251793377;3515.525404070469;3524.629913859008;6542.607443553402;6723.831904202434;6768.123547492296;6780.559263647946;6796.932030679729;6636.170478690164;6654.035164901063;6661.733530658719;6672.733090676318;6679.899801502981;6537.411632953057;6713.395794378529;6723.22682891464;6752.189737231465;6756.797296081126;6445.871082578416;6462.935370646422;6463.382330156294;6504.1869766279215;6512.3162067982175;6233.594816336924;6382.32985536512;6390.808275751735;6406.583572067801;6439.388258115471;6665.266820649822;6712.429443497357;6724.327567243236;6732.461403087839;6733.69698363565;4506.504284528764;4512.345709872116;4528;4546.522615125365;4551.08978204367;6330.3669633036325;6476.319986401549;6500.609963402211;6525.836854078686;6582.934170658232;6264.2796078451565;6296.442509981845;6309.33751956038;6321.778737744157;6327.430531252209;6144.078388241799;6328.6900281397875;6335.778247761306;6347.428731414195;6349.174607301022;6210.782622608187;6224.782132625336;6236.906446403217;6238.15784869055;6275.403836635513;6169.7300430769965;6395;6413.518986076157;6414.102025716496;6425.357464253537;6209.59637623553;6238.6880655967925;6261.686915654108;6281.780137695158;6302.464290535172 19:06:57 INFO - PROCESS | 6355 | |5;yui.html;765.6745882999724;770.9151993280742;832.5004997001798;838.9244967952883;873.5544872115228;13946.302684865766;14333.426662933483;14449.133052016874;15537.922310388432;15623.687526249469;14514.491992780255;14593.41626334948;14623.415063397451;14677.192754398504;14720.484783032596;702.8418605813703;829.1128492512984;849.452103393311;849.4987957105337;857.5969294431607;840.4285086141422;843.9789005274856;844.7465760271924;845.4462327175679;846.2848892685702;877.4340550345023;883.3816328570026;883.7083762358407;883.9602217900177;885.7121435533445;884.062893333069;884.3058199313508;885.0529932971691;886.5301390263171;890.5146695051212;643.6106155775735;645.7384759172543;646.5183438338421;646.8156575375996;649.3247023095975;14711.264436778118;14775.70448591033;14799.852001479954;14850.480233191895;14902.180380079091;13948.72102557943;13977.79033314501;14013.369398377097;14111;14322.64193395163;11339.319640821495;11469.94265028678;11475.426228688531;11742.354170520617;11776.705582360424;3874.2057878134915;3883.262180185756;3971.940420893689;4081.4490043844294;4085.428040074392;55472;55786.72106639481;56284.43715562833;57083;57760.422395775924;11463.828042579367;11564.768704626029;11612.361320127475;11616.94191529054;11668.591599294154;20945.58108837845;20986.370408887757;21111.472213194793;21138.365849024554;21186.470338241357;8467.306538692286;8496.235338819535;8498.830023399621;8505.149485051568;8554;4729.763511824395;4826.8069277228515;4901.681390709592;4920.163572192736;4985.52637499437;3514.789112653249;3599.5140656011627;3641.399169137063;3651.8496673547747;3652.3790955537625;666.2072134160334;667.1627107979551;669.8091044052421;670.2191946382508;670.577536152221;733.7725305155419;746.3432179681954;763.7288762489347;777.1334961517866;782.3662833105203;9248.815023699623;9427.764305892408;9460.195883349992;9471.573779179816;9570.282228832866;562.8536580489102;629.9699990515448;662.8475450646379;728.6429649471827;746.6192241956533;4400.273954797487;4410.470743510735;4445.51099379068;4446.866594002185;4578.748168850679;49260.50739492631;50834.74582627137;50920.23619645708;51037;61043.69478152581;45066.549334506235;45408.3188752169;47873.5212647876;48189.5181048192;51624.741876290376;43964.120717586105;46040.53959460362;46195.307070393974;46807.531924680996;48204.27693584599;9114.36199466031;9432.151106400457;9499.192568631745;9511.191548718436;9597.28020398459;32785;33232.501512477815;33381.49927751037;33953;34044.148896277795;40509.59490405058;41199.1760164801;41490.170196595296;41759.164816704106;42701.35947960845;12233.266004039786;12529.310887901252;12566.434510446868;12575.543012146834;12580.245185288912;13555;13690.589282321545;13727.519536816562;13769.931150344184;13856.515021974183;12955.287459189458;13103.344832758514;13315.66710832237;13527.729445411234;13557.25435101079;12747.553835615709;12914.096013279355;13312.201267923569;13546.458141674222;13558.389872455566;12274.386280686109;12556.43496042662;12853.357332133543;13168.868311316764;13228.206307621573;10326.277160598986;10544.683659490227;10815.621453249098;10856.891431085589;10991.890081099407;10833.29583577065;10988.285761425483;11008.614698485515;11101.222914395914;11223.102151827998 19:06:57 INFO - PROCESS | 6355 | __end_tp_report 19:06:57 INFO - PROCESS | 6355 | __start_cc_report 19:06:57 INFO - PROCESS | 6355 | _x_x_mozilla_cycle_collect,339 19:06:57 INFO - PROCESS | 6355 | __end_cc_report 19:06:57 INFO - PROCESS | 6355 | __startTimestamp1460340417650__endTimestamp 19:06:57 INFO - PROCESS | 6355 | 19:06:57 INFO - PROCESS | 6355 | ------- Summary: start ------- 19:06:57 INFO - PROCESS | 6355 | Number of tests: 6 19:06:57 INFO - PROCESS | 6355 | 19:06:57 INFO - PROCESS | 6355 | [#0] dojo.html Cycles:165 Average:5437.65 Median:5736.23 stddev:730.19 (12.7%) stddev-sans-first:710.00 19:06:57 INFO - PROCESS | 6355 | Values: 3148.3 3234.2 3235.7 3262.0 3269.1 5443.4 5447.2 5462.7 5517.8 5526.7 5332.1 5450.0 5472.8 5477.8 5541.1 4905.2 4954.4 5021.1 5025.2 5067.7 876.5 4826.3 4879.1 4951.8 5015.1 4899.2 4933.9 4942.1 4942.3 4967.1 4885.7 4921.1 4946.9 4947.4 4988.1 4912.4 4947.8 4969.1 4976.4 4994.1 5327.4 5333.2 5334.9 5380.9 5382.0 5740.2 5861.9 5885.9 5895.8 5914.5 5897.1 5926.3 5930.7 5939.2 5976.1 5519.4 5523.0 5528.6 5530.8 5538.4 5948.9 6031.2 6037.0 6037.3 6119.1 5788.6 5812.7 5813.8 5819.9 5826.2 5825.2 5831.4 5831.7 5846.4 5859.2 5825.9 5868.4 5903.2 5904.4 5947.1 5770.1 5810.3 5826.9 5836.9 5850.6 4344.0 4411.5 4412.6 4425.7 4454.9 3867.1 3988.0 4014.0 4034.3 4054.8 5664.2 5739.3 5741.0 5752.1 5785.8 5823.1 5927.2 5950.8 5959.4 5974.4 5619.9 5654.3 5657.1 5677.2 5705.3 4898.8 4905.9 4922.6 4938.1 4998.9 5902.0 6113.5 6123.4 6135.8 6143.5 5941.4 5954.2 5958.9 5959.6 5981.8 6084.1 6126.5 6132.5 6133.6 6149.0 5644.0 5842.2 5844.6 5872.5 5913.8 5855.6 5862.7 5889.8 5908.3 5962.5 5719.6 5725.9 5726.7 5738.3 5748.9 5571.0 5736.2 5767.5 5832.5 5861.4 5668.8 5717.3 5729.9 5746.6 5758.1 5750.2 5792.6 5820.8 5868.2 5883.4 5559.2 5668.7 5727.9 5729.8 5769.4 19:06:57 INFO - PROCESS | 6355 | 19:06:57 INFO - PROCESS | 6355 | [#1] ext.html Cycles:180 Average:46676.42 Median:39808.60 stddev:82912.11 (208.3%) stddev-sans-first:83072.52 19:06:57 INFO - PROCESS | 6355 | Values: 597.5 645.1 653.6 655.0 668.9 38170.0 39863.8 39885.0 39923.0 40030.4 40492.2 40886.4 40954.8 41139.2 41209.4 8789.5 8916.2 8945.1 8945.9 8954.4 8806.2 8932.4 8939.3 8968.0 8985.0 8961.9 9001.7 9008.5 9022.1 9028.5 8936.6 8963.9 8985.7 8988.8 9022.1 8729.6 8797.8 8809.6 8814.6 8843.6 32915.3 40670.0 41474.4 41564.0 41610.8 3323.0 3408.4 3553.3 3605.3 3656.1 26549.7 27286.7 27305.6 27486.2 27984.9 4022.4 4033.2 4094.2 4164.0 4183.5 187503.0 188421.0 191723.0 192706.0 237751.0 34912.7 35385.6 35622.5 35715.1 36542.0 35008.8 35164.8 35189.3 35218.3 35223.0 14161.5 14380.1 14382.4 14398.2 14398.9 12466.2 12513.2 12627.2 12629.1 12659.9 8662.7 8673.1 8702.4 8741.7 8777.3 3336.3 3367.6 3414.4 3425.6 3431.5 942.0 1032.3 1085.4 1093.9 1144.7 31628.4 32073.7 32286.4 32878.3 33385.8 1088.3 1123.0 1149.3 1230.1 1260.1 17520.3 18107.5 18221.9 18334.3 18342.6 401095.0 410586.0 412530.0 412926.0 416685.0 56957.1 57362.7 58037.7 58221.0 58420.4 1331.3 1398.1 1398.7 1410.9 1428.8 31276.2 31823.8 32240.4 32388.5 32626.5 47325.3 48408.0 48555.0 48607.0 48652.8 293104.0 296071.0 297264.0 297469.0 297563.0 28861.1 28925.1 29210.9 29302.7 29354.0 46858.3 47041.8 47191.8 47906.4 47924.3 39996.6 40724.8 40793.0 40867.0 41818.4 38483.4 40102.2 40587.4 40656.2 41243.4 37286.3 38427.4 39171.4 41970.0 42445.8 39753.4 40979.6 41208.8 41656.6 41673.2 32017.9 32246.7 32522.7 33052.3 33406.0 19:06:57 INFO - PROCESS | 6355 | 19:06:57 INFO - PROCESS | 6355 | [#2] jquery.html Cycles:180 Average:28512.11 Median:2548.15 stddev:84368.66 (3311.0%) stddev-sans-first:84578.93 19:06:57 INFO - PROCESS | 6355 | Values: 400.8 405.4 405.9 411.5 417.6 13675.0 17548.5 18433.8 18448.6 18597.4 15674.5 15732.9 15940.7 17976.3 18669.5 5401.0 5547.5 5661.4 5777.3 5778.5 5580.4 5582.8 5591.9 5620.7 5626.0 5225.3 5537.2 5567.4 5567.6 5588.2 5396.8 5466.0 5492.3 5500.0 5509.4 5622.4 5643.9 5669.9 5692.3 5706.3 13665.2 13795.4 19593.8 22571.9 22721.7 2264.1 2390.4 2402.0 2521.0 2575.3 10590.1 10621.7 13608.7 14287.1 14303.6 1859.6 1893.8 1901.6 1977.8 2017.6 74693.0 78516.0 78538.0 78556.6 78791.6 9868.9 9974.9 10076.2 10251.9 10358.6 13586.0 13825.9 13892.1 13909.2 13973.9 7533.2 7602.9 7619.9 7636.7 7744.9 7363.1 7366.7 7442.3 7485.6 7544.1 4121.6 4187.2 4234.9 4267.1 4337.8 1819.3 1826.2 1848.3 1861.6 1904.0 939.5 946.4 978.4 1002.2 1020.0 18182.4 18271.1 18699.9 18778.3 18918.0 995.8 1052.7 1059.9 1077.8 1089.5 10031.7 10601.2 10619.5 10635.2 10639.0 502919.0 505192.0 516127.0 516911.8 527836.0 70281.6 79391.6 79597.0 86243.6 90208.5 995.2 1015.2 1033.1 1035.0 1057.1 15812.7 15952.1 16000.5 16060.0 16096.9 33685.7 34414.0 34901.3 36028.5 36230.0 52765.5 52784.5 53846.2 54088.2 55351.2 5516.7 8181.9 8516.4 8523.0 8559.2 11141.8 12406.6 12408.7 12467.3 12686.0 11432.2 11475.9 11523.5 11544.8 11779.4 11026.7 11062.2 11151.7 11326.8 11335.1 11412.7 11593.2 11593.3 11939.5 12189.1 8365.4 8374.1 8418.8 8440.1 8447.4 8441.5 10370.0 11590.3 11590.7 11734.2 19:06:57 INFO - PROCESS | 6355 | 19:06:57 INFO - PROCESS | 6355 | [#3] mootools.html Cycles:180 Average:6036.58 Median:502.22 stddev:3230.66 (643.3%) stddev-sans-first:3221.50 19:06:57 INFO - PROCESS | 6355 | Values: 1471.7 1517.5 1671.9 1796.3 1831.4 7526.3 8316.2 8332.3 8598.4 8604.1 8371.9 8403.7 8446.2 8447.6 8457.2 2323.7 2369.1 2369.9 2383.9 2386.4 2302.5 2312.1 2332.8 2334.1 2345.6 2335.8 2348.1 2369.6 2374.6 2381.1 2303.3 2308.9 2313.7 2324.6 2326.4 2226.3 2228.1 2228.3 2232.2 2235.5 8475.4 8572.2 8588.4 8638.8 8645.1 5084.0 5320.1 5326.7 5387.2 5388.0 3324.9 3341.2 3417.5 3475.4 3495.1 1128.6 1132.8 1139.8 1153.8 1159.2 11785.1 11838.9 11885.4 11888.9 11922.0 4443.6 4806.3 4808.5 4815.0 4900.2 9926.0 10010.7 10023.5 10027.1 10038.2 5237.2 5283.9 5291.8 5291.9 5344.1 4427.3 4847.9 4857.5 4943.1 4973.4 3982.7 3988.2 4036.9 4103.5 4149.3 1238.6 1243.5 1307.3 1324.0 1348.1 1378.9 1406.0 1410.5 1423.4 1464.8 8224.2 8233.3 8278.5 8282.8 8295.7 499.5 504.9 505.3 508.1 508.6 6038.7 6103.5 6110.5 6276.0 6604.1 10366.0 10657.6 10746.9 10808.0 10924.3 9966.3 10523.2 10538.9 10559.8 10581.6 7765.8 7840.3 7869.6 7930.1 7941.9 8153.8 8213.5 8245.8 8276.0 8308.7 9612.9 9922.0 10014.5 10078.1 10093.3 9974.1 10106.4 10163.7 10181.2 10267.7 6423.0 7395.3 7535.9 7696.7 7700.9 8310.8 8317.0 8335.9 8337.5 8380.5 7433.0 7635.9 7695.5 7702.5 7714.3 7349.1 7420.5 7432.7 7535.2 7590.2 7823.9 7853.5 7872.4 7901.1 7993.8 6832.7 7045.2 7048.1 7231.9 7365.0 7206.1 7307.0 7366.2 7375.8 7406.7 19:06:57 INFO - PROCESS | 6355 | 19:06:57 INFO - PROCESS | 6355 | [#4] prototype.html Cycles:180 Average:5266.12 Median:6020.76 stddev:1594.99 (26.5%) stddev-sans-first:1556.05 19:06:57 INFO - PROCESS | 6355 | Values: 341.4 348.8 349.0 354.6 356.0 5958.1 6001.6 6011.8 6016.6 6024.9 5666.3 5896.2 5910.0 5917.3 5930.3 4531.0 4538.6 4547.6 4548.4 4550.8 4541.0 4555.6 4557.4 4576.5 4588.1 4504.5 4513.4 4548.8 4567.3 4577.8 4241.9 4474.1 4484.6 4494.2 4525.6 3887.2 3905.3 3918.4 3918.7 3946.3 5716.9 5723.4 5737.8 5740.9 5752.2 5115.0 5244.0 5265.6 5266.1 5275.5 6201.5 6209.3 6213.9 6227.8 6229.3 4127.3 4322.0 4363.8 4367.9 4392.6 6252.7 6464.6 6512.6 6569.1 6576.1 4417.1 4426.6 4438.0 4439.2 4455.5 4495.4 4502.4 4504.7 4514.0 4531.7 4988.3 5210.4 5246.7 5246.8 5264.5 6308.8 6316.4 6344.3 6345.3 6359.6 1521.8 1534.5 1539.4 1540.8 1541.8 1037.7 1051.0 1051.2 1053.0 1073.8 5993.8 6104.9 6115.9 6153.7 6162.7 6481.0 6490.7 6499.2 6521.6 6540.7 5879.6 6101.0 6127.1 6180.8 6193.1 3461.2 3475.0 3492.2 3515.5 3524.6 6542.6 6723.8 6768.1 6780.6 6796.9 6636.2 6654.0 6661.7 6672.7 6679.9 6537.4 6713.4 6723.2 6752.2 6756.8 6445.9 6462.9 6463.4 6504.2 6512.3 6233.6 6382.3 6390.8 6406.6 6439.4 6665.3 6712.4 6724.3 6732.5 6733.7 4506.5 4512.3 4528.0 4546.5 4551.1 6330.4 6476.3 6500.6 6525.8 6582.9 6264.3 6296.4 6309.3 6321.8 6327.4 6144.1 6328.7 6335.8 6347.4 6349.2 6210.8 6224.8 6236.9 6238.2 6275.4 6169.7 6395.0 6413.5 6414.1 6425.4 6209.6 6238.7 6261.7 6281.8 6302.5 19:06:57 INFO - PROCESS | 6355 | 19:06:57 INFO - PROCESS | 6355 | [#5] yui.html Cycles:180 Average:14418.00 Median:24182.20 stddev:15626.67 (64.6%) stddev-sans-first:15636.88 19:06:57 INFO - PROCESS | 6355 | Values: 765.7 770.9 832.5 838.9 873.6 13946.3 14333.4 14449.1 15537.9 15623.7 14514.5 14593.4 14623.4 14677.2 14720.5 702.8 829.1 849.5 849.5 857.6 840.4 844.0 844.7 845.4 846.3 877.4 883.4 883.7 884.0 885.7 884.1 884.3 885.1 886.5 890.5 643.6 645.7 646.5 646.8 649.3 14711.3 14775.7 14799.9 14850.5 14902.2 13948.7 13977.8 14013.4 14111.0 14322.6 11339.3 11469.9 11475.4 11742.4 11776.7 3874.2 3883.3 3971.9 4081.4 4085.4 55472.0 55786.7 56284.4 57083.0 57760.4 11463.8 11564.8 11612.4 11616.9 11668.6 20945.6 20986.4 21111.5 21138.4 21186.5 8467.3 8496.2 8498.8 8505.1 8554.0 4729.8 4826.8 4901.7 4920.2 4985.5 3514.8 3599.5 3641.4 3651.8 3652.4 666.2 667.2 669.8 670.2 670.6 733.8 746.3 763.7 777.1 782.4 9248.8 9427.8 9460.2 9471.6 9570.3 562.9 630.0 662.8 728.6 746.6 4400.3 4410.5 4445.5 4446.9 4578.7 49260.5 50834.7 50920.2 51037.0 61043.7 45066.5 45408.3 47873.5 48189.5 51624.7 43964.1 46040.5 46195.3 46807.5 48204.3 9114.4 9432.2 9499.2 9511.2 9597.3 32785.0 33232.5 33381.5 33953.0 34044.1 40509.6 41199.2 41490.2 41759.2 42701.4 12233.3 12529.3 12566.4 12575.5 12580.2 13555.0 13690.6 13727.5 13769.9 13856.5 12955.3 13103.3 13315.7 13527.7 13557.3 12747.6 12914.1 13312.2 13546.5 13558.4 12274.4 12556.4 12853.4 13168.9 13228.2 10326.3 10544.7 10815.6 10856.9 10991.9 10833.3 10988.3 11008.6 11101.2 11223.1 19:06:57 INFO - PROCESS | 6355 | -------- Summary: end -------- 19:06:57 INFO - PROCESS | 6355 | 19:06:58 INFO - TEST-INFO | 6355: exit 0 19:06:58 INFO - TEST-OK | dromaeo_css | took 1110053ms 19:06:58 INFO - TEST-START | kraken 19:06:58 INFO - operating with platform_type : linux_ 19:06:58 INFO - Initialising browser for kraken test... 19:06:58 INFO - TEST-INFO | started process 6587 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7V8U14/profile http://localhost:59803/getInfo.html) 19:07:01 INFO - PROCESS | 6587 | 19:07:01 INFO - PROCESS | 6587 | (process:6658): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:07:01 INFO - PROCESS | 6587 | JavaScript error: jar:file:///builds/slave/test-pgo/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 19:07:02 INFO - PROCESS | 6587 | __metrics Screen width/height:1600/1200 19:07:02 INFO - PROCESS | 6587 | colorDepth:24 19:07:02 INFO - PROCESS | 6587 | Browser inner width/height: 1024/697 19:07:02 INFO - PROCESS | 6587 | __metrics 19:07:03 ERROR - PROCESS | 6587 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 19:07:03 INFO - TEST-INFO | 6587: exit 0 19:07:03 INFO - Browser initialized. 19:07:03 INFO - Running cycle 1/1 for kraken test... 19:07:04 INFO - TEST-INFO | started process 6709 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7V8U14/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:07:05 INFO - PROCESS | 6709 | 19:07:05 INFO - PROCESS | 6709 | (process:6767): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:07:15 INFO - PROCESS | 6709 | RSS: Main: 163442688 19:07:15 INFO - PROCESS | 6709 | 19:07:18 INFO - PROCESS | 6709 | Cycle 1(1): loaded http://localhost:59803/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59803/tests/kraken/driver.html?testName=audio-beat-detection) 19:07:19 INFO - PROCESS | 6709 | RSS: Main: 167952384 19:07:19 INFO - PROCESS | 6709 | 19:07:21 INFO - PROCESS | 6709 | Cycle 1(1): loaded http://localhost:59803/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59803/tests/kraken/driver.html?testName=audio-dft) 19:07:22 INFO - PROCESS | 6709 | RSS: Main: 171540480 19:07:22 INFO - PROCESS | 6709 | 19:07:25 INFO - PROCESS | 6709 | Cycle 1(1): loaded http://localhost:59803/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59803/tests/kraken/driver.html?testName=audio-fft) 19:07:25 INFO - PROCESS | 6709 | RSS: Main: 164036608 19:07:25 INFO - PROCESS | 6709 | 19:07:28 INFO - PROCESS | 6709 | Cycle 1(1): loaded http://localhost:59803/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59803/tests/kraken/driver.html?testName=audio-oscillator) 19:07:28 INFO - PROCESS | 6709 | RSS: Main: 164093952 19:07:28 INFO - PROCESS | 6709 | 19:07:30 INFO - PROCESS | 6709 | Cycle 1(1): loaded http://localhost:59803/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59803/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:07:31 INFO - PROCESS | 6709 | RSS: Main: 165076992 19:07:31 INFO - PROCESS | 6709 | 19:07:34 INFO - PROCESS | 6709 | Cycle 1(1): loaded http://localhost:59803/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59803/tests/kraken/driver.html?testName=imaging-darkroom) 19:07:35 INFO - PROCESS | 6709 | RSS: Main: 164937728 19:07:35 INFO - PROCESS | 6709 | 19:07:38 INFO - PROCESS | 6709 | Cycle 1(1): loaded http://localhost:59803/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59803/tests/kraken/driver.html?testName=imaging-desaturate) 19:07:39 INFO - PROCESS | 6709 | RSS: Main: 164904960 19:07:39 INFO - PROCESS | 6709 | 19:07:41 INFO - PROCESS | 6709 | Cycle 1(1): loaded http://localhost:59803/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59803/tests/kraken/driver.html?testName=json-parse-financial) 19:07:42 INFO - PROCESS | 6709 | RSS: Main: 165486592 19:07:42 INFO - PROCESS | 6709 | 19:07:44 INFO - PROCESS | 6709 | Cycle 1(1): loaded http://localhost:59803/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59803/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:07:44 INFO - PROCESS | 6709 | RSS: Main: 165437440 19:07:44 INFO - PROCESS | 6709 | 19:07:46 INFO - PROCESS | 6709 | Cycle 1(1): loaded http://localhost:59803/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59803/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:07:47 INFO - PROCESS | 6709 | RSS: Main: 165380096 19:07:47 INFO - PROCESS | 6709 | 19:07:49 INFO - PROCESS | 6709 | Cycle 1(1): loaded http://localhost:59803/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59803/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:07:50 INFO - PROCESS | 6709 | RSS: Main: 165752832 19:07:50 INFO - PROCESS | 6709 | 19:07:52 INFO - PROCESS | 6709 | Cycle 1(1): loaded http://localhost:59803/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59803/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:07:53 INFO - PROCESS | 6709 | RSS: Main: 166031360 19:07:53 INFO - PROCESS | 6709 | 19:07:56 INFO - PROCESS | 6709 | Cycle 1(1): loaded http://localhost:59803/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59803/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:07:56 INFO - PROCESS | 6709 | RSS: Main: 165986304 19:07:56 INFO - PROCESS | 6709 | 19:07:58 INFO - PROCESS | 6709 | Cycle 1(1): loaded http://localhost:59803/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59803/tests/kraken/driver.html?testName=ai-astar) 19:07:58 INFO - PROCESS | 6709 | RSS: Main: 167514112 19:07:58 INFO - PROCESS | 6709 | 19:07:58 INFO - PROCESS | 6709 | __start_tp_report 19:07:58 INFO - PROCESS | 6709 | _x_x_mozilla_page_load 19:07:58 INFO - PROCESS | 6709 | _x_x_mozilla_page_load_details 19:07:58 INFO - PROCESS | 6709 | |i|pagename|runs| 19:07:58 INFO - PROCESS | 6709 | |0;ai-astar;113;105;112;111;113;123;111;111;113;112 19:07:58 INFO - PROCESS | 6709 | |1;audio-beat-detection;153;127;155;178;129;153;158;128;178;133 19:07:58 INFO - PROCESS | 6709 | |2;audio-dft;163;163;165;161;162;165;173;162;167;166 19:07:58 INFO - PROCESS | 6709 | |3;audio-fft;72;75;73;162;75;74;76;72;172;78 19:07:58 INFO - PROCESS | 6709 | |4;audio-oscillator;93;92;151;96;94;93;145;94;93;147 19:07:58 INFO - PROCESS | 6709 | |5;imaging-gaussian-blur;117;117;117;118;118;117;117;117;118;117 19:07:58 INFO - PROCESS | 6709 | |6;imaging-darkroom;147;147;146;146;146;146;146;146;146;146 19:07:58 INFO - PROCESS | 6709 | |7;imaging-desaturate;96;96;96;96;96;96;95;95;95;95 19:07:58 INFO - PROCESS | 6709 | |8;json-parse-financial;61;59;58;58;58;60;61;72;57;55 19:07:58 INFO - PROCESS | 6709 | |9;json-stringify-tinderbox;62;63;62;63;63;62;62;62;63;62 19:07:58 INFO - PROCESS | 6709 | |10;stanford-crypto-aes;87;79;81;82;82;81;82;96;80;83 19:07:58 INFO - PROCESS | 6709 | |11;stanford-crypto-ccm;129;146;144;134;134;132;139;141;168;137 19:07:58 INFO - PROCESS | 6709 | |12;stanford-crypto-pbkdf2;169;172;167;166;165;164;166;173;169;170 19:07:58 INFO - PROCESS | 6709 | |13;stanford-crypto-sha256-iterative;68;71;70;68;66;67;71;68;70;69 19:07:58 INFO - PROCESS | 6709 | __end_tp_report 19:07:58 INFO - PROCESS | 6709 | __start_cc_report 19:07:58 INFO - PROCESS | 6709 | _x_x_mozilla_cycle_collect,863 19:07:58 INFO - PROCESS | 6709 | __end_cc_report 19:07:58 INFO - PROCESS | 6709 | __startTimestamp1460340478649__endTimestamp 19:07:58 INFO - PROCESS | 6709 | 19:07:58 INFO - PROCESS | 6709 | ------- Summary: start ------- 19:07:58 INFO - PROCESS | 6709 | Number of tests: 14 19:07:58 INFO - PROCESS | 6709 | 19:07:58 INFO - PROCESS | 6709 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.50 stddev:4.40 (3.9%) stddev-sans-first:4.66 19:07:58 INFO - PROCESS | 6709 | Values: 113.0 105.0 112.0 111.0 113.0 123.0 111.0 111.0 113.0 112.0 19:07:58 INFO - PROCESS | 6709 | 19:07:58 INFO - PROCESS | 6709 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:154.00 stddev:19.47 (12.6%) stddev-sans-first:20.60 19:07:58 INFO - PROCESS | 6709 | Values: 153.0 127.0 155.0 178.0 129.0 153.0 158.0 128.0 178.0 133.0 19:07:58 INFO - PROCESS | 6709 | 19:07:58 INFO - PROCESS | 6709 | [#2] audio-dft Cycles:10 Average:164.70 Median:165.00 stddev:3.50 (2.1%) stddev-sans-first:3.66 19:07:58 INFO - PROCESS | 6709 | Values: 163.0 163.0 165.0 161.0 162.0 165.0 173.0 162.0 167.0 166.0 19:07:58 INFO - PROCESS | 6709 | 19:07:58 INFO - PROCESS | 6709 | [#3] audio-fft Cycles:10 Average:92.90 Median:74.50 stddev:39.17 (52.6%) stddev-sans-first:40.81 19:07:58 INFO - PROCESS | 6709 | Values: 72.0 75.0 73.0 162.0 75.0 74.0 76.0 72.0 172.0 78.0 19:07:58 INFO - PROCESS | 6709 | 19:07:58 INFO - PROCESS | 6709 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:93.00 stddev:26.19 (28.2%) stddev-sans-first:27.06 19:07:58 INFO - PROCESS | 6709 | Values: 93.0 92.0 151.0 96.0 94.0 93.0 145.0 94.0 93.0 147.0 19:07:58 INFO - PROCESS | 6709 | 19:07:58 INFO - PROCESS | 6709 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 19:07:58 INFO - PROCESS | 6709 | Values: 117.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 118.0 117.0 19:07:58 INFO - PROCESS | 6709 | 19:07:58 INFO - PROCESS | 6709 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 19:07:58 INFO - PROCESS | 6709 | Values: 147.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 19:07:58 INFO - PROCESS | 6709 | 19:07:58 INFO - PROCESS | 6709 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 19:07:58 INFO - PROCESS | 6709 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 19:07:58 INFO - PROCESS | 6709 | 19:07:58 INFO - PROCESS | 6709 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:59.50 stddev:4.63 (7.8%) stddev-sans-first:4.89 19:07:58 INFO - PROCESS | 6709 | Values: 61.0 59.0 58.0 58.0 58.0 60.0 61.0 72.0 57.0 55.0 19:07:58 INFO - PROCESS | 6709 | 19:07:58 INFO - PROCESS | 6709 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 19:07:58 INFO - PROCESS | 6709 | Values: 62.0 63.0 62.0 63.0 63.0 62.0 62.0 62.0 63.0 62.0 19:07:58 INFO - PROCESS | 6709 | 19:07:58 INFO - PROCESS | 6709 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:82.00 stddev:4.95 (6.0%) stddev-sans-first:5.06 19:07:58 INFO - PROCESS | 6709 | Values: 87.0 79.0 81.0 82.0 82.0 81.0 82.0 96.0 80.0 83.0 19:07:58 INFO - PROCESS | 6709 | 19:07:58 INFO - PROCESS | 6709 | [#11] stanford-crypto-ccm Cycles:10 Average:140.40 Median:140.00 stddev:11.07 (7.9%) stddev-sans-first:10.94 19:07:58 INFO - PROCESS | 6709 | Values: 129.0 146.0 144.0 134.0 134.0 132.0 139.0 141.0 168.0 137.0 19:07:58 INFO - PROCESS | 6709 | 19:07:58 INFO - PROCESS | 6709 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.10 Median:169.00 stddev:3.00 (1.8%) stddev-sans-first:3.16 19:07:58 INFO - PROCESS | 6709 | Values: 169.0 172.0 167.0 166.0 165.0 164.0 166.0 173.0 169.0 170.0 19:07:58 INFO - PROCESS | 6709 | 19:07:58 INFO - PROCESS | 6709 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.50 stddev:1.69 (2.4%) stddev-sans-first:1.76 19:07:58 INFO - PROCESS | 6709 | Values: 68.0 71.0 70.0 68.0 66.0 67.0 71.0 68.0 70.0 69.0 19:07:58 INFO - PROCESS | 6709 | -------- Summary: end -------- 19:07:58 INFO - PROCESS | 6709 | 19:07:59 INFO - TEST-INFO | 6709: exit 0 19:07:59 INFO - TEST-OK | kraken | took 61257ms 19:07:59 INFO - SUITE-END | took 1171s 19:07:59 INFO - Completed test suite (00:19:31) 19:07:59 INFO - javascript benchmark 19:07:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3148.2601588626676, 3234.1752853022476, 3235.7249633781125, 3262.0213935819265, 3269.133679574913, 5443.401225865156, 5447.237386765856, 5462.726863656816, 5517.779288828452, 5526.723663816808, 5332.120200166968, 5450.0, 5472.753726082326, 5477.780888764454, 5541.085720856064, 4905.190643543811, 4954.380702412199, 5021.07110184617, 5025.246213068032, 5067.721275329855, 876.5337012897866, 4826.251930950691, 4879.072976134541, 4951.752412379366, 5015.0972824891505, 4899.216125419915, 4933.901321973558, 4942.085714142895, 4942.258661200831, 4967.130752118383, 4885.658003939726, 4921.138800709861, 4946.925796113062, 4947.431045429749, 4988.077205716954, 4912.38595175603, 4947.752612369367, 4969.055879382906, 4976.377952755905, 4994.05113028527, 5327.38735045467, 5333.2266821310695, 5334.946650533522, 5380.865478363033, 5382.0, 5740.196372507852, 5861.882762344771, 5885.911711324334, 5895.764169433218, 5914.497267732248, 5897.085951677497, 5926.259217597801, 5930.673812940287, 5939.168516407706, 5976.103584462322, 5519.420460851633, 5522.972385138049, 5528.640638358494, 5530.778768849241, 5538.418466061086, 5948.940510594925, 6031.155638210654, 6037.034074548052, 6037.275526936795, 6119.051547010132, 5788.623739456922, 5812.738426770806, 5813.76744930198, 5819.912701309484, 5826.184334193216, 5825.2135961644635, 5831.4168583141345, 5831.737571809279, 5846.444587764156, 5859.1797148399255, 5825.912611310834, 5868.4424979626865, 5903.203067585821, 5904.439078287556, 5947.1376650385455, 5770.07678771403, 5810.331811841608, 5826.941730582725, 5836.941630583725, 5850.5612079094235, 4343.978280108579, 4411.470623525198, 4412.624926881251, 4425.73445593259, 4454.910901782011, 3867.1298957734284, 3987.980060099681, 4014.0, 4034.2738307105, 4054.7972601369815, 5664.20701101846, 5739.253896993364, 5740.971295143581, 5752.137179423036, 5785.82642520725, 5823.097419899922, 5927.229460170237, 5950.761969521257, 5959.404059594092, 5974.3726908674835, 5619.915701264485, 5654.3497497788285, 5657.094864821609, 5677.233573467612, 5705.343885453226, 4898.828541001048, 4905.901881962341, 4922.630802689812, 4938.135826230396, 4998.850034498898, 5901.970490147522, 6113.476306051851, 6123.418275263843, 6135.754569817246, 6143.508519318444, 5941.405859414111, 5954.166416701579, 5958.851028724143, 5959.582829201914, 5981.760729570942, 6084.11780291864, 6126.540509461719, 6132.478739307209, 6133.601315914451, 6149.0, 5643.971780141073, 5842.211301474246, 5844.561657875762, 5872.500837428866, 5913.822585322448, 5855.648661080349, 5862.736176872137, 5889.823305300848, 5908.3205431375945, 5962.52299816005, 5719.57103217252, 5725.885482290248, 5726.685032323096, 5738.340090889601, 5748.9425105748405, 5571.025070612708, 5736.225609542658, 5767.452092051249, 5832.475077243069, 5861.35525092231, 5668.801591944262, 5717.285339332583, 5729.914051289151, 5746.569007324384, 5758.078707406795, 5750.166225897138, 5792.565557583114, 5820.82537523875, 5868.2077919480325, 5883.35283118848, 5559.24950131727, 5668.716564171693, 5727.942720572741, 5729.770809167587, 5769.3942136076785], "value": 5388.981708601496, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.5130268830902, 645.0839807473387, 653.5817077070673, 655.0403658640092, 668.8796266254024, 38170.0, 39863.80068099659, 39885.0, 39923.0, 40030.399544006825, 40492.190156196855, 40886.38670419946, 40954.79522602383, 41139.17721645565, 41209.381859272136, 8789.472631642106, 8916.197542221198, 8945.105489451067, 8945.926488821318, 8954.37319387643, 8806.20744133028, 8932.374733768638, 8939.28485721144, 8967.95516022419, 8985.0, 8961.865572016424, 9001.684941027066, 9008.504532250723, 9022.052684468135, 9028.548572571344, 8936.597853096593, 8963.865542016874, 8985.685501007434, 8988.820223595558, 9022.052684468168, 8729.60716767747, 8797.824043519095, 8809.603567839398, 8814.647414103429, 8843.60203790831, 32915.341693166, 40670.0, 41474.37788433146, 41564.0, 41610.79194604038, 3322.983385083059, 3408.3694516514524, 3553.271579326232, 3605.260921511084, 3656.122530592665, 26549.734502655112, 27286.727132728618, 27305.590416143772, 27486.17541473759, 27984.860075699493, 4022.3966405039187, 4033.1731994940965, 4094.1811637672286, 4163.97918010408, 4183.4979802423595, 187503.0, 188421.0, 191723.0, 192706.0, 237750.99999999828, 34912.65087349094, 35385.64614353875, 35622.46566301508, 35715.10712232215, 36542.0, 35008.824955875054, 35164.82417587896, 35189.29621407558, 35218.295634087175, 35223.0, 14161.504347347793, 14380.137191768526, 14382.424703011762, 14398.20809855447, 14398.85601143996, 12466.189697669804, 12513.249205047727, 12627.242365458102, 12629.11596188258, 12659.87340126587, 8662.740117796477, 8673.089325620846, 8702.434341767765, 8741.650333986696, 8777.253933415603, 3336.282699219631, 3367.5958884933966, 3414.3683418567643, 3425.5889293284963, 3431.4509678451827, 941.9576119074658, 1032.2825636182931, 1085.375908852413, 1093.8960798724268, 1144.6508814811395, 31628.36743265122, 32073.67926320707, 32286.35427291441, 32878.34243315168, 33385.83307083449, 1088.2654208409292, 1122.955081796719, 1149.2587281203578, 1230.0651504856373, 1260.1053252190864, 17520.29918803259, 18107.54731131732, 18221.908890455463, 18334.266629334677, 18342.63314733698, 401095.0, 410586.0, 412530.0, 412926.0, 416685.0, 56957.14564281539, 57362.7131864338, 58037.70981145067, 58221.0, 58420.415795842346, 1331.2544974814134, 1398.0912406935574, 1398.741232871922, 1410.9417936547588, 1428.764253898116, 31276.218094547818, 31823.840880795447, 32240.35519289648, 32388.514172286963, 32626.51060234051, 47325.29012064753, 48408.0, 48555.0, 48607.0, 48652.75673621751, 293104.0, 296071.0, 297264.0, 297469.0, 297563.0, 28861.134165975054, 28925.132246032652, 29210.853945730134, 29302.70697293, 29354.0, 46858.29712554246, 47041.764791175825, 47191.76404117957, 47906.44888735565, 47924.281135782294, 39996.600034000454, 40724.796376017934, 40793.0, 40867.0, 41818.37272440855, 38483.42274865823, 40102.1979560413, 40587.391189131595, 40656.1868762629, 41243.38134928038, 37286.25427491381, 38427.42358864675, 39171.41242881416, 41970.0, 42445.78777106095, 39753.40369894512, 40979.59020409758, 41208.79395603003, 41656.58343416527, 41673.16653666849, 32017.87937422272, 32246.677533224367, 32522.67477325291, 33052.33895322128, 33405.99782006544], "value": 18032.711986563525, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.79559424693406, 405.446565438177, 405.9188162367526, 411.51852332770653, 417.599104859335, 13675.0, 17548.47354579363, 18433.81566184338, 18448.631027379462, 18597.442076737687, 15674.451394201205, 15732.921335393336, 15940.681186376294, 17976.280948762032, 18669.53326166843, 5400.972995135038, 5547.528460080898, 5661.405552416999, 5777.335606405254, 5778.451047150535, 5580.441955804427, 5582.804601838937, 5591.916121258185, 5620.690862002588, 5626.043572592648, 5225.320708307933, 5537.197106419567, 5567.415421380758, 5567.610267281292, 5588.245586845765, 5396.784128634889, 5465.9726701366435, 5492.313460817398, 5499.99999999998, 5509.393966663683, 5622.353429355636, 5643.887122257532, 5669.8582535436535, 5692.31692196939, 5706.258186435778, 13665.18008919458, 13795.448182072705, 19593.80406195934, 22571.887140564355, 22721.659175112385, 2264.1396269417683, 2390.354604256841, 2401.9911637112455, 2520.962185567218, 2575.343287461704, 10590.09984151348, 10621.681349559525, 13608.727825443535, 14287.071340362947, 14303.642408939755, 1859.6373707127116, 1893.8011508791653, 1901.610169915164, 1977.8219960203508, 2017.6368253714325, 74693.0, 78516.0, 78538.0, 78556.60721696354, 78791.60604196943, 9868.851967220497, 9974.850377244347, 10076.193904487624, 10251.948740256252, 10358.585656573803, 13586.048976571743, 13825.861741382658, 13892.09701369428, 13909.165450073027, 13973.88208943282, 7533.171351151369, 7602.879681856049, 7619.923800762032, 7636.732714354971, 7744.883826742604, 7363.116426028911, 7366.742164024234, 7442.292982166686, 7485.5508669480005, 7544.094708634999, 4121.5878412158545, 4187.204431158131, 4234.851780187679, 4267.146570685875, 4337.783110844445, 1819.3359423810214, 1826.214727667116, 1848.2884089625322, 1861.5799460701035, 1904.0289452379386, 939.5490164720973, 946.3753922411175, 978.3738407419257, 1002.178213864624, 1019.99490002551, 18182.363617273597, 18271.08644567766, 18699.906500467412, 18778.342758003404, 18918.0, 995.7809281957958, 1052.7157667429904, 1059.8728152621582, 1077.8167711489066, 1089.54239219528, 10031.69904902854, 10601.151907847354, 10619.469026548642, 10635.20235982289, 10639.042486176126, 502919.0, 505192.0, 516127.0, 516911.8161728643, 527836.0, 70281.64859175672, 79391.60304198442, 79597.0, 86243.56878215694, 90208.5489572548, 995.2386424385351, 1015.2132097624252, 1033.132168978062, 1034.9586016559404, 1057.117307048623, 15812.68374632524, 15952.122633254818, 16000.519984400487, 16060.0, 16096.919515402347, 33685.663143368256, 34414.0, 34901.30197395987, 36028.4595731059, 36230.0, 52765.472345277594, 52784.47215527796, 53846.19230711464, 54088.18867717066, 55351.18812524627, 5516.696581688046, 8181.877271840808, 8516.403851730567, 8523.0, 8559.186877246651, 11141.777164456827, 12406.565770198, 12408.689782755504, 12467.31429771335, 12686.0, 11432.199746017699, 11475.942620286845, 11523.481443334902, 11544.769104618028, 11779.411029448665, 11026.724331891766, 11062.222510127824, 11151.665450036511, 11326.83009754871, 11335.093192544742, 11412.714682133013, 11593.22033898305, 11593.304401735923, 11939.522419103487, 12189.146759726735, 8365.372597055368, 8374.120717324593, 8418.789530261547, 8440.071592124985, 8447.366447516584, 8441.493510389397, 10370.0, 11590.304581725124, 11590.71023224426, 11734.237274577124], "value": 8837.333190914544, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1471.7203731291058, 1517.4992252556654, 1671.9403491610346, 1796.2994432171447, 1831.4231017229563, 7526.322630963212, 8316.168383161681, 8332.291755200808, 8598.398112132154, 8604.096569860169, 8371.874421883676, 8403.747887563368, 8446.239838414542, 8447.57762111895, 8457.196566326205, 2323.7095363079657, 2369.1471070414723, 2369.893354799038, 2383.940401489959, 2386.3556839653284, 2302.5049614332916, 2312.1329501436962, 2332.790048895599, 2334.124703236286, 2345.5660702769956, 2335.8481698689616, 2348.1077190667525, 2369.57347677418, 2374.560706269337, 2381.0951838301507, 2303.2859813457712, 2308.9422764430856, 2313.699219101523, 2324.604817181075, 2326.406766274606, 2226.265332440291, 2228.119892642397, 2228.320362289501, 2232.174095584628, 2235.4634887626853, 8475.449095808754, 8572.185642363966, 8588.398812083156, 8638.784030399227, 8645.092265312114, 5083.974580127113, 5320.122179840322, 5326.7070311132875, 5387.24578559002, 5387.973060134714, 3324.8670053197843, 3341.248219150696, 3417.470292104728, 3475.3570589441033, 3495.1436897959907, 1128.5655022816193, 1132.835738817875, 1139.8062329403938, 1153.7692461507731, 1159.2406973432414, 11785.116116291312, 11838.940805295919, 11885.405729713566, 11888.881111188864, 11922.0, 4443.600075993176, 4806.327114204014, 4808.519148085164, 4815.036992601494, 4900.240462728283, 9926.0, 10010.749731256632, 10023.498825058718, 10027.147692446224, 10038.247131465168, 5237.188235823453, 5283.894322113536, 5291.814786482531, 5291.867703307371, 5344.118220493575, 4427.335899615019, 4847.878803029953, 4857.465678775332, 4943.085529177114, 4973.42805577356, 3982.7012974027066, 3988.1824226033596, 4036.9394459083137, 4103.4870641169855, 4149.33610622299, 1238.6284114765535, 1243.4777393494574, 1307.3332600373878, 1323.9602811915659, 1348.0765675512305, 1378.8827949624194, 1405.9929700351433, 1410.5063227870164, 1423.352374669523, 1464.7949287099814, 8224.218699223564, 8233.300169485541, 8278.503289802511, 8282.834343313221, 8295.668173273121, 499.53792741713767, 504.9018385012583, 505.27997603414985, 508.1412413021981, 508.64140780749483, 6038.728257228435, 6103.481204097701, 6110.480609148272, 6275.968620156961, 6604.075429439882, 10366.0, 10657.57369705203, 10746.94626526878, 10808.0, 10924.344539327665, 9966.2525310602, 10523.21075919309, 10538.947305263424, 10559.788804223872, 10581.62964296246, 7765.805854853674, 7840.2943735065255, 7869.645865936047, 7930.1276859545405, 7941.880871786928, 8153.7553873383895, 8213.507189568645, 8245.79385515367, 8275.95862020686, 8308.70919517814, 9612.855807162758, 9921.950390248003, 10014.549345279334, 10078.092971632588, 10093.293469457067, 9974.102330790263, 10106.44414557177, 10163.7459063524, 10181.185505159718, 10267.7433064174, 6423.03654451836, 7395.334419902235, 7535.924640753522, 7696.653650585849, 7700.884486732815, 8310.750677479686, 8317.0, 8335.916640833757, 8337.499750015018, 8380.455270407405, 7433.0, 7635.923640763522, 7695.461317707706, 7702.460827742004, 7714.267144621252, 7349.118105827335, 7420.5176663516695, 7432.665530051053, 7535.208803075818, 7590.203028681909, 7823.921760782547, 7853.489523180975, 7872.37021038327, 7901.0518737749535, 7993.760187194393, 6832.692528836114, 7045.1898031727005, 7048.083749112788, 7231.8553628928175, 7364.963175184304, 7206.063211782434, 7307.0, 7366.226546212571, 7375.778726638209, 7406.666699998621], "value": 4824.033516067943, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.42981221360327, 348.84127721886546, 348.97208223342136, 354.5514923621618, 356.0209424083768, 5958.106284057393, 6001.639901605907, 6011.759529618816, 6016.639001659898, 6024.87950240996, 5666.348369937448, 5896.233489646351, 5910.024845900432, 5917.319508256552, 5930.318013428457, 4530.954690453103, 4538.568835960578, 4547.63618910488, 4548.363229147905, 4550.817967281305, 4541.0, 4555.567221113989, 4557.384753058344, 4576.473705523874, 4588.128255631436, 4504.504504504502, 4513.435820522434, 4548.772561371935, 4567.314902764579, 4577.8397756078375, 4241.918310830733, 4474.127545128701, 4484.641228701696, 4494.213512635309, 4525.601431241447, 3887.1642596841816, 3905.3165696003084, 3918.373060310365, 3918.666913312372, 3946.3291240489184, 5716.857078573027, 5723.370429252779, 5737.77048918047, 5740.856478588027, 5752.165935939307, 5115.0, 5244.033487442209, 5265.578753699733, 5266.052110620087, 5275.472452754694, 6201.5348848836065, 6209.285932117819, 6213.906791398133, 6227.782027629057, 6229.345918678564, 4127.277726397869, 4321.956780432187, 4363.781810909473, 4367.868963931055, 4392.648588112943, 6252.687365631746, 6464.577792885605, 6512.5766825156215, 6569.146011018584, 6576.145101136869, 4417.1386579616665, 4426.601605855489, 4437.977810110929, 4439.223135951195, 4455.465344158722, 4495.393121928563, 4502.369668246448, 4504.729716217037, 4514.0069184779295, 4531.682782205214, 4988.326575912278, 5210.374755029345, 5246.658967167122, 5246.790128394821, 5264.52619264268, 6308.779192728232, 6316.4315211630255, 6344.302126766052, 6345.270293916259, 6359.551572644473, 1521.8402067782945, 1534.5319677498246, 1539.3842463014885, 1540.8151021877447, 1541.8072740907387, 1037.6835065305004, 1051.006798575339, 1051.1538211739623, 1053.0, 1073.8335557988523, 5993.752342871423, 6104.908426373608, 6115.938840611626, 6153.676959453739, 6162.722677479434, 6481.0, 6490.707918143695, 6499.155109835786, 6521.576097553644, 6540.672966351759, 5879.559033072536, 6100.969495152496, 6127.142200091991, 6180.752769889244, 6193.1329613854095, 3461.2212252243044, 3475.0, 3492.214251793377, 3515.525404070469, 3524.629913859008, 6542.607443553402, 6723.831904202434, 6768.123547492296, 6780.559263647946, 6796.932030679729, 6636.170478690164, 6654.035164901063, 6661.733530658719, 6672.733090676318, 6679.899801502981, 6537.411632953057, 6713.395794378529, 6723.22682891464, 6752.189737231465, 6756.797296081126, 6445.871082578416, 6462.935370646422, 6463.382330156294, 6504.1869766279215, 6512.3162067982175, 6233.594816336924, 6382.32985536512, 6390.808275751735, 6406.583572067801, 6439.388258115471, 6665.266820649822, 6712.429443497357, 6724.327567243236, 6732.461403087839, 6733.69698363565, 4506.504284528764, 4512.345709872116, 4528.0, 4546.522615125365, 4551.08978204367, 6330.3669633036325, 6476.319986401549, 6500.609963402211, 6525.836854078686, 6582.934170658232, 6264.2796078451565, 6296.442509981845, 6309.33751956038, 6321.778737744157, 6327.430531252209, 6144.078388241799, 6328.6900281397875, 6335.778247761306, 6347.428731414195, 6349.174607301022, 6210.782622608187, 6224.782132625336, 6236.906446403217, 6238.15784869055, 6275.403836635513, 6169.7300430769965, 6395.0, 6413.518986076157, 6414.102025716496, 6425.357464253537, 6209.59637623553, 6238.6880655967925, 6261.686915654108, 6281.780137695158, 6302.464290535172], "value": 4749.4561229953015, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [765.6745882999724, 770.9151993280742, 832.5004997001798, 838.9244967952883, 873.5544872115228, 13946.302684865766, 14333.426662933483, 14449.133052016874, 15537.922310388432, 15623.687526249469, 14514.491992780255, 14593.41626334948, 14623.415063397451, 14677.192754398504, 14720.484783032596, 702.8418605813703, 829.1128492512984, 849.452103393311, 849.4987957105337, 857.5969294431607, 840.4285086141422, 843.9789005274856, 844.7465760271924, 845.4462327175679, 846.2848892685702, 877.4340550345023, 883.3816328570026, 883.7083762358407, 883.9602217900177, 885.7121435533445, 884.062893333069, 884.3058199313508, 885.0529932971691, 886.5301390263171, 890.5146695051212, 643.6106155775735, 645.7384759172543, 646.5183438338421, 646.8156575375996, 649.3247023095975, 14711.264436778118, 14775.70448591033, 14799.852001479954, 14850.480233191895, 14902.180380079091, 13948.72102557943, 13977.79033314501, 14013.369398377097, 14111.0, 14322.64193395163, 11339.319640821495, 11469.94265028678, 11475.426228688531, 11742.354170520617, 11776.705582360424, 3874.2057878134915, 3883.262180185756, 3971.940420893689, 4081.4490043844294, 4085.428040074392, 55472.0, 55786.72106639481, 56284.43715562833, 57083.0, 57760.422395775924, 11463.828042579367, 11564.768704626029, 11612.361320127475, 11616.94191529054, 11668.591599294154, 20945.58108837845, 20986.370408887757, 21111.472213194793, 21138.365849024554, 21186.470338241357, 8467.306538692286, 8496.235338819535, 8498.830023399621, 8505.149485051568, 8554.0, 4729.763511824395, 4826.8069277228515, 4901.681390709592, 4920.163572192736, 4985.52637499437, 3514.789112653249, 3599.5140656011627, 3641.399169137063, 3651.8496673547747, 3652.3790955537625, 666.2072134160334, 667.1627107979551, 669.8091044052421, 670.2191946382508, 670.577536152221, 733.7725305155419, 746.3432179681954, 763.7288762489347, 777.1334961517866, 782.3662833105203, 9248.815023699623, 9427.764305892408, 9460.195883349992, 9471.573779179816, 9570.282228832866, 562.8536580489102, 629.9699990515448, 662.8475450646379, 728.6429649471827, 746.6192241956533, 4400.273954797487, 4410.470743510735, 4445.51099379068, 4446.866594002185, 4578.748168850679, 49260.50739492631, 50834.74582627137, 50920.23619645708, 51037.0, 61043.69478152581, 45066.549334506235, 45408.3188752169, 47873.5212647876, 48189.5181048192, 51624.741876290376, 43964.120717586105, 46040.53959460362, 46195.307070393974, 46807.531924680996, 48204.27693584599, 9114.36199466031, 9432.151106400457, 9499.192568631745, 9511.191548718436, 9597.28020398459, 32785.0, 33232.501512477815, 33381.49927751037, 33953.0, 34044.148896277795, 40509.59490405058, 41199.1760164801, 41490.170196595296, 41759.164816704106, 42701.35947960845, 12233.266004039786, 12529.310887901252, 12566.434510446868, 12575.543012146834, 12580.245185288912, 13555.0, 13690.589282321545, 13727.519536816562, 13769.931150344184, 13856.515021974183, 12955.287459189458, 13103.344832758514, 13315.66710832237, 13527.729445411234, 13557.25435101079, 12747.553835615709, 12914.096013279355, 13312.201267923569, 13546.458141674222, 13558.389872455566, 12274.386280686109, 12556.43496042662, 12853.357332133543, 13168.868311316764, 13228.206307621573, 10326.277160598986, 10544.683659490227, 10815.621453249098, 10856.891431085589, 10991.890081099407, 10833.29583577065, 10988.285761425483, 11008.614698485515, 11101.222914395914, 11223.102151827998], "value": 6849.7540178495465, "unit": "score"}], "name": "dromaeo_css", "value": 7160.480301524744, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 105.0, 112.0, 111.0, 113.0, 123.0, 111.0, 111.0, 113.0, 112.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 127.0, 155.0, 178.0, 129.0, 153.0, 158.0, 128.0, 178.0, 133.0], "value": 149.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 165.0, 161.0, 162.0, 165.0, 173.0, 162.0, 167.0, 166.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 75.0, 73.0, 162.0, 75.0, 74.0, 76.0, 72.0, 172.0, 78.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 151.0, 96.0, 94.0, 93.0, 145.0, 94.0, 93.0, 147.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 58.0, 58.0, 58.0, 60.0, 61.0, 72.0, 57.0, 55.0], "value": 59.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 63.0, 63.0, 62.0, 62.0, 62.0, 63.0, 62.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 79.0, 81.0, 82.0, 82.0, 81.0, 82.0, 96.0, 80.0, 83.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 146.0, 144.0, 134.0, 134.0, 132.0, 139.0, 141.0, 168.0, 137.0], "value": 140.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 172.0, 167.0, 166.0, 165.0, 164.0, 166.0, 173.0, 169.0, 170.0], "value": 168.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 70.0, 68.0, 66.0, 67.0, 71.0, 68.0, 70.0, 69.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1571.0, "alertThreshold": 2.0}]} 19:07:59 INFO - Return code: 0 19:07:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:07:59 ERROR - # TBPL SUCCESS # 19:07:59 INFO - Running post-action listener: _resource_record_post_action 19:07:59 INFO - Running post-run listener: _resource_record_post_run 19:08:01 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 520216576; Read time: 16; Write time: 337424 19:08:01 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 225566720; Read time: 0; Write time: 176544 19:08:01 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294649856; Read time: 16; Write time: 160880 19:08:01 INFO - Running post-run listener: _upload_blobber_files 19:08:01 INFO - Blob upload gear active. 19:08:01 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:08:01 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:08:01 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:08:01 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:08:01 INFO - (blobuploader) - INFO - Open directory for files ... 19:08:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:08:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:08:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:08:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:08:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:08:02 INFO - (blobuploader) - INFO - Done attempting. 19:08:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:08:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:08:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:08:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:08:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:08:03 INFO - (blobuploader) - INFO - Done attempting. 19:08:03 INFO - (blobuploader) - INFO - Iteration through files over. 19:08:03 INFO - Return code: 0 19:08:03 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:08:03 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:08:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f28c7010d8403b2dfc5d550fe2e5e8960d95dd8b69f8410b47a54239f1d6c2a6d93e2b90299ec3d97d108c4080b152296a07db7a81062810df170bea5e173587", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4812e677467b64a7b9226121e52bf62e7f4ffb1e2708be0c9adde1fbe4386b3439309e09084153c2ce2376a9b0f91f22aea28f974ecbcfb6e7357aeea1c96f6d"} 19:08:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:08:03 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:08:03 INFO - Contents: 19:08:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f28c7010d8403b2dfc5d550fe2e5e8960d95dd8b69f8410b47a54239f1d6c2a6d93e2b90299ec3d97d108c4080b152296a07db7a81062810df170bea5e173587", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4812e677467b64a7b9226121e52bf62e7f4ffb1e2708be0c9adde1fbe4386b3439309e09084153c2ce2376a9b0f91f22aea28f974ecbcfb6e7357aeea1c96f6d"} 19:08:03 INFO - Running post-run listener: copy_logs_to_upload_dir 19:08:03 INFO - Copying logs to upload dir... 19:08:03 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:08:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.936263 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-10 19:08:02.772137) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-10 19:08:02.775621) ========= 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=7cf709767345e0a0c5a90e72000001d4-1460331992.103744-1351850826 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/f28c7010d8403b2dfc5d550fe2e5e8960d95dd8b69f8410b47a54239f1d6c2a6d93e2b90299ec3d97d108c4080b152296a07db7a81062810df170bea5e173587", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4812e677467b64a7b9226121e52bf62e7f4ffb1e2708be0c9adde1fbe4386b3439309e09084153c2ce2376a9b0f91f22aea28f974ecbcfb6e7357aeea1c96f6d"} build_url:https://queue.taskcluster.net/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011448 build_url: 'https://queue.taskcluster.net/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.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/f28c7010d8403b2dfc5d550fe2e5e8960d95dd8b69f8410b47a54239f1d6c2a6d93e2b90299ec3d97d108c4080b152296a07db7a81062810df170bea5e173587", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4812e677467b64a7b9226121e52bf62e7f4ffb1e2708be0c9adde1fbe4386b3439309e09084153c2ce2376a9b0f91f22aea28f974ecbcfb6e7357aeea1c96f6d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-10 19:08:02.800422) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 19:08:02.800739) ========= 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=7cf709767345e0a0c5a90e72000001d4-1460331992.103744-1351850826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 19:08:02.885034) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-10 19:08:02.885351) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-10 19:08:02.885625) ========= ========= Total master_lag: 0.29 =========