builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1459907896.95 results: success (0) buildid: 20160405163018 builduid: f5a91c8370db48dbb99f36a333a77e6a revision: a235bfcc8c411169b82420c503775c1a3e7edad5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 18:58:16.954087) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 18:58:16.954813) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 18:58:16.955176) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1459907620.291583-287592194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006425 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 18:58:16.978982) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 18:58:16.979382) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 18:58:16.992685) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 18:58:16.993012) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1459907620.291583-287592194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004726 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 18:58:17.042211) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 18:58:17.042557) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 18:58:17.042966) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 18:58:17.043312) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1459907620.291583-287592194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-05 18:58:18-- 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% 22.6M=0.001s 2016-04-05 18:58:18 (22.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175359 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 18:58:17.231149) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 18:58:17.231535) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1459907620.291583-287592194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014928 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 18:58:17.281178) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 18:58:17.281587) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a235bfcc8c411169b82420c503775c1a3e7edad5 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a235bfcc8c411169b82420c503775c1a3e7edad5 --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=a12cd81e0ef515edd9e0d800000001bb-1459907620.291583-287592194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-05 18:58:18,907 truncating revision to first 12 chars 2016-04-05 18:58:18,907 Setting DEBUG logging. 2016-04-05 18:58:18,907 attempt 1/10 2016-04-05 18:58:18,907 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a235bfcc8c41?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-05 18:58:19,174 unpacking tar archive at: mozilla-central-a235bfcc8c41/testing/mozharness/ program finished with exit code 0 elapsedTime=0.550976 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 18:58:17.848001) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 18:58:17.848417) ========= echo a235bfcc8c411169b82420c503775c1a3e7edad5 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a235bfcc8c411169b82420c503775c1a3e7edad5'] 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=a12cd81e0ef515edd9e0d800000001bb-1459907620.291583-287592194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False a235bfcc8c411169b82420c503775c1a3e7edad5 program finished with exit code 0 elapsedTime=0.003434 script_repo_revision: 'a235bfcc8c411169b82420c503775c1a3e7edad5' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 18:58:17.896339) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 18:58:17.896684) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 18:58:17.906751) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-04-05 18:58:17.907074) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=a12cd81e0ef515edd9e0d800000001bb-1459907620.291583-287592194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:58:19 INFO - MultiFileLogger online at 20160405 18:58:19 in /builds/slave/test-pgo 18:58:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:58:19 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:58:19 INFO - {'append_to_log': False, 18:58:19 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:58:19 INFO - 'blob_upload_branch': 'Firefox', 18:58:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:58:19 INFO - 'branch': 'Firefox', 18:58:19 INFO - 'buildbot_json_path': 'buildprops.json', 18:58:19 INFO - 'config_files': ('talos/linux_config.py',), 18:58:19 INFO - 'default_actions': ('clobber', 18:58:19 INFO - 'read-buildbot-config', 18:58:19 INFO - 'download-and-extract', 18:58:19 INFO - 'populate-webroot', 18:58:19 INFO - 'create-virtualenv', 18:58:19 INFO - 'install', 18:58:19 INFO - 'run-tests'), 18:58:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:58:19 INFO - 'download_minidump_stackwalk': True, 18:58:19 INFO - 'download_symbols': 'ondemand', 18:58:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:58:19 INFO - 'tooltool.py': '/tools/tooltool.py', 18:58:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:58:19 INFO - '/tools/misc-python/virtualenv.py')}, 18:58:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:58:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:58:19 INFO - 'installer_path': 'installer.exe', 18:58:19 INFO - 'log_level': 'info', 18:58:19 INFO - 'log_name': 'talos', 18:58:19 INFO - 'log_to_console': True, 18:58:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:58:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:58:19 INFO - 'opt_config_files': (), 18:58:19 INFO - 'pip_index': False, 18:58:19 INFO - 'sps_profile': False, 18:58:19 INFO - 'sps_profile_interval': 0, 18:58:19 INFO - 'suite': 'dromaeojs-e10s', 18:58:19 INFO - 'system_bits': '32', 18:58:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:58:19 INFO - 'title': 'talos-linux64-ix-064', 18:58:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:58:19 INFO - 'use_talos_json': True, 18:58:19 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:58:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:58:19 INFO - 'work_dir': 'build'} 18:58:19 INFO - ##### 18:58:19 INFO - ##### Running clobber step. 18:58:19 INFO - ##### 18:58:19 INFO - Running pre-action listener: _resource_record_pre_action 18:58:19 INFO - Running main action method: clobber 18:58:19 INFO - rmtree: /builds/slave/test-pgo/build 18:58:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:58:20 INFO - Running post-action listener: _resource_record_post_action 18:58:20 INFO - ##### 18:58:20 INFO - ##### Running read-buildbot-config step. 18:58:20 INFO - ##### 18:58:20 INFO - Running pre-action listener: _resource_record_pre_action 18:58:20 INFO - Running main action method: read_buildbot_config 18:58:20 INFO - Using buildbot properties: 18:58:20 INFO - { 18:58:20 INFO - "project": "", 18:58:20 INFO - "product": "firefox", 18:58:20 INFO - "script_repo_revision": "production", 18:58:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:58:20 INFO - "repository": "", 18:58:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 18:58:20 INFO - "buildid": "20160405163018", 18:58:20 INFO - "pgo_build": "True", 18:58:20 INFO - "basedir": "/builds/slave/test-pgo", 18:58:20 INFO - "buildnumber": 164, 18:58:20 INFO - "slavename": "talos-linux64-ix-064", 18:58:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:58:20 INFO - "platform": "ubuntu64_hw", 18:58:20 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 18:58:20 INFO - "branch": "mozilla-central", 18:58:20 INFO - "repo_path": "mozilla-central", 18:58:20 INFO - "revision": "a235bfcc8c411169b82420c503775c1a3e7edad5", 18:58:20 INFO - "stage_platform": "linux64-pgo", 18:58:20 INFO - "builduid": "f5a91c8370db48dbb99f36a333a77e6a", 18:58:20 INFO - "slavebuilddir": "test" 18:58:20 INFO - } 18:58:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/KpC2WU6bQ92NhcpqRmXBhA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 18:58:20 INFO - Running post-action listener: _resource_record_post_action 18:58:20 INFO - ##### 18:58:20 INFO - ##### Running download-and-extract step. 18:58:20 INFO - ##### 18:58:20 INFO - Running pre-action listener: _resource_record_pre_action 18:58:20 INFO - Running main action method: download_and_extract 18:58:20 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:58:20 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:58:20 INFO - https://queue.taskcluster.net/v1/task/KpC2WU6bQ92NhcpqRmXBhA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:58:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpC2WU6bQ92NhcpqRmXBhA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:58:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpC2WU6bQ92NhcpqRmXBhA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:58:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpC2WU6bQ92NhcpqRmXBhA/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:58:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpC2WU6bQ92NhcpqRmXBhA/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:58:21 INFO - Downloaded 1361 bytes. 18:58:21 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:58:21 INFO - Using the following test package requirements: 18:58:21 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:58:21 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:58:21 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:58:21 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:21 INFO - u'jsshell-linux-x86_64.zip'], 18:58:21 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:58:21 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:58:21 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:58:21 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:58:21 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:58:21 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:58:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:58:21 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:58:21 INFO - https://queue.taskcluster.net/v1/task/KpC2WU6bQ92NhcpqRmXBhA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:58:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpC2WU6bQ92NhcpqRmXBhA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:58:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpC2WU6bQ92NhcpqRmXBhA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:58:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpC2WU6bQ92NhcpqRmXBhA/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:58:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpC2WU6bQ92NhcpqRmXBhA/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:58:22 INFO - Downloaded 23696295 bytes. 18:58:22 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:58:22 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:58:23 INFO - Return code: 0 18:58:23 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:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:23 INFO - https://queue.taskcluster.net/v1/task/KpC2WU6bQ92NhcpqRmXBhA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:58:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpC2WU6bQ92NhcpqRmXBhA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:58:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpC2WU6bQ92NhcpqRmXBhA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:58:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpC2WU6bQ92NhcpqRmXBhA/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:58:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpC2WU6bQ92NhcpqRmXBhA/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:58:26 INFO - Downloaded 23696295 bytes. 18:58:26 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:58:26 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:58:27 INFO - Return code: 0 18:58:27 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:58:27 INFO - https://queue.taskcluster.net/v1/task/KpC2WU6bQ92NhcpqRmXBhA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:58:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpC2WU6bQ92NhcpqRmXBhA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:58:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpC2WU6bQ92NhcpqRmXBhA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:58:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpC2WU6bQ92NhcpqRmXBhA/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:58:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpC2WU6bQ92NhcpqRmXBhA/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:58:28 INFO - Downloaded 10847617 bytes. 18:58:28 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:58:28 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:58:28 INFO - Return code: 0 18:58:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:28 INFO - https://queue.taskcluster.net/v1/task/KpC2WU6bQ92NhcpqRmXBhA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:58:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpC2WU6bQ92NhcpqRmXBhA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:58:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpC2WU6bQ92NhcpqRmXBhA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:58:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpC2WU6bQ92NhcpqRmXBhA/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:58:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpC2WU6bQ92NhcpqRmXBhA/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:58:30 INFO - Downloaded 57684678 bytes. 18:58:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KpC2WU6bQ92NhcpqRmXBhA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:58:30 INFO - mkdir: /builds/slave/test-pgo/properties 18:58:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:58:30 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:58:30 INFO - Contents: 18:58:30 INFO - build_url:https://queue.taskcluster.net/v1/task/KpC2WU6bQ92NhcpqRmXBhA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:58:31 INFO - Running post-action listener: _resource_record_post_action 18:58:31 INFO - Running post-action listener: set_extra_try_arguments 18:58:31 INFO - ##### 18:58:31 INFO - ##### Running populate-webroot step. 18:58:31 INFO - ##### 18:58:31 INFO - Running pre-action listener: _resource_record_pre_action 18:58:31 INFO - Running main action method: populate_webroot 18:58:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:58:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:58:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:58:31 INFO - '--tppagecycles', 18:58:31 INFO - '7'], 18:58:31 INFO - 'tests': ['tsvgm']}}, 18:58:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:58:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:58:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:58:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:58:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:58:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:58:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:31 INFO - 'talos_options': ['--disable-e10s'], 18:58:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:58:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:58:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:31 INFO - 'talos_options': ['--disable-e10s'], 18:58:31 INFO - 'tests': ['damp', 'tps']}, 18:58:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:31 INFO - 'tests': ['damp', 'tps']}, 18:58:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:58:31 INFO - 'tests': ['dromaeo_dom']}, 18:58:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:58:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:58:31 INFO - 'tests': ['a11yr', 18:58:31 INFO - 'ts_paint', 18:58:31 INFO - 'tpaint', 18:58:31 INFO - 'sessionrestore', 18:58:31 INFO - 'sessionrestore_no_auto_restore', 18:58:31 INFO - 'tabpaint']}, 18:58:31 INFO - 'other-e10s': {'tests': ['a11yr', 18:58:31 INFO - 'ts_paint', 18:58:31 INFO - 'tpaint', 18:58:31 INFO - 'sessionrestore', 18:58:31 INFO - 'sessionrestore_no_auto_restore', 18:58:31 INFO - 'tabpaint']}, 18:58:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:58:31 INFO - 'ts_paint', 18:58:31 INFO - 'tpaint', 18:58:31 INFO - 'sessionrestore', 18:58:31 INFO - 'sessionrestore_no_auto_restore', 18:58:31 INFO - 'tabpaint']}, 18:58:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:58:31 INFO - 'ts_paint', 18:58:31 INFO - 'tpaint', 18:58:31 INFO - 'sessionrestore', 18:58:31 INFO - 'sessionrestore_no_auto_restore', 18:58:31 INFO - 'tabpaint']}, 18:58:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:58:31 INFO - 'tests': ['a11yr', 18:58:31 INFO - 'ts_paint', 18:58:31 INFO - 'tpaint', 18:58:31 INFO - 'sessionrestore', 18:58:31 INFO - 'sessionrestore_no_auto_restore', 18:58:31 INFO - 'tabpaint']}, 18:58:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:58:31 INFO - 'tests': ['a11yr', 18:58:31 INFO - 'ts_paint', 18:58:31 INFO - 'tpaint', 18:58:31 INFO - 'sessionrestore', 18:58:31 INFO - 'sessionrestore_no_auto_restore', 18:58:31 INFO - 'tabpaint']}, 18:58:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:58:31 INFO - 'tests': ['tsvgx', 18:58:31 INFO - 'tsvgr_opacity', 18:58:31 INFO - 'tart', 18:58:31 INFO - 'tscrollx', 18:58:31 INFO - 'cart']}, 18:58:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:58:31 INFO - 'tsvgr_opacity', 18:58:31 INFO - 'tart', 18:58:31 INFO - 'tscrollx', 18:58:31 INFO - 'cart']}, 18:58:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:31 INFO - 'talos_options': ['--disable-e10s'], 18:58:31 INFO - 'tests': ['tp5o']}, 18:58:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:31 INFO - 'tests': ['tp5o']}, 18:58:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:31 INFO - 'talos_options': ['--disable-e10s', 18:58:31 INFO - '--xperf_path', 18:58:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:58:31 INFO - 'tests': ['tp5n']}, 18:58:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:31 INFO - 'talos_options': ['--xperf_path', 18:58:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:58:31 INFO - 'tests': ['tp5n']}}, 18:58:31 INFO - 'talos.zip': {'path': '', 18:58:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:58:31 INFO - Running post-action listener: _resource_record_post_action 18:58:31 INFO - ##### 18:58:31 INFO - ##### Running create-virtualenv step. 18:58:31 INFO - ##### 18:58:31 INFO - Running pre-action listener: _resource_record_pre_action 18:58:31 INFO - Running main action method: create_virtualenv 18:58:31 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:58:31 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:58:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:58:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:58:31 INFO - Using real prefix '/usr' 18:58:31 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:58:32 INFO - Installing distribute.............................................................................................................................................................................................done. 18:58:34 INFO - Installing pip.................done. 18:58:34 INFO - Return code: 0 18:58:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:58:34 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:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:34 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:58:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:34 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 0x7f2e112a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d78d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28668b0>, '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 0x28677b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2867c60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1459907620.291583-287592194', '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:58:34 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:58:34 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:58:34 INFO - Using env: {'DISPLAY': ':0', 18:58:34 INFO - 'HOME': '/home/cltbld', 18:58:34 INFO - 'LANG': 'en_US.UTF-8', 18:58:34 INFO - 'LANGUAGE': 'en_US:en', 18:58:34 INFO - 'LOGNAME': 'cltbld', 18:58:34 INFO - 'MAIL': '/var/mail/cltbld', 18:58:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:34 INFO - 'MOZ_NO_REMOTE': '1', 18:58:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:34 INFO - 'NO_EM_RESTART': '1', 18:58:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:58:34 INFO - 'PWD': '/builds/slave/test-pgo', 18:58:34 INFO - 'SHELL': '/bin/bash', 18:58:34 INFO - 'SHLVL': '1', 18:58:34 INFO - 'TERM': 'linux', 18:58:34 INFO - 'TMOUT': '86400', 18:58:34 INFO - 'USER': 'cltbld', 18:58:34 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1459907620.291583-287592194', 18:58:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:34 INFO - '_': '/tools/buildbot/bin/python'} 18:58:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:34 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:58:34 INFO - Cleaning up... 18:58:34 INFO - Return code: 0 18:58:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:58:34 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:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:34 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:58:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:34 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 0x7f2e112a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d78d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28668b0>, '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 0x28677b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2867c60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1459907620.291583-287592194', '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:58:34 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:58:34 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:58:34 INFO - Using env: {'DISPLAY': ':0', 18:58:34 INFO - 'HOME': '/home/cltbld', 18:58:34 INFO - 'LANG': 'en_US.UTF-8', 18:58:34 INFO - 'LANGUAGE': 'en_US:en', 18:58:34 INFO - 'LOGNAME': 'cltbld', 18:58:34 INFO - 'MAIL': '/var/mail/cltbld', 18:58:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:34 INFO - 'MOZ_NO_REMOTE': '1', 18:58:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:34 INFO - 'NO_EM_RESTART': '1', 18:58:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:58:34 INFO - 'PWD': '/builds/slave/test-pgo', 18:58:34 INFO - 'SHELL': '/bin/bash', 18:58:34 INFO - 'SHLVL': '1', 18:58:34 INFO - 'TERM': 'linux', 18:58:34 INFO - 'TMOUT': '86400', 18:58:34 INFO - 'USER': 'cltbld', 18:58:34 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1459907620.291583-287592194', 18:58:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:34 INFO - '_': '/tools/buildbot/bin/python'} 18:58:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:34 INFO - Downloading/unpacking psutil>=0.7.1 18:58:34 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:58:34 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:58:34 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:58:34 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:58:34 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:58:34 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:58:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:58:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:58:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:58:36 INFO - Installing collected packages: psutil 18:58:36 INFO - Running setup.py install for psutil 18:58:36 INFO - building 'psutil._psutil_linux' extension 18:58:36 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:58:36 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:58:36 INFO - building 'psutil._psutil_posix' extension 18:58:36 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:58:37 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:58:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:58:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:58:37 INFO - Successfully installed psutil 18:58:37 INFO - Cleaning up... 18:58:37 INFO - Return code: 0 18:58:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:58: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:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58: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:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:37 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 0x7f2e112a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d78d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28668b0>, '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 0x28677b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2867c60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1459907620.291583-287592194', '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:58:37 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:58:37 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:58:37 INFO - Using env: {'DISPLAY': ':0', 18:58:37 INFO - 'HOME': '/home/cltbld', 18:58:37 INFO - 'LANG': 'en_US.UTF-8', 18:58:37 INFO - 'LANGUAGE': 'en_US:en', 18:58:37 INFO - 'LOGNAME': 'cltbld', 18:58:37 INFO - 'MAIL': '/var/mail/cltbld', 18:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:37 INFO - 'MOZ_NO_REMOTE': '1', 18:58:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:37 INFO - 'NO_EM_RESTART': '1', 18:58:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:58:37 INFO - 'PWD': '/builds/slave/test-pgo', 18:58:37 INFO - 'SHELL': '/bin/bash', 18:58:37 INFO - 'SHLVL': '1', 18:58:37 INFO - 'TERM': 'linux', 18:58:37 INFO - 'TMOUT': '86400', 18:58:37 INFO - 'USER': 'cltbld', 18:58:37 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1459907620.291583-287592194', 18:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:37 INFO - '_': '/tools/buildbot/bin/python'} 18:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:58:37 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:58:37 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:58:37 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:58:37 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:58:37 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:58:37 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:58:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:58:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:58:39 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:58:39 INFO - Installing collected packages: mozsystemmonitor 18:58:39 INFO - Running setup.py install for mozsystemmonitor 18:58:39 INFO - Successfully installed mozsystemmonitor 18:58:39 INFO - Cleaning up... 18:58:39 INFO - Return code: 0 18:58:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2e112a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d78d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28668b0>, '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 0x28677b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2867c60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1459907620.291583-287592194', '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:58:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 18:58:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:58:39 INFO - Using env: {'DISPLAY': ':0', 18:58:39 INFO - 'HOME': '/home/cltbld', 18:58:39 INFO - 'LANG': 'en_US.UTF-8', 18:58:39 INFO - 'LANGUAGE': 'en_US:en', 18:58:39 INFO - 'LOGNAME': 'cltbld', 18:58:39 INFO - 'MAIL': '/var/mail/cltbld', 18:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:39 INFO - 'MOZ_NO_REMOTE': '1', 18:58:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:39 INFO - 'NO_EM_RESTART': '1', 18:58:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:58:39 INFO - 'PWD': '/builds/slave/test-pgo', 18:58:39 INFO - 'SHELL': '/bin/bash', 18:58:39 INFO - 'SHLVL': '1', 18:58:39 INFO - 'TERM': 'linux', 18:58:39 INFO - 'TMOUT': '86400', 18:58:39 INFO - 'USER': 'cltbld', 18:58:39 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1459907620.291583-287592194', 18:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:39 INFO - '_': '/tools/buildbot/bin/python'} 18:58:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:39 INFO - Downloading/unpacking blobuploader==1.2.4 18:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:41 INFO - Downloading blobuploader-1.2.4.tar.gz 18:58:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:58:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:58:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:58:42 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:58:42 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:58:42 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:58:42 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:58:42 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:58:42 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:58:42 INFO - Downloading docopt-0.6.1.tar.gz 18:58:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:58:42 INFO - Installing collected packages: blobuploader, requests, docopt 18:58:42 INFO - Running setup.py install for blobuploader 18:58:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:58:42 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:58:42 INFO - Running setup.py install for requests 18:58:42 INFO - Running setup.py install for docopt 18:58:42 INFO - Successfully installed blobuploader requests docopt 18:58:42 INFO - Cleaning up... 18:58:42 INFO - Return code: 0 18:58:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:42 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 0x7f2e112a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d78d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28668b0>, '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 0x28677b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2867c60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1459907620.291583-287592194', '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:58:42 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:58:42 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:58:43 INFO - Using env: {'DISPLAY': ':0', 18:58:43 INFO - 'HOME': '/home/cltbld', 18:58:43 INFO - 'LANG': 'en_US.UTF-8', 18:58:43 INFO - 'LANGUAGE': 'en_US:en', 18:58:43 INFO - 'LOGNAME': 'cltbld', 18:58:43 INFO - 'MAIL': '/var/mail/cltbld', 18:58:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:43 INFO - 'MOZ_NO_REMOTE': '1', 18:58:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:43 INFO - 'NO_EM_RESTART': '1', 18:58:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:58:43 INFO - 'PWD': '/builds/slave/test-pgo', 18:58:43 INFO - 'SHELL': '/bin/bash', 18:58:43 INFO - 'SHLVL': '1', 18:58:43 INFO - 'TERM': 'linux', 18:58:43 INFO - 'TMOUT': '86400', 18:58:43 INFO - 'USER': 'cltbld', 18:58:43 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1459907620.291583-287592194', 18:58:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:43 INFO - '_': '/tools/buildbot/bin/python'} 18:58:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:58:43 INFO - Running setup.py (path:/tmp/pip-1eF3kc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:58:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:58:43 INFO - Running setup.py (path:/tmp/pip-64mx_0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:58:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:58:43 INFO - Running setup.py (path:/tmp/pip-YoZdIy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:58:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:58:43 INFO - Running setup.py (path:/tmp/pip-WS1qVr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:58:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:58:43 INFO - Running setup.py (path:/tmp/pip-Mo4TMf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:58:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:58:43 INFO - Running setup.py (path:/tmp/pip-B2w06q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:58:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:58:43 INFO - Running setup.py (path:/tmp/pip-39wzyM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:58:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:58:43 INFO - Running setup.py (path:/tmp/pip-eiqUHH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:58:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:58:43 INFO - Running setup.py (path:/tmp/pip-Qukk63-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:58:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:58:43 INFO - Running setup.py (path:/tmp/pip-JmRqFR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:58:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:58:43 INFO - Running setup.py (path:/tmp/pip-meIQgp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:58:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:58:44 INFO - Running setup.py (path:/tmp/pip-pcfdm8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:58:44 INFO - Running setup.py (path:/tmp/pip-C9EUQ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:58:44 INFO - Running setup.py (path:/tmp/pip-PKXEPZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:58:44 INFO - Running setup.py (path:/tmp/pip-Y6s2wj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:58:44 INFO - Running setup.py (path:/tmp/pip-f_PDX0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:58:44 INFO - Running setup.py (path:/tmp/pip-bU30_i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:58:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:58:44 INFO - Running setup.py install for manifestparser 18:58:44 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:58:44 INFO - Running setup.py install for mozcrash 18:58:44 INFO - Running setup.py install for mozdebug 18:58:44 INFO - Running setup.py install for mozdevice 18:58:44 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:58:44 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:58:44 INFO - Running setup.py install for mozfile 18:58:44 INFO - Running setup.py install for mozhttpd 18:58:45 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:58:45 INFO - Running setup.py install for mozinfo 18:58:45 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:58:45 INFO - Running setup.py install for mozInstall 18:58:45 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:58:45 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:58:45 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:58:45 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:58:45 INFO - Running setup.py install for mozleak 18:58:45 INFO - Running setup.py install for mozlog 18:58:45 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:58:45 INFO - Running setup.py install for moznetwork 18:58:45 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:58:45 INFO - Running setup.py install for mozprocess 18:58:45 INFO - Running setup.py install for mozprofile 18:58:45 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:58:45 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:58:45 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:58:45 INFO - Running setup.py install for mozrunner 18:58:45 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:58:45 INFO - Running setup.py install for mozscreenshot 18:58:46 INFO - Running setup.py install for moztest 18:58:46 INFO - Running setup.py install for mozversion 18:58:46 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:58:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:58:46 INFO - Cleaning up... 18:58:46 INFO - Return code: 0 18:58:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:46 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 0x7f2e112a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d78d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28668b0>, '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 0x28677b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2867c60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1459907620.291583-287592194', '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:58:46 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:58:46 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:58:46 INFO - Using env: {'DISPLAY': ':0', 18:58:46 INFO - 'HOME': '/home/cltbld', 18:58:46 INFO - 'LANG': 'en_US.UTF-8', 18:58:46 INFO - 'LANGUAGE': 'en_US:en', 18:58:46 INFO - 'LOGNAME': 'cltbld', 18:58:46 INFO - 'MAIL': '/var/mail/cltbld', 18:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:46 INFO - 'MOZ_NO_REMOTE': '1', 18:58:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:46 INFO - 'NO_EM_RESTART': '1', 18:58:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:58:46 INFO - 'PWD': '/builds/slave/test-pgo', 18:58:46 INFO - 'SHELL': '/bin/bash', 18:58:46 INFO - 'SHLVL': '1', 18:58:46 INFO - 'TERM': 'linux', 18:58:46 INFO - 'TMOUT': '86400', 18:58:46 INFO - 'USER': 'cltbld', 18:58:46 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1459907620.291583-287592194', 18:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:46 INFO - '_': '/tools/buildbot/bin/python'} 18:58:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:58:46 INFO - Running setup.py (path:/tmp/pip-_8xVMf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:58:46 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:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:58:46 INFO - Running setup.py (path:/tmp/pip-5MaTmR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:58:46 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:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:58:46 INFO - Running setup.py (path:/tmp/pip-rwGIvW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:58:46 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:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:58:46 INFO - Running setup.py (path:/tmp/pip-DJbpqq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:58:46 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:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:58:46 INFO - Running setup.py (path:/tmp/pip-SQgRXI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:58:46 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:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:58:46 INFO - Running setup.py (path:/tmp/pip-Sn3pdu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:58:46 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:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:58:46 INFO - Running setup.py (path:/tmp/pip-IavYUF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:58:46 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:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:58:46 INFO - Running setup.py (path:/tmp/pip-Tj0g63-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:58:47 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:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:58:47 INFO - Running setup.py (path:/tmp/pip-8dRtIB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:58:47 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:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:58:47 INFO - Running setup.py (path:/tmp/pip-ygpeTQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:58:47 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:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:58:47 INFO - Running setup.py (path:/tmp/pip-2mXjfb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:58:47 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:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:58:47 INFO - Running setup.py (path:/tmp/pip-GkDX4O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:58:47 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:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:58:47 INFO - Running setup.py (path:/tmp/pip-XbE9pq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:58:47 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:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:58:47 INFO - Running setup.py (path:/tmp/pip-KwUVWm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:58:47 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:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:58:47 INFO - Running setup.py (path:/tmp/pip-AFasoa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:58:47 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:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:58:47 INFO - Running setup.py (path:/tmp/pip-fXWW98-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:58:47 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:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:58:47 INFO - Running setup.py (path:/tmp/pip-7fviue-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:58:47 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:58:47 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:58:47 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:58:47 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:58:47 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:58:47 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:58:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:58:47 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:58:47 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:58:47 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:58:47 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:58:47 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:58:47 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:58:49 INFO - Downloading blessings-1.6.tar.gz 18:58:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:58:49 INFO - Installing collected packages: blessings 18:58:49 INFO - Running setup.py install for blessings 18:58:49 INFO - Successfully installed blessings 18:58:49 INFO - Cleaning up... 18:58:49 INFO - Return code: 0 18:58:49 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:58:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:58:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:58:50 INFO - Reading from file tmpfile_stdout 18:58:50 INFO - Current package versions: 18:58:50 INFO - argparse == 1.2.1 18:58:50 INFO - blessings == 1.6 18:58:50 INFO - blobuploader == 1.2.4 18:58:50 INFO - docopt == 0.6.1 18:58:50 INFO - manifestparser == 1.1 18:58:50 INFO - mozInstall == 1.12 18:58:50 INFO - mozcrash == 0.17 18:58:50 INFO - mozdebug == 0.1 18:58:50 INFO - mozdevice == 0.48 18:58:50 INFO - mozfile == 1.2 18:58:50 INFO - mozhttpd == 0.7 18:58:50 INFO - mozinfo == 0.9 18:58:50 INFO - mozleak == 0.1 18:58:50 INFO - mozlog == 3.1 18:58:50 INFO - moznetwork == 0.27 18:58:50 INFO - mozprocess == 0.22 18:58:50 INFO - mozprofile == 0.28 18:58:50 INFO - mozrunner == 6.11 18:58:50 INFO - mozscreenshot == 0.1 18:58:50 INFO - mozsystemmonitor == 0.0 18:58:50 INFO - moztest == 0.7 18:58:50 INFO - mozversion == 1.4 18:58:50 INFO - psutil == 3.1.1 18:58:50 INFO - requests == 1.2.3 18:58:50 INFO - wsgiref == 0.1.2 18:58:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:58:50 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:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:50 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:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:50 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 0x7f2e112a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d78d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28668b0>, '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 0x28677b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2867c60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1459907620.291583-287592194', '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:58:50 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:58:50 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:58:50 INFO - Using env: {'DISPLAY': ':0', 18:58:50 INFO - 'HOME': '/home/cltbld', 18:58:50 INFO - 'LANG': 'en_US.UTF-8', 18:58:50 INFO - 'LANGUAGE': 'en_US:en', 18:58:50 INFO - 'LOGNAME': 'cltbld', 18:58:50 INFO - 'MAIL': '/var/mail/cltbld', 18:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:50 INFO - 'MOZ_NO_REMOTE': '1', 18:58:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:50 INFO - 'NO_EM_RESTART': '1', 18:58:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:58:50 INFO - 'PWD': '/builds/slave/test-pgo', 18:58:50 INFO - 'SHELL': '/bin/bash', 18:58:50 INFO - 'SHLVL': '1', 18:58:50 INFO - 'TERM': 'linux', 18:58:50 INFO - 'TMOUT': '86400', 18:58:50 INFO - 'USER': 'cltbld', 18:58:50 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1459907620.291583-287592194', 18:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:50 INFO - '_': '/tools/buildbot/bin/python'} 18:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:50 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:58:50 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:58:50 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:58:50 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:58:50 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:58:50 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:58:50 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:58:50 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:58:50 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:58:50 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:58:50 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:58:50 INFO - Cleaning up... 18:58:50 INFO - Return code: 0 18:58:50 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:58:50 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:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:50 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:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:50 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 0x7f2e112a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d78d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28668b0>, '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 0x28677b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2867c60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1459907620.291583-287592194', '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:58:50 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:58:50 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:58:50 INFO - Using env: {'DISPLAY': ':0', 18:58:50 INFO - 'HOME': '/home/cltbld', 18:58:50 INFO - 'LANG': 'en_US.UTF-8', 18:58:50 INFO - 'LANGUAGE': 'en_US:en', 18:58:50 INFO - 'LOGNAME': 'cltbld', 18:58:50 INFO - 'MAIL': '/var/mail/cltbld', 18:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:50 INFO - 'MOZ_NO_REMOTE': '1', 18:58:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:50 INFO - 'NO_EM_RESTART': '1', 18:58:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:58:50 INFO - 'PWD': '/builds/slave/test-pgo', 18:58:50 INFO - 'SHELL': '/bin/bash', 18:58:50 INFO - 'SHLVL': '1', 18:58:50 INFO - 'TERM': 'linux', 18:58:50 INFO - 'TMOUT': '86400', 18:58:50 INFO - 'USER': 'cltbld', 18:58:50 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1459907620.291583-287592194', 18:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:50 INFO - '_': '/tools/buildbot/bin/python'} 18:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:50 INFO - Downloading/unpacking jsonschema 18:58:50 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:58:50 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:58:50 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:58:50 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:58:50 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:58:50 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:58:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:58:52 INFO - Downloading/unpacking functools32 (from jsonschema) 18:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:52 INFO - Downloading functools32-3.2.3-2.tar.gz 18:58:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:58:52 INFO - warning: no files found matching '*.txt' 18:58:52 INFO - no previously-included directories found matching 'build' 18:58:52 INFO - no previously-included directories found matching 'dist' 18:58:52 INFO - no previously-included directories found matching '.git*' 18:58:52 INFO - Installing collected packages: jsonschema, functools32 18:58:52 INFO - Running setup.py install for functools32 18:58:52 INFO - warning: no files found matching '*.txt' 18:58:52 INFO - no previously-included directories found matching 'build' 18:58:52 INFO - no previously-included directories found matching 'dist' 18:58:52 INFO - no previously-included directories found matching '.git*' 18:58:52 INFO - Successfully installed jsonschema functools32 18:58:52 INFO - Cleaning up... 18:58:52 INFO - Return code: 0 18:58:52 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2e112a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d78d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28668b0>, '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 0x28677b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2867c60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1459907620.291583-287592194', '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:58:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 18:58:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:58:52 INFO - Using env: {'DISPLAY': ':0', 18:58:52 INFO - 'HOME': '/home/cltbld', 18:58:52 INFO - 'LANG': 'en_US.UTF-8', 18:58:52 INFO - 'LANGUAGE': 'en_US:en', 18:58:52 INFO - 'LOGNAME': 'cltbld', 18:58:52 INFO - 'MAIL': '/var/mail/cltbld', 18:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:52 INFO - 'MOZ_NO_REMOTE': '1', 18:58:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:52 INFO - 'NO_EM_RESTART': '1', 18:58:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:58:52 INFO - 'PWD': '/builds/slave/test-pgo', 18:58:52 INFO - 'SHELL': '/bin/bash', 18:58:52 INFO - 'SHLVL': '1', 18:58:52 INFO - 'TERM': 'linux', 18:58:52 INFO - 'TMOUT': '86400', 18:58:52 INFO - 'USER': 'cltbld', 18:58:52 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1459907620.291583-287592194', 18:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:52 INFO - '_': '/tools/buildbot/bin/python'} 18:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:53 INFO - Downloading/unpacking flake8 18:58: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:58: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:58: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:58: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:58: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:58: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:58:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:58:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:58:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:58: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:58: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:58: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:58: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:58: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:58: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:58:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:58: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:58: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:58: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:58: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:58: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:58: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:58:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:58:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:58:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:58:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:58:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:58:55 INFO - no previously-included directories found matching 'docs/_build' 18:58:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:58:55 INFO - Running setup.py install for pep8 18:58:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:58:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:58:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:58:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:58:55 INFO - no previously-included directories found matching 'docs/_build' 18:58:55 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:58:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:58:55 INFO - Cleaning up... 18:58:55 INFO - Return code: 0 18:58:55 INFO - Running post-action listener: _resource_record_post_action 18:58:55 INFO - Running post-action listener: _start_resource_monitoring 18:58:55 INFO - Starting resource monitoring. 18:58:55 INFO - ##### 18:58:55 INFO - ##### Running install step. 18:58:55 INFO - ##### 18:58:55 INFO - Running pre-action listener: _resource_record_pre_action 18:58:55 INFO - Running main action method: install 18:58:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:58:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:58:56 INFO - Reading from file tmpfile_stdout 18:58:56 INFO - Detecting whether we're running mozinstall >=1.0... 18:58:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:58:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:58:56 INFO - Reading from file tmpfile_stdout 18:58:56 INFO - Output received: 18:58:56 INFO - Usage: mozinstall [options] installer 18:58:56 INFO - Options: 18:58:56 INFO - -h, --help show this help message and exit 18:58:56 INFO - -d DEST, --destination=DEST 18:58:56 INFO - Directory to install application into. [default: 18:58:56 INFO - "/builds/slave/test-pgo"] 18:58:56 INFO - --app=APP Application being installed. [default: firefox] 18:58:56 INFO - mkdir: /builds/slave/test-pgo/build/application 18:58:56 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:58:56 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:59:12 INFO - Reading from file tmpfile_stdout 18:59:12 INFO - Output received: 18:59:12 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:59:12 INFO - Running post-action listener: _resource_record_post_action 18:59:12 INFO - ##### 18:59:12 INFO - ##### Running run-tests step. 18:59:12 INFO - ##### 18:59:12 INFO - Running pre-action listener: _resource_record_pre_action 18:59:12 INFO - Running main action method: run_tests 18:59:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:59:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:59:12 INFO - Python 2.7.3 18:59:12 INFO - Return code: 0 18:59:12 INFO - grabbing minidump binary from tooltool 18:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:59:12 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 0x28668b0>, '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 0x28677b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2867c60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:59:12 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:59:12 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:59:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:59:12 INFO - Return code: 0 18:59:12 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:59:12 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:59:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:59:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:59:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:59:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:59:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:59:13 INFO - Return code: 0 18:59:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KpC2WU6bQ92NhcpqRmXBhA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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:59:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KpC2WU6bQ92NhcpqRmXBhA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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:59:13 INFO - Using env: {'DISPLAY': ':0', 18:59:13 INFO - 'HOME': '/home/cltbld', 18:59:13 INFO - 'LANG': 'en_US.UTF-8', 18:59:13 INFO - 'LANGUAGE': 'en_US:en', 18:59:13 INFO - 'LOGNAME': 'cltbld', 18:59:13 INFO - 'MAIL': '/var/mail/cltbld', 18:59:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:59:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:13 INFO - 'MOZ_NO_REMOTE': '1', 18:59:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:59:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:13 INFO - 'NO_EM_RESTART': '1', 18:59:13 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:59:13 INFO - 'PWD': '/builds/slave/test-pgo', 18:59:13 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:59:13 INFO - 'SHELL': '/bin/bash', 18:59:13 INFO - 'SHLVL': '1', 18:59:13 INFO - 'TERM': 'linux', 18:59:13 INFO - 'TMOUT': '86400', 18:59:13 INFO - 'USER': 'cltbld', 18:59:13 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1459907620.291583-287592194', 18:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:13 INFO - '_': '/tools/buildbot/bin/python'} 18:59:13 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KpC2WU6bQ92NhcpqRmXBhA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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:59:13 INFO - mozversion application_buildid: 20160405163018 18:59:13 INFO - mozversion application_changeset: a235bfcc8c411169b82420c503775c1a3e7edad5 18:59:13 INFO - mozversion application_display_name: Nightly 18:59:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:59:13 INFO - mozversion application_name: Firefox 18:59:13 INFO - mozversion application_remotingname: firefox 18:59:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:59:13 INFO - mozversion application_vendor: Mozilla 18:59:13 INFO - mozversion application_version: 48.0a1 18:59:13 INFO - mozversion platform_buildid: 20160405163018 18:59:13 INFO - mozversion platform_changeset: a235bfcc8c411169b82420c503775c1a3e7edad5 18:59:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:59:13 INFO - mozversion platform_version: 48.0a1 18:59:13 INFO - using testdate: 1459907953 18:59:13 INFO - actual date: 1459907953 18:59:13 INFO - starting webserver on 'localhost:42749' 18:59:13 INFO - SUITE-START | Running 2 tests 18:59:13 INFO - TEST-START | dromaeo_css 18:59:13 INFO - operating with platform_type : linux_ 18:59:13 INFO - Initialising browser for dromaeo_css test... 18:59:13 INFO - TEST-INFO | started process 8349 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvJ56Dq/profile http://localhost:42749/getInfo.html) 18:59:18 INFO - PROCESS | 8349 | 18:59:18 INFO - PROCESS | 8349 | (process:8419): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:59:18 INFO - PROCESS | 8349 | 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:59:19 INFO - PROCESS | 8349 | __metrics Screen width/height:1600/1200 18:59:19 INFO - PROCESS | 8349 | colorDepth:24 18:59:19 INFO - PROCESS | 8349 | Browser inner width/height: 1024/697 18:59:19 INFO - PROCESS | 8349 | __metrics 18:59:19 ERROR - PROCESS | 8349 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 18:59:20 INFO - TEST-INFO | 8349: exit 0 18:59:20 INFO - Browser initialized. 18:59:20 INFO - Running cycle 1/1 for dromaeo_css test... 18:59:20 INFO - TEST-INFO | started process 8470 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvJ56Dq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:59:22 INFO - PROCESS | 8470 | 18:59:22 INFO - PROCESS | 8470 | (process:8530): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:59:32 INFO - PROCESS | 8470 | RSS: Main: 162881536 18:59:32 INFO - PROCESS | 8470 | 19:00:21 INFO - PROCESS | 8470 | 1459908021940 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] 19:02:29 INFO - PROCESS | 8470 | Cycle 1(1): loaded http://localhost:42749/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42749/tests/dromaeo/cssquery-ext.html) 19:02:30 INFO - PROCESS | 8470 | RSS: Main: 163274752 19:02:30 INFO - PROCESS | 8470 | 19:05:32 INFO - PROCESS | 8470 | Cycle 1(1): loaded http://localhost:42749/tests/dromaeo/cssquery-ext.html (next: http://localhost:42749/tests/dromaeo/cssquery-jquery.html) 19:05:32 INFO - PROCESS | 8470 | RSS: Main: 164204544 19:05:32 INFO - PROCESS | 8470 | 19:08:34 INFO - PROCESS | 8470 | Cycle 1(1): loaded http://localhost:42749/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42749/tests/dromaeo/cssquery-mootools.html) 19:08:35 INFO - PROCESS | 8470 | RSS: Main: 162705408 19:08:35 INFO - PROCESS | 8470 | 19:11:36 INFO - PROCESS | 8470 | Cycle 1(1): loaded http://localhost:42749/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42749/tests/dromaeo/cssquery-prototype.html) 19:11:37 INFO - PROCESS | 8470 | RSS: Main: 164208640 19:11:37 INFO - PROCESS | 8470 | 19:14:39 INFO - PROCESS | 8470 | Cycle 1(1): loaded http://localhost:42749/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42749/tests/dromaeo/cssquery-yui.html) 19:14:40 INFO - PROCESS | 8470 | RSS: Main: 163155968 19:14:40 INFO - PROCESS | 8470 | 19:17:42 INFO - PROCESS | 8470 | Cycle 1(1): loaded http://localhost:42749/tests/dromaeo/cssquery-yui.html (next: http://localhost:42749/tests/dromaeo/cssquery-dojo.html) 19:17:42 INFO - PROCESS | 8470 | RSS: Main: 165240832 19:17:42 INFO - PROCESS | 8470 | 19:17:42 INFO - PROCESS | 8470 | __start_tp_report 19:17:42 INFO - PROCESS | 8470 | _x_x_mozilla_page_load 19:17:42 INFO - PROCESS | 8470 | _x_x_mozilla_page_load_details 19:17:42 INFO - PROCESS | 8470 | |i|pagename|runs| 19:17:42 INFO - PROCESS | 8470 | |0;dojo.html;3134.091113577062;3211.1490455029407;3212.469942459494;3259.9511007334895;3263.102646772139;5349.491798279162;5384.7846086156505;5396.757145928433;5410.48600382964;5475.8357249282535;5264.868378290545;5390.676559406428;5441.455854414567;5481.945180548193;5485.9725701371435;4650.694294553568;4904.926426103611;4925.064237794808;5080.59355251579;5128.333316668828;5016;5086.821961231358;5089.414717307502;5091.643584949055;5098.872528186806;4757.738324392157;4859.3196952426515;4973.651844370896;5010.7494625268955;5047.520485553867;4927.876803079952;4939.58013568847;4940.382452193476;4953.678010929278;4991.700497970133;4914.557689807899;4949.08441938239;4953.306537084811;4959.231319145538;5002.974985125051;5218.321618189611;5301.734913254322;5345.545628621572;5353.03645343838;5395.217693434469;5721.885562288772;5751.913721294184;5756.683382413966;5762.625429347079;5776.133579962997;5640.717964101778;5743.224664670258;5757.309122905236;5760.654360738327;5764.538836893039;5367.946320536784;5412.972935135338;5416.10634245353;5478.945210547883;5513.393526712059;5922.082077278029;5941.405859414024;5949.851253718605;5958.702064896738;6000.969995149996;5554;5581.49766521015;5733.455321744427;5748.540116790647;5748.913766293509;5789.363170051291;5827.941720582825;5839.445252700986;5840.5035571976005;5884.676342801187;5651.378348381675;5760.942390576124;5824.504917082011;5825.213596164548;5833.066709326572;5412.07994640912;5653.604247702704;5717.4854263115685;5723.3418156912485;5800.303963524404;4415.470143582726;4420.778961051935;4430.468343798765;4469.262571675637;4481.170983368087;3938.8818335449982;3953.2093581283284;3953.9802300988313;3958.5645578986287;3995.9400608990886;5504.724763761796;5564.443555644403;5605.859853503695;5631.549476041907;5675.574331925122;5821.76712931478;5858.209141765892;5863;5870.354261031283;5880.26496687914;5584.748686309126;5589.496945274864;5593.300837395325;5595.300587426572;5601.047821870292;4863.489333619989;4986.202207646759;5006.599472042228;5062.291279220912;5069;5998.49012833914;6031.733335999402;6033.939660603425;6035.215421995113;6036.0644100164545;5843.5909486336395;5865.442782935615;5866.090755932837;5868.2664666916635;5872.031114865999;5835.883282334415;5964.910526342195;6042.516598672008;6072.1498990140535;6122.755089796358;5715.171300161536;5749.798757043483;5762.8847423050465;5763.337216220189;5774.335951365647;5617.185508101221;5848.093545500455;5855.619384739978;5857.707114644336;5859.062549991981;5561.916571251515;5661.66030038199;5696.458836410535;5717.37108918027;5738.397468265939;5658.321001479849;5663.546916246608;5697.943020569741;5702.429757024264;5747.5689323300085;5559.360673522597;5659.688717120598;5665.546756259571;5670.432956704297;5673.631213971244;5504.80733174337;5698.116791897262;5714.571407144564;5769.682667453162;5822.679752613647;5506.256655351476;5516.586256030733;5521.420250873601;5531.308586426697;5539.473749993744 19:17:42 INFO - PROCESS | 8470 | |1;ext.html;553.2061491759323;576.5963825322275;593.7239183779543;615.981520554383;620.8385819686881;37702;38059;38164;38329.80835095821;38358.23283534335;38545.61454385455;38849.61150388495;38988.61011389885;39031.243594038264;39052.60947390525;8390.202930721587;8525.44584601999;8561.14388561142;8566.871496927552;8580.099089595597;8542.572871356439;8686.826263474726;8732.825343493127;8744.650213991432;8759.824803503958;8742.650293988232;8812.911870881273;8816.382853200279;8816.691415800447;8831.95584022079;8703.782405439882;8704.521251331174;8745.99421066576;8780.385373023892;8798.296136309113;8668.959724833061;8765.73702788911;8769.298456123495;8773.868391974062;8779.956100219522;38780.224395511934;39067.41398879019;39096.80451597752;39229.41155882664;39275.23261453241;3390.8982730518123;3619.8914032579064;3672.3573374659327;3731.2724018816343;4036.3138266494766;29419.70580294191;29718.405631887243;29838.10485685433;30170.245743856358;30574.235644109074;4239.512456067561;4278.529361770203;4284.61438470536;4334.436523251957;4371.78141092944;314354;316730.4163479191;316943;317388;318269;48064.519354806005;65012;65398.67300663561;65436.67281663561;65486.67256663781;47623.761881190374;47679.76160119247;47769.5223047772;47780.5221947783;47857.282140767915;15081.773773393408;15153.090814551162;15266.923665381824;15318.923405382902;15320.616984575474;12516.74966500665;12636.178648387826;12640.494380224687;12649.87350126487;12661.177023493443;15829.208539573207;16218.837811621734;16264.83735162657;16270.105144217181;16284.918575407048;5957.731902064331;6058.545609079337;6127.908081378783;6177.96911015442;6267.341929097471;1021.0555236406294;1033.607229252879;1075.908547773448;1136.5510623303749;1152.458344578047;28516.287092822844;28614;28829.42341153165;29198.270043248664;29286.41427171487;1121.3216004317433;1139.2936379444798;1157.3634501024403;1171.1918776044502;1178.7858505739102;15426.228688565527;15446.691066178613;15502.84497155014;15752.68494630101;15934.362625495081;209873;209933;209949;210568;210982;58371;58893.70553147207;58982.41017589769;59095.40904590985;59178;1394;1394.1913690059741;1414.6675531250353;1429.5925661186511;1439.7480440923007;30327.090187294416;30396.392072158877;30552.84723576368;30593.388132236785;30770.53844192294;47158;47902.520974789804;47905.52094479011;48138.75930620325;48169.759151204016;279152;281545;282727;283222;284649;36448.27103457969;37076.25847482981;46605.76697116493;46983.29525057058;47282.763586183224;43818.34272485979;44473;44655.776721116184;45041.54958450505;45382.08533596889;40282.597174027884;40471.59528404796;41308.967275818344;41342.58657413387;41510.1697966045;38716.41925371065;39391.40912886251;39502.20995580015;40328.3950740745;40371.59628403679;39424.076443307946;40841.79579102204;41053.589464104974;41314.58685413228;41444.378334325615;33409.665903340654;35023.824880875436;35310.47034294436;35524.64475355214;35599.46600801042;27529.174124776287;27962.623177029367;27998.720012800426;28200.71799281981;28236 19:17:42 INFO - PROCESS | 8470 | |2;jquery.html;349.48451034723786;361.5733434547234;362.32788177929956;374.05737541395683;377.29634232157036;17324.133793310346;18105.909470452647;19732.506687332825;19736.111874965623;19754.604907901834;18216.089195540237;18600.255989760393;18658.06709664518;18665.90667046663;18741.06294685264;5465.508104270605;5703.001974654439;5737.598368114233;5738.0532212184935;5751.856203594902;4046.5953404659444;5627.7186140693;6149.692515374236;6376.681165941707;6424.967875160641;6300.590461620003;6322.399372059647;6324.841878953017;6330.556861019731;6347.873042539147;6019;6178.752849886022;6236.469900058501;6245.687715614201;6264.686765661721;5460.96241714077;5486.753096110645;5492.1212605982855;5515.862103447405;5516.841463292713;21641.242556510446;21693.783062169336;22016.44958876025;22330.88834555833;22415.439614009618;2378.857268563892;2421.4551725861716;2470.2465747946867;2514.7233804281514;2831.037447267918;14071.437142514389;14295.28523573817;14457.638559036108;14499.782503262459;14618.415263389452;1900.4108726294755;1942.2328180368675;1967.1246295398553;2025.756909170909;2070.4306315763133;68411;70062.64968675125;70818;70978.64510677465;71058.64470677613;9600.615975361046;9689.27330450219;10083.172493384012;10148.492575371349;10152.695419137437;13822.308884555732;13913.58259252224;13929;13964.324281086334;13980.790288145687;7962.203779621991;8044.678212871419;8066.878996815052;8112;8112.391570632226;7939.84120317602;8007.759767206993;8145.42981991255;8155.10293867674;8164.265216130577;5975.910361344583;6172.814815555541;6210.099535567318;6223.253209614784;6259.593126446766;1633.7631043498627;1691.1628743771912;1728.5231251059565;1743.4420985284587;1809.312461264711;1035.9226404539345;1039.4854546999284;1043.1081425381342;1107.2802678259195;1118.3234143343323;16089.356425743073;17211.827881721274;18258.26966921308;18292.725609115874;18858.81141188598;1033.5762337441613;1058.7564860082225;1097.2154909239773;1113.6937342230951;1122.5509796081633;10685;11026.283291586022;11153.275037122561;11179.10567154642;11233.887661123448;475609;478556;487498;496122;503293;69757;72430.63784681042;72452;72528;72579.63710181415;1054.9683509494728;1059.8357254625546;1070.9089727373105;1072.0298130192189;1072.2119242357016;16618.335266589685;16857;16947.830521694625;17056.317747290464;17098.658026839144;34073.148171294924;34273.828630857686;34286.65713342935;34365.828170858986;34902;45561.77219113883;46790.298145527166;46834.29748553706;47223.29165062458;47349.05301893874;7916;8110.878336825071;8125.4718443301;8145.144759800136;8281.171882811912;11684.948354647782;11953.820692689791;12480.75038499243;12811.295378754257;12964.416601253155;11048.337099774039;11179.496922638338;11227.101831853595;11300.83048754253;11433.371164586028;10809;10900.236983411402;11314.773704526027;11802.35087070185;11990.40047997614;11765.647030589096;11926.165168438127;11931.522739090686;12027.097967652637;12313;8002.599870006593;8083.070446898447;8160.653492173962;8214.876776848472;8303.543305118277;8346.165383461848;10568.89431105679;11503.597374092202;11509.13681473876;11567.132465065322 19:17:42 INFO - PROCESS | 8470 | |3;mootools.html;1491.0606318019647;1494.7757836324547;1670.9415170469028;1770.8494777943874;1803.4860064881511;6819.624920629363;7330.413566914647;7510.098788145417;7523.210062943394;7606.429517786174;7706.537607743539;7724.1117271513795;7779.455438119334;7811.062672479296;7828.5694286814205;2187.84685072045;2211.7345918489805;2212.9336119916347;2216.3572563956513;2224.0547767198955;2128.265748316828;2160.470684682255;2160.8703477791305;2161.1787520742096;2174.1955476473727;2163.7078994335798;2180.1388451561625;2187.9015444305046;2192.440927563469;2224.5773303072365;2222.7332720073614;2227.554489102186;2230.308604332662;2232.9888350558226;2242.551489702066;2153.6554151335713;2174.0760176924746;2179.7820217978233;2189.6058709432295;2194.846360754748;7889.684412623488;7908.130105688369;7940.205979402013;7943.721969731089;7945.165757595427;4875.317455556189;4973.403191616993;4985.700857948535;5000.47495013022;5006.1489546776775;3184.028871194285;3223.920571231566;3228.1159744984584;3356.6475520070285;3365.932681346384;1020.9846852297221;1033.2508931025022;1034.5551412892453;1047.9528421221064;1063.1601035182198;11051.557937682483;11057.170712196617;11106.61126860564;11107.889500994785;11114.722131946766;4174.582541745801;4202.810873510699;4283.7001409901;4292.656587472995;4299.742015479019;9376.812463750686;9383.483908384967;9400.200982916529;9426.151646351862;9442.10300021497;4926.433460152057;4942.382202224722;4945.851624451272;4954.058728841581;4961.156603377434;3921.9607803922167;4430.689851710349;4474;4547.3406356078185;4582.427196600425;3635.381985062546;3637.8726744563814;3676.779393236361;3687.2625474905126;3707.6848467879995;1056;1126.4342563836274;1134.704976706046;1142.6343570057668;1147.397616251458;1385.757492438819;1401.6425811418023;1424;1437.8634029767156;1448.8116544849313;7590.734324298623;7742.264484873928;7743.845123097506;7749.496282741604;7767.844643107106;1079.881213066562;1088.314361951965;1194.2893978083027;1196;1212.781699294118;6037.758489660452;6044.486218671374;6108.236470441195;6128.63228206309;6131.233595800525;9110.954445227864;9689;9712.660056897974;9797.853032204523;9860.950695246478;9512.33413661037;9538.141567258841;9560.808783824423;9617.56720947559;9650.034996500433;7337.449691273176;7580.734674286484;7589.962050189713;7626.580538070349;7635.121960974559;7370.15243247012;7394.7781566553085;7443.590602516913;7449.6275186241555;7451.850962980819;8564.700235491728;8602.526861022454;8654.048054714101;8690.435121717068;8741.125887411208;8415.410921235454;8885.555722213734;8953;8984.058767677621;9001.32490063261;6062.757489700362;6733.696983635846;6786.626735529593;6788.287229840796;6996.825079373057;7490.438217133627;7502.549847009197;7531.736389226351;7553.169151393233;7576.166621671501;6682.83292917681;6861.897071544031;6908.861822763416;6965.094537710065;7024.086868707035;6584.868302634016;6619.900701489385;6658.500612454182;6690.799276021728;6824.624645644537;6874.621895795779;6951.0616066830335;7018.368346848808;7025.367716905503;7030.648467576499;6703.899441508479;6777.525573209828;6782.152230971129;6796.966015169893;6799.898001529882;6653.800385988428;6737.090492783607;6752.527323087336;6754.86490270182;6763.93236067633 19:17:42 INFO - PROCESS | 8470 | |4;prototype.html;316.1669002179258;318.9091109033925;319.45054506249244;321.86642543344516;325.0508515135803;6366.458850997665;6674.2658307586125;6681.532292739505;6689.632070236135;6693.531452798306;6352.841178970528;6428.100065990765;6432.871342573146;6441.90337144942;6476.870462590746;4489.663275254353;4598.770061496912;4609.976950115253;4690.507496712848;4700.341952126705;4713.835015774449;4722.763861806913;4730.195866702668;4737.952620473803;4748.4301883774;4677.6959497632715;4692.272697731857;4692.460367057781;4707.505711900252;4716.292556116576;4701.130290896178;4716.103940251342;4718.834840780573;4721.6458765592715;4722.716637001774;4058.9188216235807;4059.756414615103;4062.3906414037833;4062.5937406259136;4072.1448495815916;6038.57729958903;6172.043333283348;6174.84562885927;6178.969105154445;6181.103739957726;5436.565074794007;5453.182022696587;5458;5459.535939445152;5466.426025267329;6666.133402657623;6672.46620270382;6711.9664401678165;6725.562838415487;6732.663366831688;4425.712328698656;4430.224710675619;4434.06884554244;4438.267685831834;4441.489228738672;6923.5499692520325;6955.4087902528345;6997.755078572276;7012.649367531603;7019.719211231544;4438.267685831802;4520.728756274634;4527.59251667345;4528.094381123722;4535.705179163344;4586.4496260448295;4594.333821595917;4598.977005114953;4601.907961840811;4602.4477062752685;5374.4625537445945;5415.106507426231;5423.3491980962535;5429.511343979061;5436.836894893159;6741.8651626967185;6746.325367463312;6746.392824645707;6750.898736518956;6765.391114799691;1603.1343074739743;1623.0586259969189;1623.6427985843095;1623.8132614749218;1626.6584017356251;987.2348929579633;1005.0452070532876;1008.6620981970975;1023.7235946294608;1031.3708637730979;6493.31820158886;6527.8694426111215;6581.901271480931;6582.572132811352;6586.967065164644;6943.166819981635;6976.895346569806;6979.8604027919155;6991.265917078736;6994.475414343843;6469.417752402306;6529.11856899322;6630.071789949411;6652.600843949379;6657.46740260778;3769.2838360711376;3819.6371344722206;3827.770333779982;3833.118382771978;3847.499825022785;7317;7322.0847394075745;7325.523840950428;7331.193568707438;7352.5220860643885;7156.212816590171;7170.032045673872;7172.820679483055;7176.318249766264;7176.605286709281;7211.645471947255;7255.637218139072;7330.083739532559;7338.119425668847;7342.706291748377;7012;7038.929610703827;7039.225685174524;7039.718411263492;7054;6907.792766217021;6912.619805910723;6921.2386637468835;6925.238223795278;6939.375456208965;7256.45576581769;7276.126864776261;7323.487355885037;7328.157261914948;7331.74338898136;4342.088161486124;4399.824007039682;4579.885502862455;4587.472440669366;4592.127495775792;6949.513534052568;6994.685239164148;7017.578945263301;7019.19279282889;7026.9648651756415;6769.932300677127;6774.051632771515;6784.626845523544;6788.558743681645;6792.966035169792;6768.08630834831;6776.7628133015105;6779.55932864382;6782.457403407617;6793.082933803873;6503.219613646393;6644.202695676549;6654.268030516542;6681.933180668326;6694.531382803157;6818.386345228755;6820.454363650797;6821.727130914906;6827.658617069027;6832.829179270558;6579.671016449254;6613.107230523818;6654.633995130314;6660.300668429745;6663.167104111986 19:17:42 INFO - PROCESS | 8470 | |5;yui.html;743.6281859070465;763.4121726270776;831.5592735849999;872.1496540872648;903.114947351595;13882.652933676663;14221.64445888852;14259.928700356484;14708.852911470909;14722.705545889075;13623.591292261222;13696.794548081787;13744;13781.72436551271;13793.24137172455;799.7480793550028;826.330672155553;826.9173082691743;827.0571548434759;831.563429199672;823.0206054794775;823.0329362998452;826.7354446577098;831.3349320543571;831.4138532334689;862.6764963138822;863.4517081653164;864.5461132905212;864.5893200729666;865.6364326982651;858.712331368989;859.3769517100084;860.0668274921718;861.7630151708267;862.995685021574;622.6824319597038;624.725120946782;626.9467095296906;631.2456614345858;633.4172561243666;14438.711225775425;14503.70992580153;14530.038444810027;14567.781483277759;14568.562943111723;12459.439325230387;12690.555830545978;12693.555725549653;12765.744685106245;12799.5520156795;9993.300468967174;10557.524911379007;10885.18361122919;10894.945525272324;11070.557177712963;3672.70618350534;3724.16206353571;3735.1595890924596;3826.885193444173;3837.9040523987123;47183.76408117972;47422;47543.52456475391;47629;47991.28013079806;9084.182423581777;9140.223081038186;9438.575264113131;9522.190613797766;9749.853752193723;16908.66182676364;16912.83087169137;16932.06873621938;16943.322267109423;16956.576085597957;7698;7799.181085986003;7882.211778822187;7886.881696774553;8068.273855353046;4411.9558804411545;4457.465104187519;4465.37484752135;4477.865664030084;4590.403247577793;3204.9839750801098;3222.9033129006166;3247.1395080303737;3252.5609042779397;3261.249912520134;572.3846864620549;592.623683960688;599.6761748655678;601.3955974245855;610.7068607068632;677.7187467201155;693.9548929319578;706.1455638677155;728.5337384074197;738.512581696078;8841.69054083104;8885.36571989801;8886;8892.377533572588;8975.192232699088;583.2971269620098;681.5808277909149;683.8974153876958;728.4245446097524;733.3912852332551;4244.151169766059;4350.8042138103865;4443.888902777392;4522.977385113053;4566.931496027562;64357;64581;65114;65131.67434162894;65259.67370163119;49367;52184.73907630514;52981.205281920804;53143.46856531462;53466.465335346926;53268.46731532713;53343.19985200225;53400.198997015075;54132.45867541353;54182.7290863551;8767.868481972902;8838.558072096497;8917.152870477294;9125.133112354315;9493.335466517277;39148;39353;40502.1899562013;40510;41026.79486602548;47323;48831.267530986355;51789;52325.47674523358;52397.7380113097;11370.20408571392;11373.943130284295;11667.299962002307;11756.177067605186;11988.040956723615;12508.374581271082;12790.168639038433;13046.673833154247;13581.253031083384;13734.175949443066;12418;12431.751364972832;12560;12848.871511284768;13292.468301267842;11532.192746507664;11876.762464750484;11959.402029898645;11966.70083247891;12119.45462454174;12316.753664926831;12470.189437686522;12535.373231338213;12545.184563003375;12554.623361299176;9701.417914925127;9886.357386769838;9957.352772070082;10086.79826403453;10185.185185185315;10016.085897697814;10148.086672199537;10204.438231696426;10222.591096356062;10256.897431025893 19:17:42 INFO - PROCESS | 8470 | __end_tp_report 19:17:42 INFO - PROCESS | 8470 | __start_cc_report 19:17:42 INFO - PROCESS | 8470 | _x_x_mozilla_cycle_collect,303 19:17:42 INFO - PROCESS | 8470 | __end_cc_report 19:17:42 INFO - PROCESS | 8470 | __startTimestamp1459909062552__endTimestamp 19:17:42 INFO - PROCESS | 8470 | 19:17:42 INFO - PROCESS | 8470 | ------- Summary: start ------- 19:17:42 INFO - PROCESS | 8470 | Number of tests: 6 19:17:42 INFO - PROCESS | 8470 | 19:17:42 INFO - PROCESS | 8470 | [#0] dojo.html Cycles:165 Average:5399.49 Median:5601.05 stddev:602.60 (10.8%) stddev-sans-first:577.65 19:17:42 INFO - PROCESS | 8470 | Values: 3134.1 3211.1 3212.5 3260.0 3263.1 5349.5 5384.8 5396.8 5410.5 5475.8 5264.9 5390.7 5441.5 5481.9 5486.0 4650.7 4904.9 4925.1 5080.6 5128.3 5016.0 5086.8 5089.4 5091.6 5098.9 4757.7 4859.3 4973.7 5010.7 5047.5 4927.9 4939.6 4940.4 4953.7 4991.7 4914.6 4949.1 4953.3 4959.2 5003.0 5218.3 5301.7 5345.5 5353.0 5395.2 5721.9 5751.9 5756.7 5762.6 5776.1 5640.7 5743.2 5757.3 5760.7 5764.5 5367.9 5413.0 5416.1 5478.9 5513.4 5922.1 5941.4 5949.9 5958.7 6001.0 5554.0 5581.5 5733.5 5748.5 5748.9 5789.4 5827.9 5839.4 5840.5 5884.7 5651.4 5760.9 5824.5 5825.2 5833.1 5412.1 5653.6 5717.5 5723.3 5800.3 4415.5 4420.8 4430.5 4469.3 4481.2 3938.9 3953.2 3954.0 3958.6 3995.9 5504.7 5564.4 5605.9 5631.5 5675.6 5821.8 5858.2 5863.0 5870.4 5880.3 5584.7 5589.5 5593.3 5595.3 5601.0 4863.5 4986.2 5006.6 5062.3 5069.0 5998.5 6031.7 6033.9 6035.2 6036.1 5843.6 5865.4 5866.1 5868.3 5872.0 5835.9 5964.9 6042.5 6072.1 6122.8 5715.2 5749.8 5762.9 5763.3 5774.3 5617.2 5848.1 5855.6 5857.7 5859.1 5561.9 5661.7 5696.5 5717.4 5738.4 5658.3 5663.5 5697.9 5702.4 5747.6 5559.4 5659.7 5665.5 5670.4 5673.6 5504.8 5698.1 5714.6 5769.7 5822.7 5506.3 5516.6 5521.4 5531.3 5539.5 19:17:42 INFO - PROCESS | 8470 | 19:17:42 INFO - PROCESS | 8470 | [#1] ext.html Cycles:180 Average:45127.44 Median:39009.93 stddev:71321.17 (182.8%) stddev-sans-first:71442.72 19:17:42 INFO - PROCESS | 8470 | Values: 553.2 576.6 593.7 616.0 620.8 37702.0 38059.0 38164.0 38329.8 38358.2 38545.6 38849.6 38988.6 39031.2 39052.6 8390.2 8525.4 8561.1 8566.9 8580.1 8542.6 8686.8 8732.8 8744.7 8759.8 8742.7 8812.9 8816.4 8816.7 8832.0 8703.8 8704.5 8746.0 8780.4 8798.3 8669.0 8765.7 8769.3 8773.9 8780.0 38780.2 39067.4 39096.8 39229.4 39275.2 3390.9 3619.9 3672.4 3731.3 4036.3 29419.7 29718.4 29838.1 30170.2 30574.2 4239.5 4278.5 4284.6 4334.4 4371.8 314354.0 316730.4 316943.0 317388.0 318269.0 48064.5 65012.0 65398.7 65436.7 65486.7 47623.8 47679.8 47769.5 47780.5 47857.3 15081.8 15153.1 15266.9 15318.9 15320.6 12516.7 12636.2 12640.5 12649.9 12661.2 15829.2 16218.8 16264.8 16270.1 16284.9 5957.7 6058.5 6127.9 6178.0 6267.3 1021.1 1033.6 1075.9 1136.6 1152.5 28516.3 28614.0 28829.4 29198.3 29286.4 1121.3 1139.3 1157.4 1171.2 1178.8 15426.2 15446.7 15502.8 15752.7 15934.4 209873.0 209933.0 209949.0 210568.0 210982.0 58371.0 58893.7 58982.4 59095.4 59178.0 1394.0 1394.2 1414.7 1429.6 1439.7 30327.1 30396.4 30552.8 30593.4 30770.5 47158.0 47902.5 47905.5 48138.8 48169.8 279152.0 281545.0 282727.0 283222.0 284649.0 36448.3 37076.3 46605.8 46983.3 47282.8 43818.3 44473.0 44655.8 45041.5 45382.1 40282.6 40471.6 41309.0 41342.6 41510.2 38716.4 39391.4 39502.2 40328.4 40371.6 39424.1 40841.8 41053.6 41314.6 41444.4 33409.7 35023.8 35310.5 35524.6 35599.5 27529.2 27962.6 27998.7 28200.7 28236.0 19:17:42 INFO - PROCESS | 8470 | 19:17:42 INFO - PROCESS | 8470 | [#2] jquery.html Cycles:180 Average:27514.52 Median:22373.16 stddev:79851.10 (356.9%) stddev-sans-first:80049.05 19:17:42 INFO - PROCESS | 8470 | Values: 349.5 361.6 362.3 374.1 377.3 17324.1 18105.9 19732.5 19736.1 19754.6 18216.1 18600.3 18658.1 18665.9 18741.1 5465.5 5703.0 5737.6 5738.1 5751.9 4046.6 5627.7 6149.7 6376.7 6425.0 6300.6 6322.4 6324.8 6330.6 6347.9 6019.0 6178.8 6236.5 6245.7 6264.7 5461.0 5486.8 5492.1 5515.9 5516.8 21641.2 21693.8 22016.4 22330.9 22415.4 2378.9 2421.5 2470.2 2514.7 2831.0 14071.4 14295.3 14457.6 14499.8 14618.4 1900.4 1942.2 1967.1 2025.8 2070.4 68411.0 70062.6 70818.0 70978.6 71058.6 9600.6 9689.3 10083.2 10148.5 10152.7 13822.3 13913.6 13929.0 13964.3 13980.8 7962.2 8044.7 8066.9 8112.0 8112.4 7939.8 8007.8 8145.4 8155.1 8164.3 5975.9 6172.8 6210.1 6223.3 6259.6 1633.8 1691.2 1728.5 1743.4 1809.3 1035.9 1039.5 1043.1 1107.3 1118.3 16089.4 17211.8 18258.3 18292.7 18858.8 1033.6 1058.8 1097.2 1113.7 1122.6 10685.0 11026.3 11153.3 11179.1 11233.9 475609.0 478556.0 487498.0 496122.0 503293.0 69757.0 72430.6 72452.0 72528.0 72579.6 1055.0 1059.8 1070.9 1072.0 1072.2 16618.3 16857.0 16947.8 17056.3 17098.7 34073.1 34273.8 34286.7 34365.8 34902.0 45561.8 46790.3 46834.3 47223.3 47349.1 7916.0 8110.9 8125.5 8145.1 8281.2 11684.9 11953.8 12480.8 12811.3 12964.4 11048.3 11179.5 11227.1 11300.8 11433.4 10809.0 10900.2 11314.8 11802.4 11990.4 11765.6 11926.2 11931.5 12027.1 12313.0 8002.6 8083.1 8160.7 8214.9 8303.5 8346.2 10568.9 11503.6 11509.1 11567.1 19:17:42 INFO - PROCESS | 8470 | 19:17:42 INFO - PROCESS | 8470 | [#3] mootools.html Cycles:180 Average:5559.41 Median:6358.05 stddev:2891.29 (45.5%) stddev-sans-first:2883.23 19:17:42 INFO - PROCESS | 8470 | Values: 1491.1 1494.8 1670.9 1770.8 1803.5 6819.6 7330.4 7510.1 7523.2 7606.4 7706.5 7724.1 7779.5 7811.1 7828.6 2187.8 2211.7 2212.9 2216.4 2224.1 2128.3 2160.5 2160.9 2161.2 2174.2 2163.7 2180.1 2187.9 2192.4 2224.6 2222.7 2227.6 2230.3 2233.0 2242.6 2153.7 2174.1 2179.8 2189.6 2194.8 7889.7 7908.1 7940.2 7943.7 7945.2 4875.3 4973.4 4985.7 5000.5 5006.1 3184.0 3223.9 3228.1 3356.6 3365.9 1021.0 1033.3 1034.6 1048.0 1063.2 11051.6 11057.2 11106.6 11107.9 11114.7 4174.6 4202.8 4283.7 4292.7 4299.7 9376.8 9383.5 9400.2 9426.2 9442.1 4926.4 4942.4 4945.9 4954.1 4961.2 3922.0 4430.7 4474.0 4547.3 4582.4 3635.4 3637.9 3676.8 3687.3 3707.7 1056.0 1126.4 1134.7 1142.6 1147.4 1385.8 1401.6 1424.0 1437.9 1448.8 7590.7 7742.3 7743.8 7749.5 7767.8 1079.9 1088.3 1194.3 1196.0 1212.8 6037.8 6044.5 6108.2 6128.6 6131.2 9111.0 9689.0 9712.7 9797.9 9861.0 9512.3 9538.1 9560.8 9617.6 9650.0 7337.4 7580.7 7590.0 7626.6 7635.1 7370.2 7394.8 7443.6 7449.6 7451.9 8564.7 8602.5 8654.0 8690.4 8741.1 8415.4 8885.6 8953.0 8984.1 9001.3 6062.8 6733.7 6786.6 6788.3 6996.8 7490.4 7502.5 7531.7 7553.2 7576.2 6682.8 6861.9 6908.9 6965.1 7024.1 6584.9 6619.9 6658.5 6690.8 6824.6 6874.6 6951.1 7018.4 7025.4 7030.6 6703.9 6777.5 6782.2 6797.0 6799.9 6653.8 6737.1 6752.5 6754.9 6763.9 19:17:42 INFO - PROCESS | 8470 | 19:17:42 INFO - PROCESS | 8470 | [#4] prototype.html Cycles:180 Average:5610.34 Median:6580.79 stddev:1770.28 (26.9%) stddev-sans-first:1730.07 19:17:42 INFO - PROCESS | 8470 | Values: 316.2 318.9 319.5 321.9 325.1 6366.5 6674.3 6681.5 6689.6 6693.5 6352.8 6428.1 6432.9 6441.9 6476.9 4489.7 4598.8 4610.0 4690.5 4700.3 4713.8 4722.8 4730.2 4738.0 4748.4 4677.7 4692.3 4692.5 4707.5 4716.3 4701.1 4716.1 4718.8 4721.6 4722.7 4058.9 4059.8 4062.4 4062.6 4072.1 6038.6 6172.0 6174.8 6179.0 6181.1 5436.6 5453.2 5458.0 5459.5 5466.4 6666.1 6672.5 6712.0 6725.6 6732.7 4425.7 4430.2 4434.1 4438.3 4441.5 6923.5 6955.4 6997.8 7012.6 7019.7 4438.3 4520.7 4527.6 4528.1 4535.7 4586.4 4594.3 4599.0 4601.9 4602.4 5374.5 5415.1 5423.3 5429.5 5436.8 6741.9 6746.3 6746.4 6750.9 6765.4 1603.1 1623.1 1623.6 1623.8 1626.7 987.2 1005.0 1008.7 1023.7 1031.4 6493.3 6527.9 6581.9 6582.6 6587.0 6943.2 6976.9 6979.9 6991.3 6994.5 6469.4 6529.1 6630.1 6652.6 6657.5 3769.3 3819.6 3827.8 3833.1 3847.5 7317.0 7322.1 7325.5 7331.2 7352.5 7156.2 7170.0 7172.8 7176.3 7176.6 7211.6 7255.6 7330.1 7338.1 7342.7 7012.0 7038.9 7039.2 7039.7 7054.0 6907.8 6912.6 6921.2 6925.2 6939.4 7256.5 7276.1 7323.5 7328.2 7331.7 4342.1 4399.8 4579.9 4587.5 4592.1 6949.5 6994.7 7017.6 7019.2 7027.0 6769.9 6774.1 6784.6 6788.6 6793.0 6768.1 6776.8 6779.6 6782.5 6793.1 6503.2 6644.2 6654.3 6681.9 6694.5 6818.4 6820.5 6821.7 6827.7 6832.8 6579.7 6613.1 6654.6 6660.3 6663.2 19:17:42 INFO - PROCESS | 8470 | 19:17:42 INFO - PROCESS | 8470 | [#5] yui.html Cycles:180 Average:14770.96 Median:47810.14 stddev:17458.85 (36.5%) stddev-sans-first:17476.05 19:17:42 INFO - PROCESS | 8470 | Values: 743.6 763.4 831.6 872.1 903.1 13882.7 14221.6 14259.9 14708.9 14722.7 13623.6 13696.8 13744.0 13781.7 13793.2 799.7 826.3 826.9 827.1 831.6 823.0 823.0 826.7 831.3 831.4 862.7 863.5 864.5 864.6 865.6 858.7 859.4 860.1 861.8 863.0 622.7 624.7 626.9 631.2 633.4 14438.7 14503.7 14530.0 14567.8 14568.6 12459.4 12690.6 12693.6 12765.7 12799.6 9993.3 10557.5 10885.2 10894.9 11070.6 3672.7 3724.2 3735.2 3826.9 3837.9 47183.8 47422.0 47543.5 47629.0 47991.3 9084.2 9140.2 9438.6 9522.2 9749.9 16908.7 16912.8 16932.1 16943.3 16956.6 7698.0 7799.2 7882.2 7886.9 8068.3 4412.0 4457.5 4465.4 4477.9 4590.4 3205.0 3222.9 3247.1 3252.6 3261.2 572.4 592.6 599.7 601.4 610.7 677.7 694.0 706.1 728.5 738.5 8841.7 8885.4 8886.0 8892.4 8975.2 583.3 681.6 683.9 728.4 733.4 4244.2 4350.8 4443.9 4523.0 4566.9 64357.0 64581.0 65114.0 65131.7 65259.7 49367.0 52184.7 52981.2 53143.5 53466.5 53268.5 53343.2 53400.2 54132.5 54182.7 8767.9 8838.6 8917.2 9125.1 9493.3 39148.0 39353.0 40502.2 40510.0 41026.8 47323.0 48831.3 51789.0 52325.5 52397.7 11370.2 11373.9 11667.3 11756.2 11988.0 12508.4 12790.2 13046.7 13581.3 13734.2 12418.0 12431.8 12560.0 12848.9 13292.5 11532.2 11876.8 11959.4 11966.7 12119.5 12316.8 12470.2 12535.4 12545.2 12554.6 9701.4 9886.4 9957.4 10086.8 10185.2 10016.1 10148.1 10204.4 10222.6 10256.9 19:17:42 INFO - PROCESS | 8470 | -------- Summary: end -------- 19:17:42 INFO - PROCESS | 8470 | 19:17:43 INFO - TEST-INFO | 8470: exit 0 19:17:43 INFO - TEST-OK | dromaeo_css | took 1109269ms 19:17:43 INFO - TEST-START | kraken 19:17:43 INFO - operating with platform_type : linux_ 19:17:43 INFO - Initialising browser for kraken test... 19:17:43 INFO - TEST-INFO | started process 8699 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKB7R44/profile http://localhost:42749/getInfo.html) 19:17:47 INFO - PROCESS | 8699 | 19:17:47 INFO - PROCESS | 8699 | (process:8770): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:17:47 INFO - PROCESS | 8699 | 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:17:47 INFO - PROCESS | 8699 | __metrics Screen width/height:1600/1200 19:17:47 INFO - PROCESS | 8699 | colorDepth:24 19:17:47 INFO - PROCESS | 8699 | Browser inner width/height: 1024/697 19:17:47 INFO - PROCESS | 8699 | __metrics 19:17:48 ERROR - PROCESS | 8699 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 19:17:49 INFO - TEST-INFO | 8699: exit 0 19:17:49 INFO - Browser initialized. 19:17:49 INFO - Running cycle 1/1 for kraken test... 19:17:49 INFO - TEST-INFO | started process 8820 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKB7R44/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:17:51 INFO - PROCESS | 8820 | 19:17:51 INFO - PROCESS | 8820 | (process:8879): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:18:01 INFO - PROCESS | 8820 | RSS: Main: 162693120 19:18:01 INFO - PROCESS | 8820 | 19:18:03 INFO - PROCESS | 8820 | Cycle 1(1): loaded http://localhost:42749/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42749/tests/kraken/driver.html?testName=audio-beat-detection) 19:18:04 INFO - PROCESS | 8820 | RSS: Main: 167686144 19:18:04 INFO - PROCESS | 8820 | 19:18:07 INFO - PROCESS | 8820 | Cycle 1(1): loaded http://localhost:42749/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42749/tests/kraken/driver.html?testName=audio-dft) 19:18:07 INFO - PROCESS | 8820 | RSS: Main: 170913792 19:18:07 INFO - PROCESS | 8820 | 19:18:10 INFO - PROCESS | 8820 | Cycle 1(1): loaded http://localhost:42749/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42749/tests/kraken/driver.html?testName=audio-fft) 19:18:11 INFO - PROCESS | 8820 | RSS: Main: 161964032 19:18:11 INFO - PROCESS | 8820 | 19:18:13 INFO - PROCESS | 8820 | Cycle 1(1): loaded http://localhost:42749/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42749/tests/kraken/driver.html?testName=audio-oscillator) 19:18:13 INFO - PROCESS | 8820 | RSS: Main: 162545664 19:18:13 INFO - PROCESS | 8820 | 19:18:16 INFO - PROCESS | 8820 | Cycle 1(1): loaded http://localhost:42749/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42749/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:18:16 INFO - PROCESS | 8820 | RSS: Main: 162811904 19:18:16 INFO - PROCESS | 8820 | 19:18:19 INFO - PROCESS | 8820 | Cycle 1(1): loaded http://localhost:42749/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42749/tests/kraken/driver.html?testName=imaging-darkroom) 19:18:20 INFO - PROCESS | 8820 | RSS: Main: 162942976 19:18:20 INFO - PROCESS | 8820 | 19:18:23 INFO - PROCESS | 8820 | Cycle 1(1): loaded http://localhost:42749/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42749/tests/kraken/driver.html?testName=imaging-desaturate) 19:18:24 INFO - PROCESS | 8820 | RSS: Main: 163549184 19:18:24 INFO - PROCESS | 8820 | 19:18:27 INFO - PROCESS | 8820 | Cycle 1(1): loaded http://localhost:42749/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42749/tests/kraken/driver.html?testName=json-parse-financial) 19:18:27 INFO - PROCESS | 8820 | RSS: Main: 166113280 19:18:27 INFO - PROCESS | 8820 | 19:18:29 INFO - PROCESS | 8820 | Cycle 1(1): loaded http://localhost:42749/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42749/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:18:29 INFO - PROCESS | 8820 | RSS: Main: 166043648 19:18:29 INFO - PROCESS | 8820 | 19:18:31 INFO - PROCESS | 8820 | Cycle 1(1): loaded http://localhost:42749/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42749/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:18:32 INFO - PROCESS | 8820 | RSS: Main: 166023168 19:18:32 INFO - PROCESS | 8820 | 19:18:34 INFO - PROCESS | 8820 | Cycle 1(1): loaded http://localhost:42749/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42749/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:18:34 INFO - PROCESS | 8820 | RSS: Main: 166531072 19:18:34 INFO - PROCESS | 8820 | 19:18:37 INFO - PROCESS | 8820 | Cycle 1(1): loaded http://localhost:42749/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42749/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:18:37 INFO - PROCESS | 8820 | RSS: Main: 166449152 19:18:37 INFO - PROCESS | 8820 | 19:18:40 INFO - PROCESS | 8820 | Cycle 1(1): loaded http://localhost:42749/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42749/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:18:41 INFO - PROCESS | 8820 | RSS: Main: 166359040 19:18:41 INFO - PROCESS | 8820 | 19:18:42 INFO - PROCESS | 8820 | Cycle 1(1): loaded http://localhost:42749/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42749/tests/kraken/driver.html?testName=ai-astar) 19:18:42 INFO - PROCESS | 8820 | RSS: Main: 168108032 19:18:42 INFO - PROCESS | 8820 | 19:18:42 INFO - PROCESS | 8820 | __start_tp_report 19:18:42 INFO - PROCESS | 8820 | _x_x_mozilla_page_load 19:18:42 INFO - PROCESS | 8820 | _x_x_mozilla_page_load_details 19:18:42 INFO - PROCESS | 8820 | |i|pagename|runs| 19:18:42 INFO - PROCESS | 8820 | |0;ai-astar;114;105;112;112;113;127;111;110;111;111 19:18:42 INFO - PROCESS | 8820 | |1;audio-beat-detection;172;128;166;172;129;160;159;130;179;128 19:18:42 INFO - PROCESS | 8820 | |2;audio-dft;162;163;162;162;162;161;163;168;169;162 19:18:42 INFO - PROCESS | 8820 | |3;audio-fft;74;77;76;77;75;77;77;72;166;77 19:18:42 INFO - PROCESS | 8820 | |4;audio-oscillator;93;93;136;93;94;93;136;93;95;147 19:18:42 INFO - PROCESS | 8820 | |5;imaging-gaussian-blur;117;118;117;118;122;117;117;117;118;118 19:18:42 INFO - PROCESS | 8820 | |6;imaging-darkroom;148;146;147;146;148;153;146;146;148;147 19:18:42 INFO - PROCESS | 8820 | |7;imaging-desaturate;96;97;96;96;95;96;95;95;96;96 19:18:42 INFO - PROCESS | 8820 | |8;json-parse-financial;60;57;57;61;57;56;57;59;56;54 19:18:42 INFO - PROCESS | 8820 | |9;json-stringify-tinderbox;61;61;62;61;61;61;61;66;62;62 19:18:42 INFO - PROCESS | 8820 | |10;stanford-crypto-aes;78;79;79;80;80;79;79;79;79;78 19:18:42 INFO - PROCESS | 8820 | |11;stanford-crypto-ccm;117;121;121;113;119;115;121;117;125;113 19:18:42 INFO - PROCESS | 8820 | |12;stanford-crypto-pbkdf2;149;153;149;143;142;143;155;143;147;143 19:18:42 INFO - PROCESS | 8820 | |13;stanford-crypto-sha256-iterative;64;65;66;63;67;74;62;64;62;63 19:18:42 INFO - PROCESS | 8820 | __end_tp_report 19:18:42 INFO - PROCESS | 8820 | __start_cc_report 19:18:42 INFO - PROCESS | 8820 | _x_x_mozilla_cycle_collect,864 19:18:42 INFO - PROCESS | 8820 | __end_cc_report 19:18:42 INFO - PROCESS | 8820 | __startTimestamp1459909122923__endTimestamp 19:18:42 INFO - PROCESS | 8820 | 19:18:42 INFO - PROCESS | 8820 | ------- Summary: start ------- 19:18:42 INFO - PROCESS | 8820 | Number of tests: 14 19:18:42 INFO - PROCESS | 8820 | 19:18:42 INFO - PROCESS | 8820 | [#0] ai-astar Cycles:10 Average:112.60 Median:112.00 stddev:5.60 (5.0%) stddev-sans-first:5.92 19:18:42 INFO - PROCESS | 8820 | Values: 114.0 105.0 112.0 112.0 113.0 127.0 111.0 110.0 111.0 111.0 19:18:42 INFO - PROCESS | 8820 | 19:18:42 INFO - PROCESS | 8820 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:163.00 stddev:21.09 (12.9%) stddev-sans-first:21.13 19:18:42 INFO - PROCESS | 8820 | Values: 172.0 128.0 166.0 172.0 129.0 160.0 159.0 130.0 179.0 128.0 19:18:42 INFO - PROCESS | 8820 | 19:18:42 INFO - PROCESS | 8820 | [#2] audio-dft Cycles:10 Average:163.40 Median:162.50 stddev:2.76 (1.7%) stddev-sans-first:2.88 19:18:42 INFO - PROCESS | 8820 | Values: 162.0 163.0 162.0 162.0 162.0 161.0 163.0 168.0 169.0 162.0 19:18:42 INFO - PROCESS | 8820 | 19:18:42 INFO - PROCESS | 8820 | [#3] audio-fft Cycles:10 Average:84.80 Median:77.00 stddev:28.58 (37.1%) stddev-sans-first:30.05 19:18:42 INFO - PROCESS | 8820 | Values: 74.0 77.0 76.0 77.0 75.0 77.0 77.0 72.0 166.0 77.0 19:18:42 INFO - PROCESS | 8820 | 19:18:42 INFO - PROCESS | 8820 | [#4] audio-oscillator Cycles:10 Average:107.30 Median:93.00 stddev:22.54 (24.2%) stddev-sans-first:23.31 19:18:42 INFO - PROCESS | 8820 | Values: 93.0 93.0 136.0 93.0 94.0 93.0 136.0 93.0 95.0 147.0 19:18:42 INFO - PROCESS | 8820 | 19:18:42 INFO - PROCESS | 8820 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:1.52 (1.3%) stddev-sans-first:1.58 19:18:42 INFO - PROCESS | 8820 | Values: 117.0 118.0 117.0 118.0 122.0 117.0 117.0 117.0 118.0 118.0 19:18:42 INFO - PROCESS | 8820 | 19:18:42 INFO - PROCESS | 8820 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:2.12 (1.4%) stddev-sans-first:2.24 19:18:42 INFO - PROCESS | 8820 | Values: 148.0 146.0 147.0 146.0 148.0 153.0 146.0 146.0 148.0 147.0 19:18:42 INFO - PROCESS | 8820 | 19:18:42 INFO - PROCESS | 8820 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 19:18:42 INFO - PROCESS | 8820 | Values: 96.0 97.0 96.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 19:18:42 INFO - PROCESS | 8820 | 19:18:42 INFO - PROCESS | 8820 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:57.00 stddev:2.07 (3.6%) stddev-sans-first:1.96 19:18:42 INFO - PROCESS | 8820 | Values: 60.0 57.0 57.0 61.0 57.0 56.0 57.0 59.0 56.0 54.0 19:18:42 INFO - PROCESS | 8820 | 19:18:42 INFO - PROCESS | 8820 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:61.50 stddev:1.55 (2.5%) stddev-sans-first:1.62 19:18:42 INFO - PROCESS | 8820 | Values: 61.0 61.0 62.0 61.0 61.0 61.0 61.0 66.0 62.0 62.0 19:18:42 INFO - PROCESS | 8820 | 19:18:42 INFO - PROCESS | 8820 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.00 stddev:0.67 (0.8%) stddev-sans-first:0.60 19:18:42 INFO - PROCESS | 8820 | Values: 78.0 79.0 79.0 80.0 80.0 79.0 79.0 79.0 79.0 78.0 19:18:42 INFO - PROCESS | 8820 | 19:18:42 INFO - PROCESS | 8820 | [#11] stanford-crypto-ccm Cycles:10 Average:118.20 Median:120.00 stddev:3.91 (3.3%) stddev-sans-first:4.12 19:18:42 INFO - PROCESS | 8820 | Values: 117.0 121.0 121.0 113.0 119.0 115.0 121.0 117.0 125.0 113.0 19:18:42 INFO - PROCESS | 8820 | 19:18:42 INFO - PROCESS | 8820 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.70 Median:148.00 stddev:4.67 (3.2%) stddev-sans-first:4.88 19:18:42 INFO - PROCESS | 8820 | Values: 149.0 153.0 149.0 143.0 142.0 143.0 155.0 143.0 147.0 143.0 19:18:42 INFO - PROCESS | 8820 | 19:18:42 INFO - PROCESS | 8820 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:64.50 stddev:3.56 (5.5%) stddev-sans-first:3.76 19:18:42 INFO - PROCESS | 8820 | Values: 64.0 65.0 66.0 63.0 67.0 74.0 62.0 64.0 62.0 63.0 19:18:42 INFO - PROCESS | 8820 | -------- Summary: end -------- 19:18:42 INFO - PROCESS | 8820 | 19:18:43 INFO - TEST-INFO | 8820: exit 0 19:18:43 INFO - TEST-OK | kraken | took 60576ms 19:18:43 INFO - SUITE-END | took 1169s 19:18:44 INFO - Completed test suite (00:19:30) 19:18:44 INFO - javascript benchmark 19:18:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3134.091113577062, 3211.1490455029407, 3212.469942459494, 3259.9511007334895, 3263.102646772139, 5349.491798279162, 5384.7846086156505, 5396.757145928433, 5410.48600382964, 5475.8357249282535, 5264.868378290545, 5390.676559406428, 5441.455854414567, 5481.945180548193, 5485.9725701371435, 4650.694294553568, 4904.926426103611, 4925.064237794808, 5080.59355251579, 5128.333316668828, 5016.0, 5086.821961231358, 5089.414717307502, 5091.643584949055, 5098.872528186806, 4757.738324392157, 4859.3196952426515, 4973.651844370896, 5010.7494625268955, 5047.520485553867, 4927.876803079952, 4939.58013568847, 4940.382452193476, 4953.678010929278, 4991.700497970133, 4914.557689807899, 4949.08441938239, 4953.306537084811, 4959.231319145538, 5002.974985125051, 5218.321618189611, 5301.734913254322, 5345.545628621572, 5353.03645343838, 5395.217693434469, 5721.885562288772, 5751.913721294184, 5756.683382413966, 5762.625429347079, 5776.133579962997, 5640.717964101778, 5743.224664670258, 5757.309122905236, 5760.654360738327, 5764.538836893039, 5367.946320536784, 5412.972935135338, 5416.10634245353, 5478.945210547883, 5513.393526712059, 5922.082077278029, 5941.405859414024, 5949.851253718605, 5958.702064896738, 6000.969995149996, 5554.0, 5581.49766521015, 5733.455321744427, 5748.540116790647, 5748.913766293509, 5789.363170051291, 5827.941720582825, 5839.445252700986, 5840.5035571976005, 5884.676342801187, 5651.378348381675, 5760.942390576124, 5824.504917082011, 5825.213596164548, 5833.066709326572, 5412.07994640912, 5653.604247702704, 5717.4854263115685, 5723.3418156912485, 5800.303963524404, 4415.470143582726, 4420.778961051935, 4430.468343798765, 4469.262571675637, 4481.170983368087, 3938.8818335449982, 3953.2093581283284, 3953.9802300988313, 3958.5645578986287, 3995.9400608990886, 5504.724763761796, 5564.443555644403, 5605.859853503695, 5631.549476041907, 5675.574331925122, 5821.76712931478, 5858.209141765892, 5863.0, 5870.354261031283, 5880.26496687914, 5584.748686309126, 5589.496945274864, 5593.300837395325, 5595.300587426572, 5601.047821870292, 4863.489333619989, 4986.202207646759, 5006.599472042228, 5062.291279220912, 5069.0, 5998.49012833914, 6031.733335999402, 6033.939660603425, 6035.215421995113, 6036.0644100164545, 5843.5909486336395, 5865.442782935615, 5866.090755932837, 5868.2664666916635, 5872.031114865999, 5835.883282334415, 5964.910526342195, 6042.516598672008, 6072.1498990140535, 6122.755089796358, 5715.171300161536, 5749.798757043483, 5762.8847423050465, 5763.337216220189, 5774.335951365647, 5617.185508101221, 5848.093545500455, 5855.619384739978, 5857.707114644336, 5859.062549991981, 5561.916571251515, 5661.66030038199, 5696.458836410535, 5717.37108918027, 5738.397468265939, 5658.321001479849, 5663.546916246608, 5697.943020569741, 5702.429757024264, 5747.5689323300085, 5559.360673522597, 5659.688717120598, 5665.546756259571, 5670.432956704297, 5673.631213971244, 5504.80733174337, 5698.116791897262, 5714.571407144564, 5769.682667453162, 5822.679752613647, 5506.256655351476, 5516.586256030733, 5521.420250873601, 5531.308586426697, 5539.473749993744], "unit": "score", "name": "dojo.html", "value": 5359.983313862024}, {"lowerIsBetter": false, "replicates": [553.2061491759323, 576.5963825322275, 593.7239183779543, 615.981520554383, 620.8385819686881, 37702.0, 38059.0, 38164.0, 38329.80835095821, 38358.23283534335, 38545.61454385455, 38849.61150388495, 38988.61011389885, 39031.243594038264, 39052.60947390525, 8390.202930721587, 8525.44584601999, 8561.14388561142, 8566.871496927552, 8580.099089595597, 8542.572871356439, 8686.826263474726, 8732.825343493127, 8744.650213991432, 8759.824803503958, 8742.650293988232, 8812.911870881273, 8816.382853200279, 8816.691415800447, 8831.95584022079, 8703.782405439882, 8704.521251331174, 8745.99421066576, 8780.385373023892, 8798.296136309113, 8668.959724833061, 8765.73702788911, 8769.298456123495, 8773.868391974062, 8779.956100219522, 38780.224395511934, 39067.41398879019, 39096.80451597752, 39229.41155882664, 39275.23261453241, 3390.8982730518123, 3619.8914032579064, 3672.3573374659327, 3731.2724018816343, 4036.3138266494766, 29419.70580294191, 29718.405631887243, 29838.10485685433, 30170.245743856358, 30574.235644109074, 4239.512456067561, 4278.529361770203, 4284.61438470536, 4334.436523251957, 4371.78141092944, 314354.0, 316730.4163479191, 316943.0, 317388.0, 318269.0, 48064.519354806005, 65012.0, 65398.67300663561, 65436.67281663561, 65486.67256663781, 47623.761881190374, 47679.76160119247, 47769.5223047772, 47780.5221947783, 47857.282140767915, 15081.773773393408, 15153.090814551162, 15266.923665381824, 15318.923405382902, 15320.616984575474, 12516.74966500665, 12636.178648387826, 12640.494380224687, 12649.87350126487, 12661.177023493443, 15829.208539573207, 16218.837811621734, 16264.83735162657, 16270.105144217181, 16284.918575407048, 5957.731902064331, 6058.545609079337, 6127.908081378783, 6177.96911015442, 6267.341929097471, 1021.0555236406294, 1033.607229252879, 1075.908547773448, 1136.5510623303749, 1152.458344578047, 28516.287092822844, 28614.0, 28829.42341153165, 29198.270043248664, 29286.41427171487, 1121.3216004317433, 1139.2936379444798, 1157.3634501024403, 1171.1918776044502, 1178.7858505739102, 15426.228688565527, 15446.691066178613, 15502.84497155014, 15752.68494630101, 15934.362625495081, 209873.0, 209933.0, 209949.0, 210568.0, 210982.0, 58371.0, 58893.70553147207, 58982.41017589769, 59095.40904590985, 59178.0, 1394.0, 1394.1913690059741, 1414.6675531250353, 1429.5925661186511, 1439.7480440923007, 30327.090187294416, 30396.392072158877, 30552.84723576368, 30593.388132236785, 30770.53844192294, 47158.0, 47902.520974789804, 47905.52094479011, 48138.75930620325, 48169.759151204016, 279152.0, 281545.0, 282727.0, 283222.0, 284649.0, 36448.27103457969, 37076.25847482981, 46605.76697116493, 46983.29525057058, 47282.763586183224, 43818.34272485979, 44473.0, 44655.776721116184, 45041.54958450505, 45382.08533596889, 40282.597174027884, 40471.59528404796, 41308.967275818344, 41342.58657413387, 41510.1697966045, 38716.41925371065, 39391.40912886251, 39502.20995580015, 40328.3950740745, 40371.59628403679, 39424.076443307946, 40841.79579102204, 41053.589464104974, 41314.58685413228, 41444.378334325615, 33409.665903340654, 35023.824880875436, 35310.47034294436, 35524.64475355214, 35599.46600801042, 27529.174124776287, 27962.623177029367, 27998.720012800426, 28200.71799281981, 28236.0], "unit": "score", "name": "ext.html", "value": 18797.87084088505}, {"lowerIsBetter": false, "replicates": [349.48451034723786, 361.5733434547234, 362.32788177929956, 374.05737541395683, 377.29634232157036, 17324.133793310346, 18105.909470452647, 19732.506687332825, 19736.111874965623, 19754.604907901834, 18216.089195540237, 18600.255989760393, 18658.06709664518, 18665.90667046663, 18741.06294685264, 5465.508104270605, 5703.001974654439, 5737.598368114233, 5738.0532212184935, 5751.856203594902, 4046.5953404659444, 5627.7186140693, 6149.692515374236, 6376.681165941707, 6424.967875160641, 6300.590461620003, 6322.399372059647, 6324.841878953017, 6330.556861019731, 6347.873042539147, 6019.0, 6178.752849886022, 6236.469900058501, 6245.687715614201, 6264.686765661721, 5460.96241714077, 5486.753096110645, 5492.1212605982855, 5515.862103447405, 5516.841463292713, 21641.242556510446, 21693.783062169336, 22016.44958876025, 22330.88834555833, 22415.439614009618, 2378.857268563892, 2421.4551725861716, 2470.2465747946867, 2514.7233804281514, 2831.037447267918, 14071.437142514389, 14295.28523573817, 14457.638559036108, 14499.782503262459, 14618.415263389452, 1900.4108726294755, 1942.2328180368675, 1967.1246295398553, 2025.756909170909, 2070.4306315763133, 68411.0, 70062.64968675125, 70818.0, 70978.64510677465, 71058.64470677613, 9600.615975361046, 9689.27330450219, 10083.172493384012, 10148.492575371349, 10152.695419137437, 13822.308884555732, 13913.58259252224, 13929.0, 13964.324281086334, 13980.790288145687, 7962.203779621991, 8044.678212871419, 8066.878996815052, 8112.0, 8112.391570632226, 7939.84120317602, 8007.759767206993, 8145.42981991255, 8155.10293867674, 8164.265216130577, 5975.910361344583, 6172.814815555541, 6210.099535567318, 6223.253209614784, 6259.593126446766, 1633.7631043498627, 1691.1628743771912, 1728.5231251059565, 1743.4420985284587, 1809.312461264711, 1035.9226404539345, 1039.4854546999284, 1043.1081425381342, 1107.2802678259195, 1118.3234143343323, 16089.356425743073, 17211.827881721274, 18258.26966921308, 18292.725609115874, 18858.81141188598, 1033.5762337441613, 1058.7564860082225, 1097.2154909239773, 1113.6937342230951, 1122.5509796081633, 10685.0, 11026.283291586022, 11153.275037122561, 11179.10567154642, 11233.887661123448, 475609.0, 478556.0, 487498.0, 496122.0, 503293.0, 69757.0, 72430.63784681042, 72452.0, 72528.0, 72579.63710181415, 1054.9683509494728, 1059.8357254625546, 1070.9089727373105, 1072.0298130192189, 1072.2119242357016, 16618.335266589685, 16857.0, 16947.830521694625, 17056.317747290464, 17098.658026839144, 34073.148171294924, 34273.828630857686, 34286.65713342935, 34365.828170858986, 34902.0, 45561.77219113883, 46790.298145527166, 46834.29748553706, 47223.29165062458, 47349.05301893874, 7916.0, 8110.878336825071, 8125.4718443301, 8145.144759800136, 8281.171882811912, 11684.948354647782, 11953.820692689791, 12480.75038499243, 12811.295378754257, 12964.416601253155, 11048.337099774039, 11179.496922638338, 11227.101831853595, 11300.83048754253, 11433.371164586028, 10809.0, 10900.236983411402, 11314.773704526027, 11802.35087070185, 11990.40047997614, 11765.647030589096, 11926.165168438127, 11931.522739090686, 12027.097967652637, 12313.0, 8002.599870006593, 8083.070446898447, 8160.653492173962, 8214.876776848472, 8303.543305118277, 8346.165383461848, 10568.89431105679, 11503.597374092202, 11509.13681473876, 11567.132465065322], "unit": "score", "name": "jquery.html", "value": 9070.806025211215}, {"lowerIsBetter": false, "replicates": [1491.0606318019647, 1494.7757836324547, 1670.9415170469028, 1770.8494777943874, 1803.4860064881511, 6819.624920629363, 7330.413566914647, 7510.098788145417, 7523.210062943394, 7606.429517786174, 7706.537607743539, 7724.1117271513795, 7779.455438119334, 7811.062672479296, 7828.5694286814205, 2187.84685072045, 2211.7345918489805, 2212.9336119916347, 2216.3572563956513, 2224.0547767198955, 2128.265748316828, 2160.470684682255, 2160.8703477791305, 2161.1787520742096, 2174.1955476473727, 2163.7078994335798, 2180.1388451561625, 2187.9015444305046, 2192.440927563469, 2224.5773303072365, 2222.7332720073614, 2227.554489102186, 2230.308604332662, 2232.9888350558226, 2242.551489702066, 2153.6554151335713, 2174.0760176924746, 2179.7820217978233, 2189.6058709432295, 2194.846360754748, 7889.684412623488, 7908.130105688369, 7940.205979402013, 7943.721969731089, 7945.165757595427, 4875.317455556189, 4973.403191616993, 4985.700857948535, 5000.47495013022, 5006.1489546776775, 3184.028871194285, 3223.920571231566, 3228.1159744984584, 3356.6475520070285, 3365.932681346384, 1020.9846852297221, 1033.2508931025022, 1034.5551412892453, 1047.9528421221064, 1063.1601035182198, 11051.557937682483, 11057.170712196617, 11106.61126860564, 11107.889500994785, 11114.722131946766, 4174.582541745801, 4202.810873510699, 4283.7001409901, 4292.656587472995, 4299.742015479019, 9376.812463750686, 9383.483908384967, 9400.200982916529, 9426.151646351862, 9442.10300021497, 4926.433460152057, 4942.382202224722, 4945.851624451272, 4954.058728841581, 4961.156603377434, 3921.9607803922167, 4430.689851710349, 4474.0, 4547.3406356078185, 4582.427196600425, 3635.381985062546, 3637.8726744563814, 3676.779393236361, 3687.2625474905126, 3707.6848467879995, 1056.0, 1126.4342563836274, 1134.704976706046, 1142.6343570057668, 1147.397616251458, 1385.757492438819, 1401.6425811418023, 1424.0, 1437.8634029767156, 1448.8116544849313, 7590.734324298623, 7742.264484873928, 7743.845123097506, 7749.496282741604, 7767.844643107106, 1079.881213066562, 1088.314361951965, 1194.2893978083027, 1196.0, 1212.781699294118, 6037.758489660452, 6044.486218671374, 6108.236470441195, 6128.63228206309, 6131.233595800525, 9110.954445227864, 9689.0, 9712.660056897974, 9797.853032204523, 9860.950695246478, 9512.33413661037, 9538.141567258841, 9560.808783824423, 9617.56720947559, 9650.034996500433, 7337.449691273176, 7580.734674286484, 7589.962050189713, 7626.580538070349, 7635.121960974559, 7370.15243247012, 7394.7781566553085, 7443.590602516913, 7449.6275186241555, 7451.850962980819, 8564.700235491728, 8602.526861022454, 8654.048054714101, 8690.435121717068, 8741.125887411208, 8415.410921235454, 8885.555722213734, 8953.0, 8984.058767677621, 9001.32490063261, 6062.757489700362, 6733.696983635846, 6786.626735529593, 6788.287229840796, 6996.825079373057, 7490.438217133627, 7502.549847009197, 7531.736389226351, 7553.169151393233, 7576.166621671501, 6682.83292917681, 6861.897071544031, 6908.861822763416, 6965.094537710065, 7024.086868707035, 6584.868302634016, 6619.900701489385, 6658.500612454182, 6690.799276021728, 6824.624645644537, 6874.621895795779, 6951.0616066830335, 7018.368346848808, 7025.367716905503, 7030.648467576499, 6703.899441508479, 6777.525573209828, 6782.152230971129, 6796.966015169893, 6799.898001529882, 6653.800385988428, 6737.090492783607, 6752.527323087336, 6754.86490270182, 6763.93236067633], "unit": "score", "name": "mootools.html", "value": 4569.669557504165}, {"lowerIsBetter": false, "replicates": [316.1669002179258, 318.9091109033925, 319.45054506249244, 321.86642543344516, 325.0508515135803, 6366.458850997665, 6674.2658307586125, 6681.532292739505, 6689.632070236135, 6693.531452798306, 6352.841178970528, 6428.100065990765, 6432.871342573146, 6441.90337144942, 6476.870462590746, 4489.663275254353, 4598.770061496912, 4609.976950115253, 4690.507496712848, 4700.341952126705, 4713.835015774449, 4722.763861806913, 4730.195866702668, 4737.952620473803, 4748.4301883774, 4677.6959497632715, 4692.272697731857, 4692.460367057781, 4707.505711900252, 4716.292556116576, 4701.130290896178, 4716.103940251342, 4718.834840780573, 4721.6458765592715, 4722.716637001774, 4058.9188216235807, 4059.756414615103, 4062.3906414037833, 4062.5937406259136, 4072.1448495815916, 6038.57729958903, 6172.043333283348, 6174.84562885927, 6178.969105154445, 6181.103739957726, 5436.565074794007, 5453.182022696587, 5458.0, 5459.535939445152, 5466.426025267329, 6666.133402657623, 6672.46620270382, 6711.9664401678165, 6725.562838415487, 6732.663366831688, 4425.712328698656, 4430.224710675619, 4434.06884554244, 4438.267685831834, 4441.489228738672, 6923.5499692520325, 6955.4087902528345, 6997.755078572276, 7012.649367531603, 7019.719211231544, 4438.267685831802, 4520.728756274634, 4527.59251667345, 4528.094381123722, 4535.705179163344, 4586.4496260448295, 4594.333821595917, 4598.977005114953, 4601.907961840811, 4602.4477062752685, 5374.4625537445945, 5415.106507426231, 5423.3491980962535, 5429.511343979061, 5436.836894893159, 6741.8651626967185, 6746.325367463312, 6746.392824645707, 6750.898736518956, 6765.391114799691, 1603.1343074739743, 1623.0586259969189, 1623.6427985843095, 1623.8132614749218, 1626.6584017356251, 987.2348929579633, 1005.0452070532876, 1008.6620981970975, 1023.7235946294608, 1031.3708637730979, 6493.31820158886, 6527.8694426111215, 6581.901271480931, 6582.572132811352, 6586.967065164644, 6943.166819981635, 6976.895346569806, 6979.8604027919155, 6991.265917078736, 6994.475414343843, 6469.417752402306, 6529.11856899322, 6630.071789949411, 6652.600843949379, 6657.46740260778, 3769.2838360711376, 3819.6371344722206, 3827.770333779982, 3833.118382771978, 3847.499825022785, 7317.0, 7322.0847394075745, 7325.523840950428, 7331.193568707438, 7352.5220860643885, 7156.212816590171, 7170.032045673872, 7172.820679483055, 7176.318249766264, 7176.605286709281, 7211.645471947255, 7255.637218139072, 7330.083739532559, 7338.119425668847, 7342.706291748377, 7012.0, 7038.929610703827, 7039.225685174524, 7039.718411263492, 7054.0, 6907.792766217021, 6912.619805910723, 6921.2386637468835, 6925.238223795278, 6939.375456208965, 7256.45576581769, 7276.126864776261, 7323.487355885037, 7328.157261914948, 7331.74338898136, 4342.088161486124, 4399.824007039682, 4579.885502862455, 4587.472440669366, 4592.127495775792, 6949.513534052568, 6994.685239164148, 7017.578945263301, 7019.19279282889, 7026.9648651756415, 6769.932300677127, 6774.051632771515, 6784.626845523544, 6788.558743681645, 6792.966035169792, 6768.08630834831, 6776.7628133015105, 6779.55932864382, 6782.457403407617, 6793.082933803873, 6503.219613646393, 6644.202695676549, 6654.268030516542, 6681.933180668326, 6694.531382803157, 6818.386345228755, 6820.454363650797, 6821.727130914906, 6827.658617069027, 6832.829179270558, 6579.671016449254, 6613.107230523818, 6654.633995130314, 6660.300668429745, 6663.167104111986], "unit": "score", "name": "prototype.html", "value": 5012.031007928312}, {"lowerIsBetter": false, "replicates": [743.6281859070465, 763.4121726270776, 831.5592735849999, 872.1496540872648, 903.114947351595, 13882.652933676663, 14221.64445888852, 14259.928700356484, 14708.852911470909, 14722.705545889075, 13623.591292261222, 13696.794548081787, 13744.0, 13781.72436551271, 13793.24137172455, 799.7480793550028, 826.330672155553, 826.9173082691743, 827.0571548434759, 831.563429199672, 823.0206054794775, 823.0329362998452, 826.7354446577098, 831.3349320543571, 831.4138532334689, 862.6764963138822, 863.4517081653164, 864.5461132905212, 864.5893200729666, 865.6364326982651, 858.712331368989, 859.3769517100084, 860.0668274921718, 861.7630151708267, 862.995685021574, 622.6824319597038, 624.725120946782, 626.9467095296906, 631.2456614345858, 633.4172561243666, 14438.711225775425, 14503.70992580153, 14530.038444810027, 14567.781483277759, 14568.562943111723, 12459.439325230387, 12690.555830545978, 12693.555725549653, 12765.744685106245, 12799.5520156795, 9993.300468967174, 10557.524911379007, 10885.18361122919, 10894.945525272324, 11070.557177712963, 3672.70618350534, 3724.16206353571, 3735.1595890924596, 3826.885193444173, 3837.9040523987123, 47183.76408117972, 47422.0, 47543.52456475391, 47629.0, 47991.28013079806, 9084.182423581777, 9140.223081038186, 9438.575264113131, 9522.190613797766, 9749.853752193723, 16908.66182676364, 16912.83087169137, 16932.06873621938, 16943.322267109423, 16956.576085597957, 7698.0, 7799.181085986003, 7882.211778822187, 7886.881696774553, 8068.273855353046, 4411.9558804411545, 4457.465104187519, 4465.37484752135, 4477.865664030084, 4590.403247577793, 3204.9839750801098, 3222.9033129006166, 3247.1395080303737, 3252.5609042779397, 3261.249912520134, 572.3846864620549, 592.623683960688, 599.6761748655678, 601.3955974245855, 610.7068607068632, 677.7187467201155, 693.9548929319578, 706.1455638677155, 728.5337384074197, 738.512581696078, 8841.69054083104, 8885.36571989801, 8886.0, 8892.377533572588, 8975.192232699088, 583.2971269620098, 681.5808277909149, 683.8974153876958, 728.4245446097524, 733.3912852332551, 4244.151169766059, 4350.8042138103865, 4443.888902777392, 4522.977385113053, 4566.931496027562, 64357.0, 64581.0, 65114.0, 65131.67434162894, 65259.67370163119, 49367.0, 52184.73907630514, 52981.205281920804, 53143.46856531462, 53466.465335346926, 53268.46731532713, 53343.19985200225, 53400.198997015075, 54132.45867541353, 54182.7290863551, 8767.868481972902, 8838.558072096497, 8917.152870477294, 9125.133112354315, 9493.335466517277, 39148.0, 39353.0, 40502.1899562013, 40510.0, 41026.79486602548, 47323.0, 48831.267530986355, 51789.0, 52325.47674523358, 52397.7380113097, 11370.20408571392, 11373.943130284295, 11667.299962002307, 11756.177067605186, 11988.040956723615, 12508.374581271082, 12790.168639038433, 13046.673833154247, 13581.253031083384, 13734.175949443066, 12418.0, 12431.751364972832, 12560.0, 12848.871511284768, 13292.468301267842, 11532.192746507664, 11876.762464750484, 11959.402029898645, 11966.70083247891, 12119.45462454174, 12316.753664926831, 12470.189437686522, 12535.373231338213, 12545.184563003375, 12554.623361299176, 9701.417914925127, 9886.357386769838, 9957.352772070082, 10086.79826403453, 10185.185185185315, 10016.085897697814, 10148.086672199537, 10204.438231696426, 10222.591096356062, 10256.897431025893], "unit": "score", "name": "yui.html", "value": 6624.964213672994}], "name": "dromaeo_css", "value": 7194.59226176963}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 105.0, 112.0, 112.0, 113.0, 127.0, 111.0, 110.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.6}, {"lowerIsBetter": true, "replicates": [172.0, 128.0, 166.0, 172.0, 129.0, 160.0, 159.0, 130.0, 179.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 152.3}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 162.0, 162.0, 161.0, 163.0, 168.0, 169.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.4}, {"lowerIsBetter": true, "replicates": [74.0, 77.0, 76.0, 77.0, 75.0, 77.0, 77.0, 72.0, 166.0, 77.0], "unit": "score", "name": "audio-fft", "value": 84.8}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 136.0, 93.0, 94.0, 93.0, 136.0, 93.0, 95.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 117.0, 118.0, 122.0, 117.0, 117.0, 117.0, 118.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.9}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 146.0, 148.0, 153.0, 146.0, 146.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.5}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [60.0, 57.0, 57.0, 61.0, 57.0, 56.0, 57.0, 59.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.4}, {"lowerIsBetter": true, "replicates": [61.0, 61.0, 62.0, 61.0, 61.0, 61.0, 61.0, 66.0, 62.0, 62.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 61.8}, {"lowerIsBetter": true, "replicates": [78.0, 79.0, 79.0, 80.0, 80.0, 79.0, 79.0, 79.0, 79.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.0}, {"lowerIsBetter": true, "replicates": [117.0, 121.0, 121.0, 113.0, 119.0, 115.0, 121.0, 117.0, 125.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.2}, {"lowerIsBetter": true, "replicates": [149.0, 153.0, 149.0, 143.0, 142.0, 143.0, 155.0, 143.0, 147.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.7}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 66.0, 63.0, 67.0, 74.0, 62.0, 64.0, 62.0, 63.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.0}], "name": "kraken", "value": 1509.6999999999998}]} 19:18:44 INFO - Return code: 0 19:18:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:18:44 ERROR - # TBPL SUCCESS # 19:18:44 INFO - Running post-action listener: _resource_record_post_action 19:18:44 INFO - Running post-run listener: _resource_record_post_run 19:18:45 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 12288; Write bytes: 542765056; Read time: 320; Write time: 733744 19:18:45 INFO - install - Wall time: 17s; CPU: 17.0%; Read bytes: 4096; Write bytes: 255180800; Read time: 280; Write time: 528468 19:18:45 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 8192; Write bytes: 287469568; Read time: 40; Write time: 205276 19:18:45 INFO - Running post-run listener: _upload_blobber_files 19:18:45 INFO - Blob upload gear active. 19:18:45 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:18:45 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:18:45 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 19:18:45 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 19:18:45 INFO - (blobuploader) - INFO - Open directory for files ... 19:18:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:18:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:18:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:18:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:18:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:18:46 INFO - (blobuploader) - INFO - Done attempting. 19:18:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:18:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:18:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:18:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:18:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:18:47 INFO - (blobuploader) - INFO - Done attempting. 19:18:47 INFO - (blobuploader) - INFO - Iteration through files over. 19:18:47 INFO - Return code: 0 19:18:47 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:18:47 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:18:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b72bd46a5ecbf2d0be97f4125bf3a6105c7e68fdbd8de94a4996cb582c072550fb2472bbfe4d0afdd516243860eb95eff45d494a1d8813776e8962260c0e3b44", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ced543e210941dca239948be3ae347e6b2eb9dec639bc1620b194c2ae530ccf8dc6e25cf5cce0cbcca9e2af7af550e31758b9680ef4c0f2c6541187d55babf3f"} 19:18:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:18:47 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:18:47 INFO - Contents: 19:18:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b72bd46a5ecbf2d0be97f4125bf3a6105c7e68fdbd8de94a4996cb582c072550fb2472bbfe4d0afdd516243860eb95eff45d494a1d8813776e8962260c0e3b44", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ced543e210941dca239948be3ae347e6b2eb9dec639bc1620b194c2ae530ccf8dc6e25cf5cce0cbcca9e2af7af550e31758b9680ef4c0f2c6541187d55babf3f"} 19:18:47 INFO - Running post-run listener: copy_logs_to_upload_dir 19:18:47 INFO - Copying logs to upload dir... 19:18:47 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:18:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.944389 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-04-05 19:18:45.857364) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 19:18:45.860770) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1459907620.291583-287592194 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/Firefox/sha512/b72bd46a5ecbf2d0be97f4125bf3a6105c7e68fdbd8de94a4996cb582c072550fb2472bbfe4d0afdd516243860eb95eff45d494a1d8813776e8962260c0e3b44", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ced543e210941dca239948be3ae347e6b2eb9dec639bc1620b194c2ae530ccf8dc6e25cf5cce0cbcca9e2af7af550e31758b9680ef4c0f2c6541187d55babf3f"} build_url:https://queue.taskcluster.net/v1/task/KpC2WU6bQ92NhcpqRmXBhA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011395 build_url: 'https://queue.taskcluster.net/v1/task/KpC2WU6bQ92NhcpqRmXBhA/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/Firefox/sha512/b72bd46a5ecbf2d0be97f4125bf3a6105c7e68fdbd8de94a4996cb582c072550fb2472bbfe4d0afdd516243860eb95eff45d494a1d8813776e8962260c0e3b44", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ced543e210941dca239948be3ae347e6b2eb9dec639bc1620b194c2ae530ccf8dc6e25cf5cce0cbcca9e2af7af550e31758b9680ef4c0f2c6541187d55babf3f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 19:18:45.886558) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 19:18:45.886898) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1459907620.291583-287592194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 19:18:45.973728) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 19:18:45.974325) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 19:18:45.974995) ========= ========= Total master_lag: 0.27 =========