builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-029 starttime: 1460599716.04 results: success (0) buildid: 20160413163022 builduid: ac8233eb54934396b4ff7d6ee3b4872b revision: bc2373295e31d99f9b870a1253b6e01650df8f31 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 19:08:36.038981) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 19:08:36.039499) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 19:08:36.039856) ========= 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=0274524eba3bdaad075c2247000001d4-1460595134.771347-1256880993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006474 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 19:08:36.070523) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 19:08:36.070893) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 19:08:36.085325) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 19:08:36.085628) ========= 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=0274524eba3bdaad075c2247000001d4-1460595134.771347-1256880993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004601 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 19:08:36.135974) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 19:08:36.136284) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 19:08:36.136669) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 19:08:36.137006) ========= 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=0274524eba3bdaad075c2247000001d4-1460595134.771347-1256880993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-13 19:08:36-- 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% 46.7M=0s 2016-04-13 19:08:36 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097326 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 19:08:36.247120) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 19:08:36.247474) ========= 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=0274524eba3bdaad075c2247000001d4-1460595134.771347-1256880993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022451 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 19:08:36.297856) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-13 19:08:36.298250) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bc2373295e31d99f9b870a1253b6e01650df8f31 --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 bc2373295e31d99f9b870a1253b6e01650df8f31 --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=0274524eba3bdaad075c2247000001d4-1460595134.771347-1256880993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-13 19:08:36,638 truncating revision to first 12 chars 2016-04-13 19:08:36,638 Setting DEBUG logging. 2016-04-13 19:08:36,638 attempt 1/10 2016-04-13 19:08:36,638 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bc2373295e31?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-13 19:08:37,581 unpacking tar archive at: mozilla-central-bc2373295e31/testing/mozharness/ program finished with exit code 0 elapsedTime=1.203685 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-13 19:08:37.515658) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 19:08:37.516092) ========= echo bc2373295e31d99f9b870a1253b6e01650df8f31 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'bc2373295e31d99f9b870a1253b6e01650df8f31'] 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=0274524eba3bdaad075c2247000001d4-1460595134.771347-1256880993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False bc2373295e31d99f9b870a1253b6e01650df8f31 program finished with exit code 0 elapsedTime=0.003947 script_repo_revision: 'bc2373295e31d99f9b870a1253b6e01650df8f31' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 19:08:37.566146) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 19:08:37.566496) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 19:08:37.580203) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-04-13 19:08:37.580568) ========= /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=0274524eba3bdaad075c2247000001d4-1460595134.771347-1256880993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:08:38 INFO - MultiFileLogger online at 20160413 19:08:38 in /builds/slave/test-pgo 19:08:38 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 19:08:38 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:08:38 INFO - {'append_to_log': False, 19:08:38 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:08:38 INFO - 'blob_upload_branch': 'Firefox', 19:08:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:08:38 INFO - 'branch': 'Firefox', 19:08:38 INFO - 'buildbot_json_path': 'buildprops.json', 19:08:38 INFO - 'config_files': ('talos/linux_config.py',), 19:08:38 INFO - 'default_actions': ('clobber', 19:08:38 INFO - 'read-buildbot-config', 19:08:38 INFO - 'download-and-extract', 19:08:38 INFO - 'populate-webroot', 19:08:38 INFO - 'create-virtualenv', 19:08:38 INFO - 'install', 19:08:38 INFO - 'run-tests'), 19:08:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:08:38 INFO - 'download_minidump_stackwalk': True, 19:08:38 INFO - 'download_symbols': 'ondemand', 19:08:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:08:38 INFO - 'tooltool.py': '/tools/tooltool.py', 19:08:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:08:38 INFO - '/tools/misc-python/virtualenv.py')}, 19:08:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:08:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:08:38 INFO - 'installer_path': 'installer.exe', 19:08:38 INFO - 'log_level': 'info', 19:08:38 INFO - 'log_name': 'talos', 19:08:38 INFO - 'log_to_console': True, 19:08:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:08:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:08:38 INFO - 'opt_config_files': (), 19:08:38 INFO - 'pip_index': False, 19:08:38 INFO - 'sps_profile': False, 19:08:38 INFO - 'sps_profile_interval': 0, 19:08:38 INFO - 'suite': 'dromaeojs-e10s', 19:08:38 INFO - 'system_bits': '32', 19:08:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:08:38 INFO - 'title': 'talos-linux64-ix-029', 19:08:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:08:38 INFO - 'use_talos_json': True, 19:08:38 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:08:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:08:38 INFO - 'work_dir': 'build'} 19:08:38 INFO - ##### 19:08:38 INFO - ##### Running clobber step. 19:08:38 INFO - ##### 19:08:38 INFO - Running pre-action listener: _resource_record_pre_action 19:08:38 INFO - Running main action method: clobber 19:08:38 INFO - rmtree: /builds/slave/test-pgo/build 19:08:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:08:39 INFO - Running post-action listener: _resource_record_post_action 19:08:39 INFO - ##### 19:08:39 INFO - ##### Running read-buildbot-config step. 19:08:39 INFO - ##### 19:08:39 INFO - Running pre-action listener: _resource_record_pre_action 19:08:39 INFO - Running main action method: read_buildbot_config 19:08:39 INFO - Using buildbot properties: 19:08:39 INFO - { 19:08:39 INFO - "project": "", 19:08:39 INFO - "product": "firefox", 19:08:39 INFO - "script_repo_revision": "production", 19:08:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:08:39 INFO - "repository": "", 19:08:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 19:08:39 INFO - "buildid": "20160413163022", 19:08:39 INFO - "pgo_build": "True", 19:08:39 INFO - "basedir": "/builds/slave/test-pgo", 19:08:39 INFO - "buildnumber": 413, 19:08:39 INFO - "slavename": "talos-linux64-ix-029", 19:08:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:08:39 INFO - "platform": "ubuntu64_hw", 19:08:39 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:08:39 INFO - "branch": "mozilla-central", 19:08:39 INFO - "repo_path": "mozilla-central", 19:08:39 INFO - "revision": "bc2373295e31d99f9b870a1253b6e01650df8f31", 19:08:39 INFO - "stage_platform": "linux64-pgo", 19:08:39 INFO - "builduid": "ac8233eb54934396b4ff7d6ee3b4872b", 19:08:39 INFO - "slavebuilddir": "test" 19:08:39 INFO - } 19:08:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/bEIea4yMSDy8y4-ni3t_tQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 19:08:39 INFO - Running post-action listener: _resource_record_post_action 19:08:39 INFO - ##### 19:08:39 INFO - ##### Running download-and-extract step. 19:08:39 INFO - ##### 19:08:39 INFO - Running pre-action listener: _resource_record_pre_action 19:08:39 INFO - Running main action method: download_and_extract 19:08:39 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:08: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')]} 19:08:39 INFO - https://queue.taskcluster.net/v1/task/bEIea4yMSDy8y4-ni3t_tQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:08:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEIea4yMSDy8y4-ni3t_tQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:08:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEIea4yMSDy8y4-ni3t_tQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:08:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEIea4yMSDy8y4-ni3t_tQ/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 19:08:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEIea4yMSDy8y4-ni3t_tQ/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 19:08:40 INFO - Downloaded 1361 bytes. 19:08:40 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:08:40 INFO - Using the following test package requirements: 19:08:40 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:08:40 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:40 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:08:40 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:40 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:08:40 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:40 INFO - u'jsshell-linux-x86_64.zip'], 19:08:40 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:40 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:08:40 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:08:40 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:40 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:08:40 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:40 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:08:40 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:40 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:08:40 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:40 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:08:40 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:40 INFO - https://queue.taskcluster.net/v1/task/bEIea4yMSDy8y4-ni3t_tQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:08:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEIea4yMSDy8y4-ni3t_tQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:08:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEIea4yMSDy8y4-ni3t_tQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:08:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEIea4yMSDy8y4-ni3t_tQ/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 19:08:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEIea4yMSDy8y4-ni3t_tQ/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 19:08:41 INFO - Downloaded 23774060 bytes. 19:08:41 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'] 19:08:41 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 19:08:43 INFO - Return code: 0 19:08:43 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 19:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:43 INFO - https://queue.taskcluster.net/v1/task/bEIea4yMSDy8y4-ni3t_tQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:08:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEIea4yMSDy8y4-ni3t_tQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:08:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEIea4yMSDy8y4-ni3t_tQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:08:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEIea4yMSDy8y4-ni3t_tQ/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 19:08:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEIea4yMSDy8y4-ni3t_tQ/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 19:08:44 INFO - Downloaded 23774060 bytes. 19:08:44 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'] 19:08:44 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 19:08:46 INFO - Return code: 0 19:08: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')]} 19:08:46 INFO - https://queue.taskcluster.net/v1/task/bEIea4yMSDy8y4-ni3t_tQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:08:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEIea4yMSDy8y4-ni3t_tQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:08:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEIea4yMSDy8y4-ni3t_tQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:08:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEIea4yMSDy8y4-ni3t_tQ/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 19:08:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEIea4yMSDy8y4-ni3t_tQ/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 19:08:46 INFO - Downloaded 10841076 bytes. 19:08:46 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'] 19:08:46 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 19:08:47 INFO - Return code: 0 19:08:47 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')]} 19:08:47 INFO - https://queue.taskcluster.net/v1/task/bEIea4yMSDy8y4-ni3t_tQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:08:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEIea4yMSDy8y4-ni3t_tQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:08:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEIea4yMSDy8y4-ni3t_tQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:08:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEIea4yMSDy8y4-ni3t_tQ/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 19:08:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEIea4yMSDy8y4-ni3t_tQ/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 19:08:48 INFO - Downloaded 57861640 bytes. 19:08:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bEIea4yMSDy8y4-ni3t_tQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:08:48 INFO - mkdir: /builds/slave/test-pgo/properties 19:08:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:08:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:08:48 INFO - Contents: 19:08:48 INFO - build_url:https://queue.taskcluster.net/v1/task/bEIea4yMSDy8y4-ni3t_tQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:08:49 INFO - Running post-action listener: _resource_record_post_action 19:08:49 INFO - Running post-action listener: set_extra_try_arguments 19:08:49 INFO - ##### 19:08:49 INFO - ##### Running populate-webroot step. 19:08:49 INFO - ##### 19:08:49 INFO - Running pre-action listener: _resource_record_pre_action 19:08:49 INFO - Running main action method: populate_webroot 19:08:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:08:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:08:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:08:49 INFO - '--tppagecycles', 19:08:49 INFO - '7'], 19:08:49 INFO - 'tests': ['tsvgm']}}, 19:08:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:08:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:08:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:08:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:08:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:08:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:08:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:49 INFO - 'talos_options': ['--disable-e10s'], 19:08:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:08:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:08:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:49 INFO - 'talos_options': ['--disable-e10s'], 19:08:49 INFO - 'tests': ['damp', 'tps']}, 19:08:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:49 INFO - 'tests': ['damp', 'tps']}, 19:08:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:08:49 INFO - 'tests': ['dromaeo_dom']}, 19:08:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:08:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:08:49 INFO - 'tests': ['a11yr', 19:08:49 INFO - 'ts_paint', 19:08:49 INFO - 'tpaint', 19:08:49 INFO - 'sessionrestore', 19:08:49 INFO - 'sessionrestore_no_auto_restore', 19:08:49 INFO - 'tabpaint']}, 19:08:49 INFO - 'other-e10s': {'tests': ['a11yr', 19:08:49 INFO - 'ts_paint', 19:08:49 INFO - 'tpaint', 19:08:49 INFO - 'sessionrestore', 19:08:49 INFO - 'sessionrestore_no_auto_restore', 19:08:49 INFO - 'tabpaint']}, 19:08:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:08:49 INFO - 'ts_paint', 19:08:49 INFO - 'tpaint', 19:08:49 INFO - 'sessionrestore', 19:08:49 INFO - 'sessionrestore_no_auto_restore', 19:08:49 INFO - 'tabpaint']}, 19:08:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:08:49 INFO - 'ts_paint', 19:08:49 INFO - 'tpaint', 19:08:49 INFO - 'sessionrestore', 19:08:49 INFO - 'sessionrestore_no_auto_restore', 19:08:49 INFO - 'tabpaint']}, 19:08:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:08:49 INFO - 'tests': ['a11yr', 19:08:49 INFO - 'ts_paint', 19:08:49 INFO - 'tpaint', 19:08:49 INFO - 'sessionrestore', 19:08:49 INFO - 'sessionrestore_no_auto_restore', 19:08:49 INFO - 'tabpaint']}, 19:08:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:08:49 INFO - 'tests': ['a11yr', 19:08:49 INFO - 'ts_paint', 19:08:49 INFO - 'tpaint', 19:08:49 INFO - 'sessionrestore', 19:08:49 INFO - 'sessionrestore_no_auto_restore', 19:08:49 INFO - 'tabpaint']}, 19:08:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:08:49 INFO - 'tests': ['tsvgx', 19:08:49 INFO - 'tsvgr_opacity', 19:08:49 INFO - 'tart', 19:08:49 INFO - 'tscrollx', 19:08:49 INFO - 'cart']}, 19:08:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:08:49 INFO - 'tsvgr_opacity', 19:08:49 INFO - 'tart', 19:08:49 INFO - 'tscrollx', 19:08:49 INFO - 'cart']}, 19:08:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:49 INFO - 'talos_options': ['--disable-e10s'], 19:08:49 INFO - 'tests': ['tp5o']}, 19:08:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:49 INFO - 'tests': ['tp5o']}, 19:08:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:49 INFO - 'talos_options': ['--disable-e10s', 19:08:49 INFO - '--xperf_path', 19:08:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:08:49 INFO - 'tests': ['tp5n']}, 19:08:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:49 INFO - 'talos_options': ['--xperf_path', 19:08:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:08:49 INFO - 'tests': ['tp5n']}}, 19:08:49 INFO - 'talos.zip': {'path': '', 19:08:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:08:49 INFO - Running post-action listener: _resource_record_post_action 19:08:49 INFO - ##### 19:08:49 INFO - ##### Running create-virtualenv step. 19:08:49 INFO - ##### 19:08:49 INFO - Running pre-action listener: _resource_record_pre_action 19:08:49 INFO - Running main action method: create_virtualenv 19:08:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:08:49 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 19:08:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:08:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:08:49 INFO - Using real prefix '/usr' 19:08:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:08:49 INFO - Installing distribute.............................................................................................................................................................................................done. 19:08:51 INFO - Installing pip.................done. 19:08:51 INFO - Return code: 0 19:08:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1e7089f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e48d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28738b0>, '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 0x28747b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2874c60>, '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': '0274524eba3bdaad075c2247000001d4-1460595134.771347-1256880993', '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 19:08:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 19:08:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:08:51 INFO - Using env: {'DISPLAY': ':0', 19:08:51 INFO - 'HOME': '/home/cltbld', 19:08:51 INFO - 'LANG': 'en_US.UTF-8', 19:08:51 INFO - 'LANGUAGE': 'en_US:en', 19:08:51 INFO - 'LOGNAME': 'cltbld', 19:08:51 INFO - 'MAIL': '/var/mail/cltbld', 19:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:51 INFO - 'MOZ_NO_REMOTE': '1', 19:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:51 INFO - 'NO_EM_RESTART': '1', 19:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:08:51 INFO - 'PWD': '/builds/slave/test-pgo', 19:08:51 INFO - 'SHELL': '/bin/bash', 19:08:51 INFO - 'SHLVL': '1', 19:08:51 INFO - 'TERM': 'linux', 19:08:51 INFO - 'TMOUT': '86400', 19:08:51 INFO - 'USER': 'cltbld', 19:08:51 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460595134.771347-1256880993', 19:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:51 INFO - '_': '/tools/buildbot/bin/python'} 19:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:51 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 19:08:51 INFO - Cleaning up... 19:08:51 INFO - Return code: 0 19:08:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe1e7089f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e48d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28738b0>, '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 0x28747b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2874c60>, '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': '0274524eba3bdaad075c2247000001d4-1460595134.771347-1256880993', '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 19:08:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 19:08:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:08:51 INFO - Using env: {'DISPLAY': ':0', 19:08:51 INFO - 'HOME': '/home/cltbld', 19:08:51 INFO - 'LANG': 'en_US.UTF-8', 19:08:51 INFO - 'LANGUAGE': 'en_US:en', 19:08:51 INFO - 'LOGNAME': 'cltbld', 19:08:51 INFO - 'MAIL': '/var/mail/cltbld', 19:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:51 INFO - 'MOZ_NO_REMOTE': '1', 19:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:51 INFO - 'NO_EM_RESTART': '1', 19:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:08:51 INFO - 'PWD': '/builds/slave/test-pgo', 19:08:51 INFO - 'SHELL': '/bin/bash', 19:08:51 INFO - 'SHLVL': '1', 19:08:51 INFO - 'TERM': 'linux', 19:08:51 INFO - 'TMOUT': '86400', 19:08:51 INFO - 'USER': 'cltbld', 19:08:51 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460595134.771347-1256880993', 19:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:51 INFO - '_': '/tools/buildbot/bin/python'} 19:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:52 INFO - Downloading/unpacking psutil>=0.7.1 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:08:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:08:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:08:54 INFO - Installing collected packages: psutil 19:08:54 INFO - Running setup.py install for psutil 19:08:54 INFO - building 'psutil._psutil_linux' extension 19:08:54 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 19:08:54 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 19:08:54 INFO - building 'psutil._psutil_posix' extension 19:08:54 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 19:08:54 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 19:08:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:08:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:08:54 INFO - Successfully installed psutil 19:08:54 INFO - Cleaning up... 19:08:54 INFO - Return code: 0 19:08:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe1e7089f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e48d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28738b0>, '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 0x28747b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2874c60>, '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': '0274524eba3bdaad075c2247000001d4-1460595134.771347-1256880993', '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 19:08:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 19:08:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:08:54 INFO - Using env: {'DISPLAY': ':0', 19:08:54 INFO - 'HOME': '/home/cltbld', 19:08:54 INFO - 'LANG': 'en_US.UTF-8', 19:08:54 INFO - 'LANGUAGE': 'en_US:en', 19:08:54 INFO - 'LOGNAME': 'cltbld', 19:08:54 INFO - 'MAIL': '/var/mail/cltbld', 19:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:54 INFO - 'MOZ_NO_REMOTE': '1', 19:08:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:54 INFO - 'NO_EM_RESTART': '1', 19:08:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:08:54 INFO - 'PWD': '/builds/slave/test-pgo', 19:08:54 INFO - 'SHELL': '/bin/bash', 19:08:54 INFO - 'SHLVL': '1', 19:08:54 INFO - 'TERM': 'linux', 19:08:54 INFO - 'TMOUT': '86400', 19:08:54 INFO - 'USER': 'cltbld', 19:08:54 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460595134.771347-1256880993', 19:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:54 INFO - '_': '/tools/buildbot/bin/python'} 19:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:08:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:08:56 INFO - Installing collected packages: mozsystemmonitor 19:08:56 INFO - Running setup.py install for mozsystemmonitor 19:08:56 INFO - Successfully installed mozsystemmonitor 19:08:56 INFO - Cleaning up... 19:08:56 INFO - Return code: 0 19:08:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:08:56 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')]} 19:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:56 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')]} 19:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:56 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 0x7fe1e7089f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e48d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28738b0>, '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 0x28747b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2874c60>, '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': '0274524eba3bdaad075c2247000001d4-1460595134.771347-1256880993', '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 19:08:56 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 19:08:56 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 19:08:56 INFO - Using env: {'DISPLAY': ':0', 19:08:56 INFO - 'HOME': '/home/cltbld', 19:08:56 INFO - 'LANG': 'en_US.UTF-8', 19:08:56 INFO - 'LANGUAGE': 'en_US:en', 19:08:56 INFO - 'LOGNAME': 'cltbld', 19:08:56 INFO - 'MAIL': '/var/mail/cltbld', 19:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:56 INFO - 'MOZ_NO_REMOTE': '1', 19:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:56 INFO - 'NO_EM_RESTART': '1', 19:08:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:08:57 INFO - 'PWD': '/builds/slave/test-pgo', 19:08:57 INFO - 'SHELL': '/bin/bash', 19:08:57 INFO - 'SHLVL': '1', 19:08:57 INFO - 'TERM': 'linux', 19:08:57 INFO - 'TMOUT': '86400', 19:08:57 INFO - 'USER': 'cltbld', 19:08:57 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460595134.771347-1256880993', 19:08:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:57 INFO - '_': '/tools/buildbot/bin/python'} 19:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:57 INFO - Downloading/unpacking blobuploader==1.2.4 19:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:59 INFO - Downloading blobuploader-1.2.4.tar.gz 19:08:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:08:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:08:59 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 19:08:59 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 19:08:59 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 19:08:59 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 19:08:59 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 19:08:59 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 19:08:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:08:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:08:59 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 19:08:59 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 19:08:59 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 19:08:59 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 19:08:59 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 19:08:59 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 19:08:59 INFO - Downloading docopt-0.6.1.tar.gz 19:08:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:08:59 INFO - Installing collected packages: blobuploader, requests, docopt 19:08:59 INFO - Running setup.py install for blobuploader 19:08:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:08:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:08:59 INFO - Running setup.py install for requests 19:09:00 INFO - Running setup.py install for docopt 19:09:00 INFO - Successfully installed blobuploader requests docopt 19:09:00 INFO - Cleaning up... 19:09:00 INFO - Return code: 0 19:09:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:00 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 0x7fe1e7089f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e48d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28738b0>, '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 0x28747b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2874c60>, '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': '0274524eba3bdaad075c2247000001d4-1460595134.771347-1256880993', '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 19:09:00 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 19:09:00 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 19:09:00 INFO - Using env: {'DISPLAY': ':0', 19:09:00 INFO - 'HOME': '/home/cltbld', 19:09:00 INFO - 'LANG': 'en_US.UTF-8', 19:09:00 INFO - 'LANGUAGE': 'en_US:en', 19:09:00 INFO - 'LOGNAME': 'cltbld', 19:09:00 INFO - 'MAIL': '/var/mail/cltbld', 19:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:00 INFO - 'MOZ_NO_REMOTE': '1', 19:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:00 INFO - 'NO_EM_RESTART': '1', 19:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:09:00 INFO - 'PWD': '/builds/slave/test-pgo', 19:09:00 INFO - 'SHELL': '/bin/bash', 19:09:00 INFO - 'SHLVL': '1', 19:09:00 INFO - 'TERM': 'linux', 19:09:00 INFO - 'TMOUT': '86400', 19:09:00 INFO - 'USER': 'cltbld', 19:09:00 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460595134.771347-1256880993', 19:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:00 INFO - '_': '/tools/buildbot/bin/python'} 19:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:09:00 INFO - Running setup.py (path:/tmp/pip-Zwnqwd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:09:00 INFO - Running setup.py (path:/tmp/pip-CMJajE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:09:00 INFO - Running setup.py (path:/tmp/pip-q3gD4H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:09:00 INFO - Running setup.py (path:/tmp/pip-V8yQK8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:09:00 INFO - Running setup.py (path:/tmp/pip-VWzrk5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:09:01 INFO - Running setup.py (path:/tmp/pip-_aR29n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:09:01 INFO - Running setup.py (path:/tmp/pip-1_Runf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:09:01 INFO - Running setup.py (path:/tmp/pip-SnZzpt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:09:01 INFO - Running setup.py (path:/tmp/pip-56wuUB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:09:01 INFO - Running setup.py (path:/tmp/pip-WUV1_4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:09:01 INFO - Running setup.py (path:/tmp/pip-m9tLcv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:09:01 INFO - Running setup.py (path:/tmp/pip-OLLOOF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:09:01 INFO - Running setup.py (path:/tmp/pip-KZnIjY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:09:01 INFO - Running setup.py (path:/tmp/pip-PAY__X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:09:01 INFO - Running setup.py (path:/tmp/pip-HdyiPp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:09:01 INFO - Running setup.py (path:/tmp/pip-XhQBrp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:09:01 INFO - Running setup.py (path:/tmp/pip-8wavpY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:09:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:09:01 INFO - Running setup.py install for manifestparser 19:09:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:09:01 INFO - Running setup.py install for mozcrash 19:09:02 INFO - Running setup.py install for mozdebug 19:09:02 INFO - Running setup.py install for mozdevice 19:09:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:09:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:09:02 INFO - Running setup.py install for mozfile 19:09:02 INFO - Running setup.py install for mozhttpd 19:09:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:09:02 INFO - Running setup.py install for mozinfo 19:09:02 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:09:02 INFO - Running setup.py install for mozInstall 19:09:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:09:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:09:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:09:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:09:02 INFO - Running setup.py install for mozleak 19:09:02 INFO - Running setup.py install for mozlog 19:09:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:09:02 INFO - Running setup.py install for moznetwork 19:09:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:09:03 INFO - Running setup.py install for mozprocess 19:09:03 INFO - Running setup.py install for mozprofile 19:09:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:09:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:09:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:09:03 INFO - Running setup.py install for mozrunner 19:09:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:09:03 INFO - Running setup.py install for mozscreenshot 19:09:03 INFO - Running setup.py install for moztest 19:09:03 INFO - Running setup.py install for mozversion 19:09:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:09:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:09:03 INFO - Cleaning up... 19:09:03 INFO - Return code: 0 19:09:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:09:03 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')]} 19:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:03 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')]} 19:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:03 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 0x7fe1e7089f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e48d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28738b0>, '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 0x28747b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2874c60>, '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': '0274524eba3bdaad075c2247000001d4-1460595134.771347-1256880993', '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 19:09:03 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 19:09:03 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 19:09:03 INFO - Using env: {'DISPLAY': ':0', 19:09:03 INFO - 'HOME': '/home/cltbld', 19:09:03 INFO - 'LANG': 'en_US.UTF-8', 19:09:03 INFO - 'LANGUAGE': 'en_US:en', 19:09:03 INFO - 'LOGNAME': 'cltbld', 19:09:03 INFO - 'MAIL': '/var/mail/cltbld', 19:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:03 INFO - 'MOZ_NO_REMOTE': '1', 19:09:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:03 INFO - 'NO_EM_RESTART': '1', 19:09:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:09:03 INFO - 'PWD': '/builds/slave/test-pgo', 19:09:03 INFO - 'SHELL': '/bin/bash', 19:09:03 INFO - 'SHLVL': '1', 19:09:03 INFO - 'TERM': 'linux', 19:09:03 INFO - 'TMOUT': '86400', 19:09:03 INFO - 'USER': 'cltbld', 19:09:03 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460595134.771347-1256880993', 19:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:03 INFO - '_': '/tools/buildbot/bin/python'} 19:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:09:03 INFO - Running setup.py (path:/tmp/pip-ZXuRbX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:09:03 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)) 19:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:09:03 INFO - Running setup.py (path:/tmp/pip-cRW9eq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:09:04 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)) 19:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:09:04 INFO - Running setup.py (path:/tmp/pip-yjhXGJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:09:04 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)) 19:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:09:04 INFO - Running setup.py (path:/tmp/pip-h2a5Ww-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:09:04 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)) 19:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:09:04 INFO - Running setup.py (path:/tmp/pip-i2pO8R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:09:04 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)) 19:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:09:04 INFO - Running setup.py (path:/tmp/pip-Ks9GIb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:09:04 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)) 19:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:09:04 INFO - Running setup.py (path:/tmp/pip-i6kATF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:09:04 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)) 19:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:09:04 INFO - Running setup.py (path:/tmp/pip-49Rag7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:09:04 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)) 19:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:09:04 INFO - Running setup.py (path:/tmp/pip-ATTqIO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:09:04 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)) 19:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:09:04 INFO - Running setup.py (path:/tmp/pip-Avjetu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:09:04 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)) 19:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:09:04 INFO - Running setup.py (path:/tmp/pip-yKGtOo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:09:04 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)) 19:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:09:04 INFO - Running setup.py (path:/tmp/pip-h9NH3k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:09:04 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)) 19:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:09:04 INFO - Running setup.py (path:/tmp/pip-i_4Kf0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:09:04 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)) 19:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:09:04 INFO - Running setup.py (path:/tmp/pip-UuzuDS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:09:04 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)) 19:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:09:04 INFO - Running setup.py (path:/tmp/pip-CRsVuC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:09:04 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)) 19:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:09:05 INFO - Running setup.py (path:/tmp/pip-ar23X4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:09:05 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)) 19:09:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:09:05 INFO - Running setup.py (path:/tmp/pip-5XCO30-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:09:05 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)) 19:09:05 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)) 19:09:05 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)) 19:09:05 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)) 19:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:09:05 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)) 19:09:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:06 INFO - Downloading blessings-1.6.tar.gz 19:09:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:09:07 INFO - Installing collected packages: blessings 19:09:07 INFO - Running setup.py install for blessings 19:09:07 INFO - Successfully installed blessings 19:09:07 INFO - Cleaning up... 19:09:07 INFO - Return code: 0 19:09:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:09:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:09:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:09:07 INFO - Reading from file tmpfile_stdout 19:09:07 INFO - Current package versions: 19:09:07 INFO - argparse == 1.2.1 19:09:07 INFO - blessings == 1.6 19:09:07 INFO - blobuploader == 1.2.4 19:09:07 INFO - docopt == 0.6.1 19:09:07 INFO - manifestparser == 1.1 19:09:07 INFO - mozInstall == 1.12 19:09:07 INFO - mozcrash == 0.17 19:09:07 INFO - mozdebug == 0.1 19:09:07 INFO - mozdevice == 0.48 19:09:07 INFO - mozfile == 1.2 19:09:07 INFO - mozhttpd == 0.7 19:09:07 INFO - mozinfo == 0.9 19:09:07 INFO - mozleak == 0.1 19:09:07 INFO - mozlog == 3.1 19:09:07 INFO - moznetwork == 0.27 19:09:07 INFO - mozprocess == 0.22 19:09:07 INFO - mozprofile == 0.28 19:09:07 INFO - mozrunner == 6.11 19:09:07 INFO - mozscreenshot == 0.1 19:09:07 INFO - mozsystemmonitor == 0.0 19:09:07 INFO - moztest == 0.7 19:09:07 INFO - mozversion == 1.4 19:09:07 INFO - psutil == 3.1.1 19:09:07 INFO - requests == 1.2.3 19:09:07 INFO - wsgiref == 0.1.2 19:09:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:07 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 0x7fe1e7089f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e48d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28738b0>, '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 0x28747b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2874c60>, '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': '0274524eba3bdaad075c2247000001d4-1460595134.771347-1256880993', '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 19:09:07 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 19:09:07 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 19:09:07 INFO - Using env: {'DISPLAY': ':0', 19:09:07 INFO - 'HOME': '/home/cltbld', 19:09:07 INFO - 'LANG': 'en_US.UTF-8', 19:09:07 INFO - 'LANGUAGE': 'en_US:en', 19:09:07 INFO - 'LOGNAME': 'cltbld', 19:09:07 INFO - 'MAIL': '/var/mail/cltbld', 19:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:07 INFO - 'MOZ_NO_REMOTE': '1', 19:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:07 INFO - 'NO_EM_RESTART': '1', 19:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:09:07 INFO - 'PWD': '/builds/slave/test-pgo', 19:09:07 INFO - 'SHELL': '/bin/bash', 19:09:07 INFO - 'SHLVL': '1', 19:09:07 INFO - 'TERM': 'linux', 19:09:07 INFO - 'TMOUT': '86400', 19:09:07 INFO - 'USER': 'cltbld', 19:09:07 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460595134.771347-1256880993', 19:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:07 INFO - '_': '/tools/buildbot/bin/python'} 19:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:07 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)) 19:09:07 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)) 19:09:07 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)) 19:09:07 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)) 19:09:07 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)) 19:09:07 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)) 19:09:07 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)) 19:09:07 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)) 19:09:07 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)) 19:09:07 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)) 19:09:07 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)) 19:09:07 INFO - Cleaning up... 19:09:07 INFO - Return code: 0 19:09:07 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1e7089f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e48d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28738b0>, '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 0x28747b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2874c60>, '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': '0274524eba3bdaad075c2247000001d4-1460595134.771347-1256880993', '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 19:09:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 19:09:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:09:07 INFO - Using env: {'DISPLAY': ':0', 19:09:07 INFO - 'HOME': '/home/cltbld', 19:09:07 INFO - 'LANG': 'en_US.UTF-8', 19:09:07 INFO - 'LANGUAGE': 'en_US:en', 19:09:07 INFO - 'LOGNAME': 'cltbld', 19:09:07 INFO - 'MAIL': '/var/mail/cltbld', 19:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:07 INFO - 'MOZ_NO_REMOTE': '1', 19:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:07 INFO - 'NO_EM_RESTART': '1', 19:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:09:07 INFO - 'PWD': '/builds/slave/test-pgo', 19:09:07 INFO - 'SHELL': '/bin/bash', 19:09:07 INFO - 'SHLVL': '1', 19:09:07 INFO - 'TERM': 'linux', 19:09:07 INFO - 'TMOUT': '86400', 19:09:07 INFO - 'USER': 'cltbld', 19:09:07 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460595134.771347-1256880993', 19:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:07 INFO - '_': '/tools/buildbot/bin/python'} 19:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:07 INFO - Downloading/unpacking jsonschema 19:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:09:09 INFO - Downloading/unpacking functools32 (from jsonschema) 19:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:09 INFO - Downloading functools32-3.2.3-2.tar.gz 19:09:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:09:10 INFO - warning: no files found matching '*.txt' 19:09:10 INFO - no previously-included directories found matching 'build' 19:09:10 INFO - no previously-included directories found matching 'dist' 19:09:10 INFO - no previously-included directories found matching '.git*' 19:09:10 INFO - Installing collected packages: jsonschema, functools32 19:09:10 INFO - Running setup.py install for functools32 19:09:10 INFO - warning: no files found matching '*.txt' 19:09:10 INFO - no previously-included directories found matching 'build' 19:09:10 INFO - no previously-included directories found matching 'dist' 19:09:10 INFO - no previously-included directories found matching '.git*' 19:09:10 INFO - Successfully installed jsonschema functools32 19:09:10 INFO - Cleaning up... 19:09:10 INFO - Return code: 0 19:09:10 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:10 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 0x7fe1e7089f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e48d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28738b0>, '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 0x28747b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2874c60>, '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': '0274524eba3bdaad075c2247000001d4-1460595134.771347-1256880993', '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 19:09:10 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 19:09:10 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 19:09:10 INFO - Using env: {'DISPLAY': ':0', 19:09:10 INFO - 'HOME': '/home/cltbld', 19:09:10 INFO - 'LANG': 'en_US.UTF-8', 19:09:10 INFO - 'LANGUAGE': 'en_US:en', 19:09:10 INFO - 'LOGNAME': 'cltbld', 19:09:10 INFO - 'MAIL': '/var/mail/cltbld', 19:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:10 INFO - 'MOZ_NO_REMOTE': '1', 19:09:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:10 INFO - 'NO_EM_RESTART': '1', 19:09:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:09:10 INFO - 'PWD': '/builds/slave/test-pgo', 19:09:10 INFO - 'SHELL': '/bin/bash', 19:09:10 INFO - 'SHLVL': '1', 19:09:10 INFO - 'TERM': 'linux', 19:09:10 INFO - 'TMOUT': '86400', 19:09:10 INFO - 'USER': 'cltbld', 19:09:10 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460595134.771347-1256880993', 19:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:10 INFO - '_': '/tools/buildbot/bin/python'} 19:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:10 INFO - Downloading/unpacking flake8 19:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:09:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:09:12 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 19:09:12 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 19:09:12 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 19:09:12 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 19:09:12 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 19:09:12 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 19:09:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:09:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:09:12 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 19:09:12 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 19:09:12 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 19:09:12 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 19:09:12 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 19:09:12 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 19:09:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:09:12 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 19:09:12 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 19:09:12 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 19:09:12 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 19:09:12 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 19:09:12 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 19:09:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:09:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:09:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:09:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:09:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:09:13 INFO - no previously-included directories found matching 'docs/_build' 19:09:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:09:13 INFO - Running setup.py install for pep8 19:09:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:09:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:09:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:09:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:09:13 INFO - no previously-included directories found matching 'docs/_build' 19:09:13 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:09:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:09:13 INFO - Cleaning up... 19:09:13 INFO - Return code: 0 19:09:13 INFO - Running post-action listener: _resource_record_post_action 19:09:13 INFO - Running post-action listener: _start_resource_monitoring 19:09:13 INFO - Starting resource monitoring. 19:09:13 INFO - ##### 19:09:13 INFO - ##### Running install step. 19:09:13 INFO - ##### 19:09:13 INFO - Running pre-action listener: _resource_record_pre_action 19:09:13 INFO - Running main action method: install 19:09:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:09:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:09:13 INFO - Reading from file tmpfile_stdout 19:09:13 INFO - Detecting whether we're running mozinstall >=1.0... 19:09:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:09:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:09:13 INFO - Reading from file tmpfile_stdout 19:09:13 INFO - Output received: 19:09:13 INFO - Usage: mozinstall [options] installer 19:09:13 INFO - Options: 19:09:13 INFO - -h, --help show this help message and exit 19:09:13 INFO - -d DEST, --destination=DEST 19:09:13 INFO - Directory to install application into. [default: 19:09:13 INFO - "/builds/slave/test-pgo"] 19:09:13 INFO - --app=APP Application being installed. [default: firefox] 19:09:13 INFO - mkdir: /builds/slave/test-pgo/build/application 19:09:13 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'] 19:09:13 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 19:09:30 INFO - Reading from file tmpfile_stdout 19:09:30 INFO - Output received: 19:09:30 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:09:30 INFO - Running post-action listener: _resource_record_post_action 19:09:30 INFO - ##### 19:09:30 INFO - ##### Running run-tests step. 19:09:30 INFO - ##### 19:09:30 INFO - Running pre-action listener: _resource_record_pre_action 19:09:30 INFO - Running main action method: run_tests 19:09:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:09:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:09:30 INFO - Python 2.7.3 19:09:30 INFO - Return code: 0 19:09:30 INFO - grabbing minidump binary from tooltool 19:09:30 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')]} 19:09:30 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 0x28738b0>, '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 0x28747b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2874c60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:09:30 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 19:09:30 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 19:09:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:09:30 INFO - Return code: 0 19:09:30 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:09:30 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:09:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:09:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:09:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:09:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:09:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:09:31 INFO - Return code: 0 19:09:31 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/bEIea4yMSDy8y4-ni3t_tQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 19:09:31 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/bEIea4yMSDy8y4-ni3t_tQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 19:09:31 INFO - Using env: {'DISPLAY': ':0', 19:09:31 INFO - 'HOME': '/home/cltbld', 19:09:31 INFO - 'LANG': 'en_US.UTF-8', 19:09:31 INFO - 'LANGUAGE': 'en_US:en', 19:09:31 INFO - 'LOGNAME': 'cltbld', 19:09:31 INFO - 'MAIL': '/var/mail/cltbld', 19:09:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:09:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:31 INFO - 'MOZ_NO_REMOTE': '1', 19:09:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:09:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:31 INFO - 'NO_EM_RESTART': '1', 19:09:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:09:31 INFO - 'PWD': '/builds/slave/test-pgo', 19:09:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:09:31 INFO - 'SHELL': '/bin/bash', 19:09:31 INFO - 'SHLVL': '1', 19:09:31 INFO - 'TERM': 'linux', 19:09:31 INFO - 'TMOUT': '86400', 19:09:31 INFO - 'USER': 'cltbld', 19:09:31 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460595134.771347-1256880993', 19:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:31 INFO - '_': '/tools/buildbot/bin/python'} 19:09:31 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/bEIea4yMSDy8y4-ni3t_tQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 19:09:31 INFO - mozversion application_buildid: 20160413163022 19:09:31 INFO - mozversion application_changeset: bc2373295e31d99f9b870a1253b6e01650df8f31 19:09:31 INFO - mozversion application_display_name: Nightly 19:09:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:09:31 INFO - mozversion application_name: Firefox 19:09:31 INFO - mozversion application_remotingname: firefox 19:09:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:09:31 INFO - mozversion application_vendor: Mozilla 19:09:31 INFO - mozversion application_version: 48.0a1 19:09:31 INFO - mozversion platform_buildid: 20160413163022 19:09:31 INFO - mozversion platform_changeset: bc2373295e31d99f9b870a1253b6e01650df8f31 19:09:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:09:31 INFO - mozversion platform_version: 48.0a1 19:09:31 INFO - using testdate: 1460599771 19:09:31 INFO - actual date: 1460599771 19:09:31 INFO - starting webserver on 'localhost:52274' 19:09:31 INFO - SUITE-START | Running 2 tests 19:09:31 INFO - TEST-START | dromaeo_css 19:09:31 INFO - operating with platform_type : linux_ 19:09:31 INFO - Initialising browser for dromaeo_css test... 19:09:31 INFO - TEST-INFO | started process 14617 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyL0iG0/profile http://localhost:52274/getInfo.html) 19:09:34 INFO - PROCESS | 14617 | 19:09:34 INFO - PROCESS | 14617 | (process:14685): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:09:34 INFO - PROCESS | 14617 | 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:09:35 INFO - PROCESS | 14617 | __metrics Screen width/height:1600/1200 19:09:35 INFO - PROCESS | 14617 | colorDepth:24 19:09:35 INFO - PROCESS | 14617 | Browser inner width/height: 1024/697 19:09:35 INFO - PROCESS | 14617 | __metrics 19:09:35 ERROR - PROCESS | 14617 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 19:09:36 INFO - TEST-INFO | 14617: exit 0 19:09:36 INFO - Browser initialized. 19:09:36 INFO - Running cycle 1/1 for dromaeo_css test... 19:09:36 INFO - TEST-INFO | started process 14736 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyL0iG0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:09:38 INFO - PROCESS | 14736 | 19:09:38 INFO - PROCESS | 14736 | (process:14795): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:09:48 INFO - PROCESS | 14736 | RSS: Main: 163069952 19:09:48 INFO - PROCESS | 14736 | 19:10:38 INFO - PROCESS | 14736 | 1460599838006 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:12:46 INFO - PROCESS | 14736 | Cycle 1(1): loaded http://localhost:52274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52274/tests/dromaeo/cssquery-ext.html) 19:12:47 INFO - PROCESS | 14736 | RSS: Main: 169193472 19:12:47 INFO - PROCESS | 14736 | 19:15:49 INFO - PROCESS | 14736 | Cycle 1(1): loaded http://localhost:52274/tests/dromaeo/cssquery-ext.html (next: http://localhost:52274/tests/dromaeo/cssquery-jquery.html) 19:15:49 INFO - PROCESS | 14736 | RSS: Main: 164663296 19:15:49 INFO - PROCESS | 14736 | 19:18:51 INFO - PROCESS | 14736 | Cycle 1(1): loaded http://localhost:52274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52274/tests/dromaeo/cssquery-mootools.html) 19:18:52 INFO - PROCESS | 14736 | RSS: Main: 165572608 19:18:52 INFO - PROCESS | 14736 | 19:21:53 INFO - PROCESS | 14736 | Cycle 1(1): loaded http://localhost:52274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52274/tests/dromaeo/cssquery-prototype.html) 19:21:54 INFO - PROCESS | 14736 | RSS: Main: 163405824 19:21:54 INFO - PROCESS | 14736 | 19:24:56 INFO - PROCESS | 14736 | Cycle 1(1): loaded http://localhost:52274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52274/tests/dromaeo/cssquery-yui.html) 19:24:57 INFO - PROCESS | 14736 | RSS: Main: 164360192 19:24:57 INFO - PROCESS | 14736 | 19:27:59 INFO - PROCESS | 14736 | Cycle 1(1): loaded http://localhost:52274/tests/dromaeo/cssquery-yui.html (next: http://localhost:52274/tests/dromaeo/cssquery-dojo.html) 19:27:59 INFO - PROCESS | 14736 | RSS: Main: 166313984 19:27:59 INFO - PROCESS | 14736 | 19:27:59 INFO - PROCESS | 14736 | __start_tp_report 19:27:59 INFO - PROCESS | 14736 | _x_x_mozilla_page_load 19:27:59 INFO - PROCESS | 14736 | _x_x_mozilla_page_load_details 19:27:59 INFO - PROCESS | 14736 | |i|pagename|runs| 19:27:59 INFO - PROCESS | 14736 | |0;dojo.html;3185.9203519912;3219.9356012879734;3263.070025042865;3290.3912776136417;3300.4224260754363;5494.587905907058;5502.889942201154;5505.697186654733;5530.695811730353;5534.529564986981;5487.890242195153;5583.246261754662;5592.468715472024;5608.6073974821775;5698.943010569893;4975.253711943219;5014.498550144993;5064.290999260106;5082.872928176806;5144.948550514484;4951.480094590071;4962.230854217602;4990.65065445419;5029.497050294978;5051;4922.114019476493;4922.507749225085;4942.777575009115;5023.296738456619;5035.446100928895;5028.748562571894;5040.193569028937;5045.344105266292;5058.266551350033;5102.336696229467;4973.801047958077;4997.9750101249265;5007.974960125212;5027.120253955543;5027.547520723152;5420;5451.37309209442;5465.699386533739;5475.589330800206;5511.751971161308;5908.172855800191;5914.260717410324;5927.585069045169;5937.643741375531;5954.2259506264345;5881.264841894763;5938.910916336258;5970.611910225822;5992.310884248323;6000.159977603095;5498.202760599691;5525.889482210333;5525.889482210333;5549.72251387429;5555.694436805974;5976.671283079472;5979.820605381846;5983.61106528083;5991.2510936132985;6004.729787159588;5689.260396148474;5767.509761670305;5769.538436925036;5850.3272123705465;5883.264591926009;5773.134029895466;5898.410158984153;5904.439078287556;5906.379830117776;5906.852328691817;5861.238039054981;5862.032764593794;5870.031444811643;5896.439838215449;5925.73334199962;5842.970785146047;5855.121731740273;5933.2880054393745;5980.372060933626;6054.51563874889;4472.709273897186;4477.686561940633;4480.507144214133;4481.969147096186;4510.255807791743;3995.5205375355144;4028.7582745035393;4031.7984100794843;4036.899077523027;4112.033672087057;5562.415946325577;5715.057015592381;5716.142578613241;5768.74040668171;5783.537317014713;5963.642181469126;5975.4024597540765;5978.970105149447;5984;6019.518438524908;5597.916031259534;5734.541236701138;5735.1970724098655;5748.798792042258;5752.568557358215;5050.520200580939;5082.74586270685;5089.51649593288;5096.541311282002;5126.6923984561045;6090.969545152246;6092.939070609325;6121.785737499166;6126.6017708848785;6136.938630613637;5850.53195744348;5918;5920.111983202381;5928.940710592925;5971.850703732442;6120.54095942815;6159.599626024294;6176.382361763787;6185.6907154641185;6186.1648677427975;5766.711664416846;5780.653160810365;5807.157962095388;5815.592908496534;5819.5635327351465;5882.117682347682;5888.440598143169;5923.940760592339;5942.376050514807;5978.252718410199;5713.514351280188;5744.971275143597;5797.333306669619;5833.270841144857;5855.38518455556;5777.768889244383;5812.360640329476;5840.2991641003355;5850.063989761617;5871.7651293949475;5642.23829782974;5703.657780533182;5711.942880571141;5713.714314284186;5738.053221218453;5788.421157884178;5811.53507719373;5831.7375718091935;5840.094785308284;5854.151148083419;5660.575456840671;5706.714664266853;5707.857303567444;5717.256756621613;5728.598998070095 19:27:59 INFO - PROCESS | 14736 | |1;ext.html;607.7022259093046;662.618994078405;668.7928289437564;670.5607826873398;691.1671435919717;30866.845665771667;37690.24619507611;38462;38596.22807543851;38674.806625966834;42250.78874605623;42627.14745705084;42835.78582107093;42884.571154288526;42900;8584.871226931586;8751.168638979287;8753.912460875405;8773.078826723198;8788.824223515527;8580.270676992432;8632.697855575056;8709.912900870973;8726.214640682338;8901.06538813425;8952.104789521061;8975.775605609846;9022.548872556346;9035.457872527637;9040.231580315649;8931.419457735226;8964.372493925428;8973.775655608597;8980.371374003822;8989.235914947238;8896.466212027299;9025.142611451902;9025.23285520725;9031.864522032174;9034.954825225897;41926;42089.579104208875;42313.365299520534;42384.78807605973;42456;3315.2209230830736;3495.353359628477;4005.819738111792;4017.4375587417785;4044.716869819114;32221.194470138198;32897.50653740196;32933.3413331732;33038.6696133038;33232.16919577006;4317.179735850178;4365.934510982338;4405.185040767468;4406.757628330441;4444.355568442557;293457;293809.530952346;294117;294509;295636.1309160707;36427;62128.689356552924;62304.376956229855;62373.68813155905;62408.375916241166;35488.29023419517;35658.64341356605;35795.28409431797;35865.64134358675;35900.82049589735;14600.85399145995;14621.342039608031;14779.778303325458;14786.704265914621;14794.778078328834;12993.285369304589;13068.673283167996;13074.542391016459;13090.607281781562;13118.409671564803;8621.09478504748;8662.78343041429;8675.262602678717;8706.434081784664;8805.603747831363;3386.204242003127;3416.931661366759;3419.452887537982;3456.3605732939486;3481.2515309208643;1050.222835102019;1109.2180013090913;1119.7200699825044;1123.8819923907872;1162.2387336294742;31708;32065.679343206735;32093.839530802663;32379.838100809346;32635.347293054005;1127.5940661361903;1135.4890299365318;1193.8448001759716;1221.9450124744408;1252.2799390350585;15075.54773356801;15193.316300766492;15844.60388490297;16064.357425702841;16084.713222942137;453114;455561;461135;461415;463746;59277.40722592805;59328.40671593315;60066;60078.09882851673;60235;1364.9044566880423;1367.0703921333588;1388.645895296693;1398.8880889529016;1399.8180236569385;28944.56583151212;29589;29825.850870745508;29867.55198672065;30659.386812264074;48489.75755121202;48724.512754873416;49001.509984901124;49067;49084;430194;430315;431686;432154;433007;29151;29319.853400733715;29468.263293417836;29790.404191916474;29795;50350;50765.746171268904;50777.49222507728;51376;51857.481425185266;41713;42820.571794281655;42830;43681.34477982769;44005.33991990059;41788;41954.580454195064;42389.576104238564;42587.57412425836;43130.56869431391;36967.44548831716;42923.35614965841;43388.78305608452;43566;43572.78213608912;34165.658343416246;34174.31651366909;35300.82349588236;35363.29273414569;35684.46473302954;27519.17442476729;28273.293167670974;28371.858140709166;28403.289917752223;28424.30484037062 19:27:59 INFO - PROCESS | 14736 | |2;jquery.html;392.9135590170165;397.5011360742268;398.1459768795934;410.38032570818064;417.6679539765886;14904.40382384706;17812.821871781278;18517.90741046296;18594.256229750794;18597.535061623465;17605.119744012813;17693.57152429974;17902.28390864364;18611.813881861177;18633.627327453443;5545.528630066449;5559.249501317311;5676.148577713356;5689.800856970007;5709.457601527869;5372.677639341652;5568.610197286192;5633.126865335879;5651.095824668054;5724.141378793193;5672.943270567303;5675.404082571333;5691.601587888849;5693.686847223401;5701.059325211356;5622.4939755422;5650.434956504358;5940.346561878211;6196.597221180609;6197.752089916398;5401.486858748452;5518.779248830042;5537.446255374471;5538.584606154554;5541.6674999499755;12144.174585005694;12843.550475733398;12951.80572291407;12980.675483112904;13052.086353955227;2093.6231478333893;2127.1597718901103;2203.6804663323887;2207.6578130389653;2250.797428231451;9467.337286389955;9824.312298139133;9979.950100249525;9981.201503879673;13176;1789.642071585688;1945.2413558712115;1950.600126973981;1958.7355706979517;1964.7052942058663;79707;79886.6005669968;80001;80793.59603201946;81738.18261817425;10593.57625694979;10872.402017889091;10981;10988.945055274673;11165.218434709492;12019.63941081769;13631.250281234428;14369.137851728721;15300.387984480718;15358.769618455732;6396.200474940632;6654.301298363699;7685.346745526693;8232.135625759329;8380.53907035119;7958.562279074707;8040.396970227256;8045.718399856094;8103.554304513308;8215.09633940266;4654.301854721751;4667.089917466062;4667.789949452283;4684.110019096429;4731.905361892812;1867.4771064102074;1925.9229630814891;1985.1662301833264;2021.6057868715754;2042.816146546818;1021.841106695756;1052.3373070548514;1064.164630764846;1068.076114161245;1076.8761592416815;17749.822501774815;17873.28506859737;18040.729389059175;18230.45308640743;19626.901865490865;1029.840374741916;1033.764317685639;1064.5582083435443;1064.8455973883742;1093.9726506837392;10020.899791002143;10518.421486818299;10525.578976840841;10656.04095631397;10708.678739637824;471657;483324;487951;491003;496535;99004.50497747466;99275;99335.50332248292;99419.50290248648;101113;1059.1209296284067;1072.9839052414377;1075.9031687148195;1078.1105587890022;1103.2222283290262;16564.503064908073;16758.748618770485;16924.492265232064;16932.40736574214;17141.914290428467;30406.391872161992;35696.92909212728;36007;37937.24125517529;40232.59767402289;49917.25124123214;50749;52341.7382913083;52639;53810;7300.452466065172;7841.451098423056;7855;7941.642626081724;8124.593770311342;10815.729606759895;12874.16317939331;13088;13149.408276627384;13389.933050334686;10878.292910960763;11518.36648984314;11573.421328933688;11625.18623696333;11909.642710718692;11463.541458341573;11545.769084618429;11631.941840290745;11632;11731.824022639497;11559.884401155881;11702.648920532398;11765.11761617865;11828.34944078084;11868.465919033491;7980.12218655959;8020.398470114648;8102.675892964216;8161.551114688749;8182.4681395709085;8179.386546008954;10138.594456221668;11144.442777861237;11342.886571134513;11425.143114266297 19:27:59 INFO - PROCESS | 14736 | |3;mootools.html;1566.6396728752386;1576.5743249322684;1734.366956061038;1840.7238914162883;1873.4566975577084;7562.319391254786;8143.429959902809;8180.141085186059;8352.624131914063;8457.746267611974;8227.67089316428;8231.506109633427;8254.257116859482;8274.586270686457;8312.459690120138;2327.860328380298;2358.0332063853825;2361.2089949866813;2367.6448532720055;2368.6498695743435;2305.7002589663402;2320.385097949045;2362.681038059857;2375.0143690368564;2380.0241900820665;2338.286822519131;2349.2364981381033;2365.27859003004;2368.526294741059;2371.7865392114704;2305.2853615379286;2308.088305119477;2314.0743702519044;2314.5833749925005;2321.2688003278913;2235;2237.093976939326;2238.3173132194675;2252.0991603358625;2254.1772253127656;8239.629216685264;8426.410151289412;8437.95781021091;8468.110848360957;8490.150984901522;4964.255361695775;5076.060928728197;5096.598435430249;5099.617528685363;5111.4121875984365;3185.490321548541;3187.6174859016833;3207.903762887117;3238.3847069056806;3342.5320455136302;1119.6249256499002;1127.954881804727;1129.7743445412525;1157.2593540134321;1189.9702507437296;11623.476943537562;11636.883631163664;11672.35802030888;11694.239874408137;11696.356700381475;4580;4646.814127434933;4791.353167322367;4811.302361157613;4812.302216178705;10032.849507257397;10097.545610447547;10114;10152.543135558917;10190.949045254727;5351.785928562814;5353.357597088374;5365.356157261153;5390.21841832932;5408.48619381166;4062.309407400749;4843.709377437365;4873.585745211697;4885.706857588556;4919.852404427873;3915.1190982029384;3920.6863450923856;4032.334664780337;4060.918781624351;4112.856050038235;1305.693162106904;1316.394458549059;1324.576135636587;1330.4079684540286;1338.3910320804011;862.8490014247482;1001.5543083327849;1005.6781829814389;1015.0458568945168;1021.3157184686278;5699.971500142473;5807.216025836543;5881.941180588139;5897.734601942923;5957.6127551709;422.5014482910195;424.45881501086365;425.6637256567277;427.45926403100106;449.9190145773792;3929.9214015719526;3936.5079365079364;3952.802359882052;3976;3999.460072890123;10199.7450063749;10642;10723.19576031785;10769.569217231223;10799.83800242997;10399.84400233997;10458.424786636655;10542.73643158912;10619.522121504397;10693.78612427747;7936.4047696423;7980.84038319242;8033.799155021171;8044.557549334842;8100.959495202605;5600.159976003469;5649.152627105803;5685;5791.305043394819;5838.211841401357;9677.516124193622;9765.707028789147;9838.114569688762;9848.753781155528;9857.556409961713;9584.424934503952;9864.260180486348;9904.158146557624;10061.798764024532;10127.949360253151;6761.053452516553;7114.537555058904;7321.74373896911;7484.401247900046;7591.58246296459;8090.595470226583;8144.67421303165;8194.590270486333;8216.055153657406;8216.794580135305;7016.403605693573;7432.6283685814415;7525.774226773206;7693.346065584488;7774.494657847448;7527.8118047049265;7554.169041405331;7568.772936811904;7619.352355049883;7647.541147531166;6424.10062591247;6433.613983161025;6439.903401448888;6458.773942911976;6483.157189565515;4738.976305118453;4928.827491037797;5075.264086707333;5078.035173317058;5087.287779710918;5220.791168353223;5243.161094225058;5257.185136303879;5306.8407947761625;5312.229726689686 19:27:59 INFO - PROCESS | 14736 | |4;prototype.html;311.97192252697266;319.51752853191675;326.61785710718465;330.3541576218493;332.76706305586094;5895.823125306248;5937.732802023908;6101.908471372933;6126.816195514136;6135.9079613805825;5991.310999235089;5992.22101126854;6016.789412370568;6019.428154325332;6020.6086604370685;4458.9331160032625;4462.598366147046;4465.687401881862;4472.776361181945;4487.19230538503;4343.978280108595;4460.710053846506;4478.305862591304;4482.618977386926;4487.663425243103;4348.195583816988;4403.097365040175;4419.558044195587;4422.09347083847;4422.916385485561;4361.847335343264;4413.4262545869;4418.933715994247;4438.4451943507065;4438.778061096932;3613.0606042428894;3817.141143242776;3830.272248272819;3835.137094153821;3856.67218286446;5705.800296989627;5734.448170564101;5745.080787074048;5751.1085781703905;5772.6536407815665;5121.28302037715;5130.256112863651;5133.6919784813035;5165.096108181053;5178.508041736029;6142.539309551801;6153.077038444269;6153.630782153085;6175.59858609189;6293.2762732285455;4125.381192821071;4158.542560318362;4187.91624167518;4206.747595144301;4208.410822484854;6503.349665033506;6527.086207930894;6597.439217666504;6598.60408375499;6605.504587155934;4194.182134483746;4283.785810709452;4305.913881722348;4319.416878721395;4323.697341186087;4329.242382583036;4343.652507799368;4352.738835669807;4367.781610919441;4390.890227744332;5097.209932460474;5118.97440512795;5129.948700513021;5142.994232249425;5153.871153221125;5836.474717275466;6164.352742961924;6289.937100629027;6360.14138091361;6370.554061215763;1504.0372314130166;1529.495266562032;1530.4566878758103;1536.5159974607964;1537.415782002854;953.5536620203966;973.4013581647235;977.8386566216636;978.7014960437135;980.9411435313904;6125.693715314305;6127.601705889192;6167.784127555604;6172.753089876444;6223.408776166257;6441.227052753606;6495.870082598416;6496.967515162489;6555.213374395008;6562.409383155539;6024.608400453956;6137.202163718688;6140.754369825247;6162.383761623802;6167.444929956326;3462.6364231755806;3485.5643044619424;3488.127968007998;3490.7556471046782;3499.562554680665;6624.701888415033;6705;6734.865302693918;6745.392914637706;6767.330541926055;6649.035889795952;6671.299513551105;6680.83297917556;6689.933100668931;6703.927371620614;6570.967145164243;6653.9667301663185;6741;6742.460603151736;6757.493188010919;6380.234371875405;6415.133956915944;6452;6461.64460954652;6462.838429039311;6287.497000239879;6402.35976402356;6413.775517856852;6424.93575064262;6429.7749578764515;6761.729530818909;6790.287019862843;6794.456443484411;6801.89797153053;6803.591784492946;4284.007936309631;4291.806868690854;4327.415798867112;4359.106383191502;4361.912761744811;6291.874162516816;6428.4214420702365;6477.902831457626;6549.869002619826;6575.605463672195;6316.989281714904;6333.556651034568;6351.460125889351;6352.269489008823;6354;6138.324784273816;6302.275238347649;6336.7465301389275;6339.461145802658;6351.364863513611;6142.662153581417;6179.443850053517;6207.6585787782105;6219.440250377488;6290.811275661737;6417.7753778617525;6431.067495213074;6447.516436267392;6450.580712253689;6479.967600161969;6022.247219097613;6269.185005949197;6284.905726414016;6302.180716506825;6334.144890439732 19:27:59 INFO - PROCESS | 14736 | |5;yui.html;734.1007266099026;749.5165618176277;765.4679997401804;863.8358711844749;881.8236352729454;13161.539346122887;13265;13288.402021909013;13528.391222394992;13610;14066.085704429204;14110.365033573487;14135.293235338244;14238.857611423882;14270.785938210935;683.6991723641606;803.4014659078995;813.820959388935;831.4844796226348;836.0135040652028;824.2499325613693;826.8222332198576;829.2453866981049;829.6847198064727;830.7881490219985;852.1946760311508;858.9570521473902;865.6926790989203;867.371155911965;867.3841572483512;856.6915910272297;857.3869683176528;861.9655213791441;863.9092895246034;866.0300463480879;632.7152781248457;634.7524465458475;635.586868535451;636.1221514310269;636.7675798333621;13126;13207.801882971764;13252.734945301136;13295.268760218185;13337.399817008161;13329.66675833112;13394.598162055056;13575.932120339336;13638.727225455435;13696.178229306273;11251.09991200702;11311.773764524663;11350.262232954914;11388.886111138949;11435.885641143564;3836.76979381238;3849.788261645608;3885.2229554089295;3946.4277679736565;3955.920881582381;53733.19400209;53991.19013214805;54049.1892621611;54185.45814541844;54250.18624720632;10520.631777887736;10898.945505272422;11065.668029959113;11099.223054386277;11195.4962026709;20030.198792048446;20211.292604759055;20217.090230939644;20378.59242815165;20380.898095509427;8423.705170319132;8545.957270213608;8576.1423857615;8590;8663.826723465496;4692.835750748775;4762.761861906891;4772.76136193189;4784.210605250164;4825.6139508839915;3487.3548393546766;3585.964140358615;3587.712982961357;3589.6051434342726;3602.441621548664;644.1239913717341;650.7657243392375;659.8383396067898;668.5286872754697;676.3067855448205;688.7176257734305;711.5090587494716;795.9920400796034;822.5722624235364;826.1655727715051;9152.771180720401;9594;9876.160526355197;9880.35777674449;9890.456024918698;608.0848323273445;634.8317695810614;664.5974801094106;684.9931500685029;713.8429545499981;4454.910901781946;4544.681872268976;4573.6569757268335;4580.702254353457;4594.747288899142;57969.71015144897;59515.702421487615;60000;60512.579496820515;60522;53498.73250633722;54386.728066359414;54395.45604543983;55934.160987585215;56164.71917640467;48194.5180548197;48759.26861097087;48839.75580122077;49265.26102108471;49645.25532117021;8795.604197810986;8872.24585910205;8872.778180545538;8939.776505587412;8986.505742183981;32102;32111.839440802647;32304.515432268065;32309.838450807594;33031.17422064468;41634.375484368364;43844.34233486564;44279.335809962235;44673.32990005217;44760.77619611881;11553.942230288794;11673.708157296136;11716.648500544998;11725.179237453638;11749.118816088656;12907.677308067374;12992.675183120498;12997.15518491295;13231.66920826987;13563.59309220725;12060.638180854588;12174.208676436003;12205.389730513261;12469;12563.560275390317;11409.25839820409;11728.179027468337;12013.219140755822;12354.135210535176;12561.24632522015;11382;11724.472398741906;12875.484980600671;13315.134516256412;13404.530841420503;10599;10646.8402973957;10767.300125491818;10793.40636265013;10981.83527247076;10684.626038088629;10921.344719316867;10962.835557466804;11175.441227938409;11186.552537898393 19:27:59 INFO - PROCESS | 14736 | __end_tp_report 19:27:59 INFO - PROCESS | 14736 | __start_cc_report 19:27:59 INFO - PROCESS | 14736 | _x_x_mozilla_cycle_collect,330 19:27:59 INFO - PROCESS | 14736 | __end_cc_report 19:27:59 INFO - PROCESS | 14736 | __startTimestamp1460600879821__endTimestamp 19:27:59 INFO - PROCESS | 14736 | 19:27:59 INFO - PROCESS | 14736 | ------- Summary: start ------- 19:27:59 INFO - PROCESS | 14736 | Number of tests: 6 19:27:59 INFO - PROCESS | 14736 | 19:27:59 INFO - PROCESS | 14736 | [#0] dojo.html Cycles:165 Average:5502.72 Median:5738.05 stddev:624.21 (10.9%) stddev-sans-first:599.08 19:27:59 INFO - PROCESS | 14736 | Values: 3185.9 3219.9 3263.1 3290.4 3300.4 5494.6 5502.9 5505.7 5530.7 5534.5 5487.9 5583.2 5592.5 5608.6 5698.9 4975.3 5014.5 5064.3 5082.9 5144.9 4951.5 4962.2 4990.7 5029.5 5051.0 4922.1 4922.5 4942.8 5023.3 5035.4 5028.7 5040.2 5045.3 5058.3 5102.3 4973.8 4998.0 5008.0 5027.1 5027.5 5420.0 5451.4 5465.7 5475.6 5511.8 5908.2 5914.3 5927.6 5937.6 5954.2 5881.3 5938.9 5970.6 5992.3 6000.2 5498.2 5525.9 5525.9 5549.7 5555.7 5976.7 5979.8 5983.6 5991.3 6004.7 5689.3 5767.5 5769.5 5850.3 5883.3 5773.1 5898.4 5904.4 5906.4 5906.9 5861.2 5862.0 5870.0 5896.4 5925.7 5843.0 5855.1 5933.3 5980.4 6054.5 4472.7 4477.7 4480.5 4482.0 4510.3 3995.5 4028.8 4031.8 4036.9 4112.0 5562.4 5715.1 5716.1 5768.7 5783.5 5963.6 5975.4 5979.0 5984.0 6019.5 5597.9 5734.5 5735.2 5748.8 5752.6 5050.5 5082.7 5089.5 5096.5 5126.7 6091.0 6092.9 6121.8 6126.6 6136.9 5850.5 5918.0 5920.1 5928.9 5971.9 6120.5 6159.6 6176.4 6185.7 6186.2 5766.7 5780.7 5807.2 5815.6 5819.6 5882.1 5888.4 5923.9 5942.4 5978.3 5713.5 5745.0 5797.3 5833.3 5855.4 5777.8 5812.4 5840.3 5850.1 5871.8 5642.2 5703.7 5711.9 5713.7 5738.1 5788.4 5811.5 5831.7 5840.1 5854.2 5660.6 5706.7 5707.9 5717.3 5728.6 19:27:59 INFO - PROCESS | 14736 | 19:27:59 INFO - PROCESS | 14736 | [#1] ext.html Cycles:180 Average:55181.65 Median:42022.08 stddev:106298.01 (253.0%) stddev-sans-first:106517.23 19:27:59 INFO - PROCESS | 14736 | Values: 607.7 662.6 668.8 670.6 691.2 30866.8 37690.2 38462.0 38596.2 38674.8 42250.8 42627.1 42835.8 42884.6 42900.0 8584.9 8751.2 8753.9 8773.1 8788.8 8580.3 8632.7 8709.9 8726.2 8901.1 8952.1 8975.8 9022.5 9035.5 9040.2 8931.4 8964.4 8973.8 8980.4 8989.2 8896.5 9025.1 9025.2 9031.9 9035.0 41926.0 42089.6 42313.4 42384.8 42456.0 3315.2 3495.4 4005.8 4017.4 4044.7 32221.2 32897.5 32933.3 33038.7 33232.2 4317.2 4365.9 4405.2 4406.8 4444.4 293457.0 293809.5 294117.0 294509.0 295636.1 36427.0 62128.7 62304.4 62373.7 62408.4 35488.3 35658.6 35795.3 35865.6 35900.8 14600.9 14621.3 14779.8 14786.7 14794.8 12993.3 13068.7 13074.5 13090.6 13118.4 8621.1 8662.8 8675.3 8706.4 8805.6 3386.2 3416.9 3419.5 3456.4 3481.3 1050.2 1109.2 1119.7 1123.9 1162.2 31708.0 32065.7 32093.8 32379.8 32635.3 1127.6 1135.5 1193.8 1221.9 1252.3 15075.5 15193.3 15844.6 16064.4 16084.7 453114.0 455561.0 461135.0 461415.0 463746.0 59277.4 59328.4 60066.0 60078.1 60235.0 1364.9 1367.1 1388.6 1398.9 1399.8 28944.6 29589.0 29825.9 29867.6 30659.4 48489.8 48724.5 49001.5 49067.0 49084.0 430194.0 430315.0 431686.0 432154.0 433007.0 29151.0 29319.9 29468.3 29790.4 29795.0 50350.0 50765.7 50777.5 51376.0 51857.5 41713.0 42820.6 42830.0 43681.3 44005.3 41788.0 41954.6 42389.6 42587.6 43130.6 36967.4 42923.4 43388.8 43566.0 43572.8 34165.7 34174.3 35300.8 35363.3 35684.5 27519.2 28273.3 28371.9 28403.3 28424.3 19:27:59 INFO - PROCESS | 14736 | 19:27:59 INFO - PROCESS | 14736 | [#2] jquery.html Cycles:180 Average:28220.77 Median:2068.22 stddev:80358.80 (3885.4%) stddev-sans-first:80557.06 19:27:59 INFO - PROCESS | 14736 | Values: 392.9 397.5 398.1 410.4 417.7 14904.4 17812.8 18517.9 18594.3 18597.5 17605.1 17693.6 17902.3 18611.8 18633.6 5545.5 5559.2 5676.1 5689.8 5709.5 5372.7 5568.6 5633.1 5651.1 5724.1 5672.9 5675.4 5691.6 5693.7 5701.1 5622.5 5650.4 5940.3 6196.6 6197.8 5401.5 5518.8 5537.4 5538.6 5541.7 12144.2 12843.6 12951.8 12980.7 13052.1 2093.6 2127.2 2203.7 2207.7 2250.8 9467.3 9824.3 9980.0 9981.2 13176.0 1789.6 1945.2 1950.6 1958.7 1964.7 79707.0 79886.6 80001.0 80793.6 81738.2 10593.6 10872.4 10981.0 10988.9 11165.2 12019.6 13631.3 14369.1 15300.4 15358.8 6396.2 6654.3 7685.3 8232.1 8380.5 7958.6 8040.4 8045.7 8103.6 8215.1 4654.3 4667.1 4667.8 4684.1 4731.9 1867.5 1925.9 1985.2 2021.6 2042.8 1021.8 1052.3 1064.2 1068.1 1076.9 17749.8 17873.3 18040.7 18230.5 19626.9 1029.8 1033.8 1064.6 1064.8 1094.0 10020.9 10518.4 10525.6 10656.0 10708.7 471657.0 483324.0 487951.0 491003.0 496535.0 99004.5 99275.0 99335.5 99419.5 101113.0 1059.1 1073.0 1075.9 1078.1 1103.2 16564.5 16758.7 16924.5 16932.4 17141.9 30406.4 35696.9 36007.0 37937.2 40232.6 49917.3 50749.0 52341.7 52639.0 53810.0 7300.5 7841.5 7855.0 7941.6 8124.6 10815.7 12874.2 13088.0 13149.4 13389.9 10878.3 11518.4 11573.4 11625.2 11909.6 11463.5 11545.8 11631.9 11632.0 11731.8 11559.9 11702.6 11765.1 11828.3 11868.5 7980.1 8020.4 8102.7 8161.6 8182.5 8179.4 10138.6 11144.4 11342.9 11425.1 19:27:59 INFO - PROCESS | 14736 | 19:27:59 INFO - PROCESS | 14736 | [#3] mootools.html Cycles:180 Average:5626.50 Median:4801.33 stddev:3156.45 (65.7%) stddev-sans-first:3150.56 19:27:59 INFO - PROCESS | 14736 | Values: 1566.6 1576.6 1734.4 1840.7 1873.5 7562.3 8143.4 8180.1 8352.6 8457.7 8227.7 8231.5 8254.3 8274.6 8312.5 2327.9 2358.0 2361.2 2367.6 2368.6 2305.7 2320.4 2362.7 2375.0 2380.0 2338.3 2349.2 2365.3 2368.5 2371.8 2305.3 2308.1 2314.1 2314.6 2321.3 2235.0 2237.1 2238.3 2252.1 2254.2 8239.6 8426.4 8438.0 8468.1 8490.2 4964.3 5076.1 5096.6 5099.6 5111.4 3185.5 3187.6 3207.9 3238.4 3342.5 1119.6 1128.0 1129.8 1157.3 1190.0 11623.5 11636.9 11672.4 11694.2 11696.4 4580.0 4646.8 4791.4 4811.3 4812.3 10032.8 10097.5 10114.0 10152.5 10190.9 5351.8 5353.4 5365.4 5390.2 5408.5 4062.3 4843.7 4873.6 4885.7 4919.9 3915.1 3920.7 4032.3 4060.9 4112.9 1305.7 1316.4 1324.6 1330.4 1338.4 862.8 1001.6 1005.7 1015.0 1021.3 5700.0 5807.2 5881.9 5897.7 5957.6 422.5 424.5 425.7 427.5 449.9 3929.9 3936.5 3952.8 3976.0 3999.5 10199.7 10642.0 10723.2 10769.6 10799.8 10399.8 10458.4 10542.7 10619.5 10693.8 7936.4 7980.8 8033.8 8044.6 8101.0 5600.2 5649.2 5685.0 5791.3 5838.2 9677.5 9765.7 9838.1 9848.8 9857.6 9584.4 9864.3 9904.2 10061.8 10127.9 6761.1 7114.5 7321.7 7484.4 7591.6 8090.6 8144.7 8194.6 8216.1 8216.8 7016.4 7432.6 7525.8 7693.3 7774.5 7527.8 7554.2 7568.8 7619.4 7647.5 6424.1 6433.6 6439.9 6458.8 6483.2 4739.0 4928.8 5075.3 5078.0 5087.3 5220.8 5243.2 5257.2 5306.8 5312.2 19:27:59 INFO - PROCESS | 14736 | 19:27:59 INFO - PROCESS | 14736 | [#4] prototype.html Cycles:180 Average:5236.14 Median:6137.76 stddev:1627.15 (26.5%) stddev-sans-first:1589.18 19:27:59 INFO - PROCESS | 14736 | Values: 312.0 319.5 326.6 330.4 332.8 5895.8 5937.7 6101.9 6126.8 6135.9 5991.3 5992.2 6016.8 6019.4 6020.6 4458.9 4462.6 4465.7 4472.8 4487.2 4344.0 4460.7 4478.3 4482.6 4487.7 4348.2 4403.1 4419.6 4422.1 4422.9 4361.8 4413.4 4418.9 4438.4 4438.8 3613.1 3817.1 3830.3 3835.1 3856.7 5705.8 5734.4 5745.1 5751.1 5772.7 5121.3 5130.3 5133.7 5165.1 5178.5 6142.5 6153.1 6153.6 6175.6 6293.3 4125.4 4158.5 4187.9 4206.7 4208.4 6503.3 6527.1 6597.4 6598.6 6605.5 4194.2 4283.8 4305.9 4319.4 4323.7 4329.2 4343.7 4352.7 4367.8 4390.9 5097.2 5119.0 5129.9 5143.0 5153.9 5836.5 6164.4 6289.9 6360.1 6370.6 1504.0 1529.5 1530.5 1536.5 1537.4 953.6 973.4 977.8 978.7 980.9 6125.7 6127.6 6167.8 6172.8 6223.4 6441.2 6495.9 6497.0 6555.2 6562.4 6024.6 6137.2 6140.8 6162.4 6167.4 3462.6 3485.6 3488.1 3490.8 3499.6 6624.7 6705.0 6734.9 6745.4 6767.3 6649.0 6671.3 6680.8 6689.9 6703.9 6571.0 6654.0 6741.0 6742.5 6757.5 6380.2 6415.1 6452.0 6461.6 6462.8 6287.5 6402.4 6413.8 6424.9 6429.8 6761.7 6790.3 6794.5 6801.9 6803.6 4284.0 4291.8 4327.4 4359.1 4361.9 6291.9 6428.4 6477.9 6549.9 6575.6 6317.0 6333.6 6351.5 6352.3 6354.0 6138.3 6302.3 6336.7 6339.5 6351.4 6142.7 6179.4 6207.7 6219.4 6290.8 6417.8 6431.1 6447.5 6450.6 6480.0 6022.2 6269.2 6284.9 6302.2 6334.1 19:27:59 INFO - PROCESS | 14736 | 19:27:59 INFO - PROCESS | 14736 | [#5] yui.html Cycles:180 Average:14578.46 Median:24652.73 stddev:16656.69 (67.6%) stddev-sans-first:16670.97 19:27:59 INFO - PROCESS | 14736 | Values: 734.1 749.5 765.5 863.8 881.8 13161.5 13265.0 13288.4 13528.4 13610.0 14066.1 14110.4 14135.3 14238.9 14270.8 683.7 803.4 813.8 831.5 836.0 824.2 826.8 829.2 829.7 830.8 852.2 859.0 865.7 867.4 867.4 856.7 857.4 862.0 863.9 866.0 632.7 634.8 635.6 636.1 636.8 13126.0 13207.8 13252.7 13295.3 13337.4 13329.7 13394.6 13575.9 13638.7 13696.2 11251.1 11311.8 11350.3 11388.9 11435.9 3836.8 3849.8 3885.2 3946.4 3955.9 53733.2 53991.2 54049.2 54185.5 54250.2 10520.6 10898.9 11065.7 11099.2 11195.5 20030.2 20211.3 20217.1 20378.6 20380.9 8423.7 8546.0 8576.1 8590.0 8663.8 4692.8 4762.8 4772.8 4784.2 4825.6 3487.4 3586.0 3587.7 3589.6 3602.4 644.1 650.8 659.8 668.5 676.3 688.7 711.5 796.0 822.6 826.2 9152.8 9594.0 9876.2 9880.4 9890.5 608.1 634.8 664.6 685.0 713.8 4454.9 4544.7 4573.7 4580.7 4594.7 57969.7 59515.7 60000.0 60512.6 60522.0 53498.7 54386.7 54395.5 55934.2 56164.7 48194.5 48759.3 48839.8 49265.3 49645.3 8795.6 8872.2 8872.8 8939.8 8986.5 32102.0 32111.8 32304.5 32309.8 33031.2 41634.4 43844.3 44279.3 44673.3 44760.8 11553.9 11673.7 11716.6 11725.2 11749.1 12907.7 12992.7 12997.2 13231.7 13563.6 12060.6 12174.2 12205.4 12469.0 12563.6 11409.3 11728.2 12013.2 12354.1 12561.2 11382.0 11724.5 12875.5 13315.1 13404.5 10599.0 10646.8 10767.3 10793.4 10981.8 10684.6 10921.3 10962.8 11175.4 11186.6 19:27:59 INFO - PROCESS | 14736 | -------- Summary: end -------- 19:27:59 INFO - PROCESS | 14736 | 19:28:00 INFO - TEST-INFO | 14736: exit 0 19:28:00 INFO - TEST-OK | dromaeo_css | took 1109176ms 19:28:00 INFO - TEST-START | kraken 19:28:00 INFO - operating with platform_type : linux_ 19:28:00 INFO - Initialising browser for kraken test... 19:28:00 INFO - TEST-INFO | started process 14969 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfTRE4b/profile http://localhost:52274/getInfo.html) 19:28:03 INFO - PROCESS | 14969 | 19:28:03 INFO - PROCESS | 14969 | (process:15036): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:28:03 INFO - PROCESS | 14969 | 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:28:04 INFO - PROCESS | 14969 | __metrics Screen width/height:1600/1200 19:28:04 INFO - PROCESS | 14969 | colorDepth:24 19:28:04 INFO - PROCESS | 14969 | Browser inner width/height: 1024/697 19:28:04 INFO - PROCESS | 14969 | __metrics 19:28:04 ERROR - PROCESS | 14969 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 19:28:05 INFO - TEST-INFO | 14969: exit 0 19:28:05 INFO - Browser initialized. 19:28:05 INFO - Running cycle 1/1 for kraken test... 19:28:05 INFO - TEST-INFO | started process 15087 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfTRE4b/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:28:07 INFO - PROCESS | 15087 | 19:28:07 INFO - PROCESS | 15087 | (process:15145): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:28:17 INFO - PROCESS | 15087 | RSS: Main: 163110912 19:28:17 INFO - PROCESS | 15087 | 19:28:20 INFO - PROCESS | 15087 | Cycle 1(1): loaded http://localhost:52274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52274/tests/kraken/driver.html?testName=audio-beat-detection) 19:28:20 INFO - PROCESS | 15087 | RSS: Main: 167211008 19:28:20 INFO - PROCESS | 15087 | 19:28:23 INFO - PROCESS | 15087 | Cycle 1(1): loaded http://localhost:52274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52274/tests/kraken/driver.html?testName=audio-dft) 19:28:24 INFO - PROCESS | 15087 | RSS: Main: 170868736 19:28:24 INFO - PROCESS | 15087 | 19:28:27 INFO - PROCESS | 15087 | Cycle 1(1): loaded http://localhost:52274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52274/tests/kraken/driver.html?testName=audio-fft) 19:28:27 INFO - PROCESS | 15087 | RSS: Main: 160858112 19:28:27 INFO - PROCESS | 15087 | 19:28:29 INFO - PROCESS | 15087 | Cycle 1(1): loaded http://localhost:52274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52274/tests/kraken/driver.html?testName=audio-oscillator) 19:28:30 INFO - PROCESS | 15087 | RSS: Main: 161472512 19:28:30 INFO - PROCESS | 15087 | 19:28:32 INFO - PROCESS | 15087 | Cycle 1(1): loaded http://localhost:52274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:28:33 INFO - PROCESS | 15087 | RSS: Main: 162557952 19:28:33 INFO - PROCESS | 15087 | 19:28:36 INFO - PROCESS | 15087 | Cycle 1(1): loaded http://localhost:52274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52274/tests/kraken/driver.html?testName=imaging-darkroom) 19:28:36 INFO - PROCESS | 15087 | RSS: Main: 162545664 19:28:36 INFO - PROCESS | 15087 | 19:28:40 INFO - PROCESS | 15087 | Cycle 1(1): loaded http://localhost:52274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52274/tests/kraken/driver.html?testName=imaging-desaturate) 19:28:40 INFO - PROCESS | 15087 | RSS: Main: 162766848 19:28:40 INFO - PROCESS | 15087 | 19:28:43 INFO - PROCESS | 15087 | Cycle 1(1): loaded http://localhost:52274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52274/tests/kraken/driver.html?testName=json-parse-financial) 19:28:44 INFO - PROCESS | 15087 | RSS: Main: 165470208 19:28:44 INFO - PROCESS | 15087 | 19:28:45 INFO - PROCESS | 15087 | Cycle 1(1): loaded http://localhost:52274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:28:46 INFO - PROCESS | 15087 | RSS: Main: 166060032 19:28:46 INFO - PROCESS | 15087 | 19:28:48 INFO - PROCESS | 15087 | Cycle 1(1): loaded http://localhost:52274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52274/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:28:48 INFO - PROCESS | 15087 | RSS: Main: 165486592 19:28:48 INFO - PROCESS | 15087 | 19:28:51 INFO - PROCESS | 15087 | Cycle 1(1): loaded http://localhost:52274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:28:51 INFO - PROCESS | 15087 | RSS: Main: 166150144 19:28:51 INFO - PROCESS | 15087 | 19:28:54 INFO - PROCESS | 15087 | Cycle 1(1): loaded http://localhost:52274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:28:54 INFO - PROCESS | 15087 | RSS: Main: 166998016 19:28:54 INFO - PROCESS | 15087 | 19:28:57 INFO - PROCESS | 15087 | Cycle 1(1): loaded http://localhost:52274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:28:58 INFO - PROCESS | 15087 | RSS: Main: 166395904 19:28:58 INFO - PROCESS | 15087 | 19:29:00 INFO - PROCESS | 15087 | Cycle 1(1): loaded http://localhost:52274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52274/tests/kraken/driver.html?testName=ai-astar) 19:29:00 INFO - PROCESS | 15087 | RSS: Main: 167907328 19:29:00 INFO - PROCESS | 15087 | 19:29:00 INFO - PROCESS | 15087 | __start_tp_report 19:29:00 INFO - PROCESS | 15087 | _x_x_mozilla_page_load 19:29:00 INFO - PROCESS | 15087 | _x_x_mozilla_page_load_details 19:29:00 INFO - PROCESS | 15087 | |i|pagename|runs| 19:29:00 INFO - PROCESS | 15087 | |0;ai-astar;109;105;111;110;110;126;113;112;110;110 19:29:00 INFO - PROCESS | 15087 | |1;audio-beat-detection;152;129;163;193;129;152;154;131;184;128 19:29:00 INFO - PROCESS | 15087 | |2;audio-dft;165;166;162;163;160;163;168;164;166;165 19:29:00 INFO - PROCESS | 15087 | |3;audio-fft;73;72;76;181;76;73;76;77;164;74 19:29:00 INFO - PROCESS | 15087 | |4;audio-oscillator;93;93;151;93;93;94;139;93;92;154 19:29:00 INFO - PROCESS | 15087 | |5;imaging-gaussian-blur;120;117;118;117;117;117;118;117;119;120 19:29:00 INFO - PROCESS | 15087 | |6;imaging-darkroom;147;146;146;146;146;146;146;146;146;147 19:29:00 INFO - PROCESS | 15087 | |7;imaging-desaturate;96;96;96;97;95;95;96;95;96;95 19:29:00 INFO - PROCESS | 15087 | |8;json-parse-financial;57;60;58;60;59;59;58;84;56;57 19:29:00 INFO - PROCESS | 15087 | |9;json-stringify-tinderbox;62;63;62;62;61;67;62;62;63;61 19:29:00 INFO - PROCESS | 15087 | |10;stanford-crypto-aes;82;79;81;79;81;81;82;82;82;88 19:29:00 INFO - PROCESS | 15087 | |11;stanford-crypto-ccm;129;131;129;131;128;136;134;135;171;137 19:29:00 INFO - PROCESS | 15087 | |12;stanford-crypto-pbkdf2;165;170;172;161;164;169;167;164;168;161 19:29:00 INFO - PROCESS | 15087 | |13;stanford-crypto-sha256-iterative;71;72;70;72;72;70;71;67;68;67 19:29:00 INFO - PROCESS | 15087 | __end_tp_report 19:29:00 INFO - PROCESS | 15087 | __start_cc_report 19:29:00 INFO - PROCESS | 15087 | _x_x_mozilla_cycle_collect,830 19:29:00 INFO - PROCESS | 15087 | __end_cc_report 19:29:00 INFO - PROCESS | 15087 | __startTimestamp1460600940311__endTimestamp 19:29:00 INFO - PROCESS | 15087 | 19:29:00 INFO - PROCESS | 15087 | ------- Summary: start ------- 19:29:00 INFO - PROCESS | 15087 | Number of tests: 14 19:29:00 INFO - PROCESS | 15087 | 19:29:00 INFO - PROCESS | 15087 | [#0] ai-astar Cycles:10 Average:111.60 Median:110.50 stddev:5.48 (5.0%) stddev-sans-first:5.73 19:29:00 INFO - PROCESS | 15087 | Values: 109.0 105.0 111.0 110.0 110.0 126.0 113.0 112.0 110.0 110.0 19:29:00 INFO - PROCESS | 15087 | 19:29:00 INFO - PROCESS | 15087 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:153.00 stddev:23.34 (15.3%) stddev-sans-first:24.75 19:29:00 INFO - PROCESS | 15087 | Values: 152.0 129.0 163.0 193.0 129.0 152.0 154.0 131.0 184.0 128.0 19:29:00 INFO - PROCESS | 15087 | 19:29:00 INFO - PROCESS | 15087 | [#2] audio-dft Cycles:10 Average:164.20 Median:165.00 stddev:2.30 (1.4%) stddev-sans-first:2.42 19:29:00 INFO - PROCESS | 15087 | Values: 165.0 166.0 162.0 163.0 160.0 163.0 168.0 164.0 166.0 165.0 19:29:00 INFO - PROCESS | 15087 | 19:29:00 INFO - PROCESS | 15087 | [#3] audio-fft Cycles:10 Average:94.20 Median:75.00 stddev:41.49 (55.3%) stddev-sans-first:43.30 19:29:00 INFO - PROCESS | 15087 | Values: 73.0 72.0 76.0 181.0 76.0 73.0 76.0 77.0 164.0 74.0 19:29:00 INFO - PROCESS | 15087 | 19:29:00 INFO - PROCESS | 15087 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:93.00 stddev:26.83 (28.9%) stddev-sans-first:27.79 19:29:00 INFO - PROCESS | 15087 | Values: 93.0 93.0 151.0 93.0 93.0 94.0 139.0 93.0 92.0 154.0 19:29:00 INFO - PROCESS | 15087 | 19:29:00 INFO - PROCESS | 15087 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.25 (1.1%) stddev-sans-first:1.09 19:29:00 INFO - PROCESS | 15087 | Values: 120.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 119.0 120.0 19:29:00 INFO - PROCESS | 15087 | 19:29:00 INFO - PROCESS | 15087 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 19:29:00 INFO - PROCESS | 15087 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 19:29:00 INFO - PROCESS | 15087 | 19:29:00 INFO - PROCESS | 15087 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 19:29:00 INFO - PROCESS | 15087 | Values: 96.0 96.0 96.0 97.0 95.0 95.0 96.0 95.0 96.0 95.0 19:29:00 INFO - PROCESS | 15087 | 19:29:00 INFO - PROCESS | 15087 | [#8] json-parse-financial Cycles:10 Average:60.80 Median:59.00 stddev:8.26 (14.0%) stddev-sans-first:8.64 19:29:00 INFO - PROCESS | 15087 | Values: 57.0 60.0 58.0 60.0 59.0 59.0 58.0 84.0 56.0 57.0 19:29:00 INFO - PROCESS | 15087 | 19:29:00 INFO - PROCESS | 15087 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:62.00 stddev:1.72 (2.8%) stddev-sans-first:1.81 19:29:00 INFO - PROCESS | 15087 | Values: 62.0 63.0 62.0 62.0 61.0 67.0 62.0 62.0 63.0 61.0 19:29:00 INFO - PROCESS | 15087 | 19:29:00 INFO - PROCESS | 15087 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:82.00 stddev:2.50 (3.0%) stddev-sans-first:2.65 19:29:00 INFO - PROCESS | 15087 | Values: 82.0 79.0 81.0 79.0 81.0 81.0 82.0 82.0 82.0 88.0 19:29:00 INFO - PROCESS | 15087 | 19:29:00 INFO - PROCESS | 15087 | [#11] stanford-crypto-ccm Cycles:10 Average:136.10 Median:134.50 stddev:12.66 (9.4%) stddev-sans-first:13.17 19:29:00 INFO - PROCESS | 15087 | Values: 129.0 131.0 129.0 131.0 128.0 136.0 134.0 135.0 171.0 137.0 19:29:00 INFO - PROCESS | 15087 | 19:29:00 INFO - PROCESS | 15087 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.10 Median:167.50 stddev:3.73 (2.2%) stddev-sans-first:3.93 19:29:00 INFO - PROCESS | 15087 | Values: 165.0 170.0 172.0 161.0 164.0 169.0 167.0 164.0 168.0 161.0 19:29:00 INFO - PROCESS | 15087 | 19:29:00 INFO - PROCESS | 15087 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:71.00 stddev:2.00 (2.8%) stddev-sans-first:2.09 19:29:00 INFO - PROCESS | 15087 | Values: 71.0 72.0 70.0 72.0 72.0 70.0 71.0 67.0 68.0 67.0 19:29:00 INFO - PROCESS | 15087 | -------- Summary: end -------- 19:29:00 INFO - PROCESS | 15087 | 19:29:01 INFO - TEST-INFO | 15087: exit 0 19:29:01 INFO - TEST-OK | kraken | took 60762ms 19:29:01 INFO - SUITE-END | took 1169s 19:29:01 INFO - Completed test suite (00:19:30) 19:29:01 INFO - javascript benchmark 19:29:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3185.9203519912, 3219.9356012879734, 3263.070025042865, 3290.3912776136417, 3300.4224260754363, 5494.587905907058, 5502.889942201154, 5505.697186654733, 5530.695811730353, 5534.529564986981, 5487.890242195153, 5583.246261754662, 5592.468715472024, 5608.6073974821775, 5698.943010569893, 4975.253711943219, 5014.498550144993, 5064.290999260106, 5082.872928176806, 5144.948550514484, 4951.480094590071, 4962.230854217602, 4990.65065445419, 5029.497050294978, 5051.0, 4922.114019476493, 4922.507749225085, 4942.777575009115, 5023.296738456619, 5035.446100928895, 5028.748562571894, 5040.193569028937, 5045.344105266292, 5058.266551350033, 5102.336696229467, 4973.801047958077, 4997.9750101249265, 5007.974960125212, 5027.120253955543, 5027.547520723152, 5420.0, 5451.37309209442, 5465.699386533739, 5475.589330800206, 5511.751971161308, 5908.172855800191, 5914.260717410324, 5927.585069045169, 5937.643741375531, 5954.2259506264345, 5881.264841894763, 5938.910916336258, 5970.611910225822, 5992.310884248323, 6000.159977603095, 5498.202760599691, 5525.889482210333, 5525.889482210333, 5549.72251387429, 5555.694436805974, 5976.671283079472, 5979.820605381846, 5983.61106528083, 5991.2510936132985, 6004.729787159588, 5689.260396148474, 5767.509761670305, 5769.538436925036, 5850.3272123705465, 5883.264591926009, 5773.134029895466, 5898.410158984153, 5904.439078287556, 5906.379830117776, 5906.852328691817, 5861.238039054981, 5862.032764593794, 5870.031444811643, 5896.439838215449, 5925.73334199962, 5842.970785146047, 5855.121731740273, 5933.2880054393745, 5980.372060933626, 6054.51563874889, 4472.709273897186, 4477.686561940633, 4480.507144214133, 4481.969147096186, 4510.255807791743, 3995.5205375355144, 4028.7582745035393, 4031.7984100794843, 4036.899077523027, 4112.033672087057, 5562.415946325577, 5715.057015592381, 5716.142578613241, 5768.74040668171, 5783.537317014713, 5963.642181469126, 5975.4024597540765, 5978.970105149447, 5984.0, 6019.518438524908, 5597.916031259534, 5734.541236701138, 5735.1970724098655, 5748.798792042258, 5752.568557358215, 5050.520200580939, 5082.74586270685, 5089.51649593288, 5096.541311282002, 5126.6923984561045, 6090.969545152246, 6092.939070609325, 6121.785737499166, 6126.6017708848785, 6136.938630613637, 5850.53195744348, 5918.0, 5920.111983202381, 5928.940710592925, 5971.850703732442, 6120.54095942815, 6159.599626024294, 6176.382361763787, 6185.6907154641185, 6186.1648677427975, 5766.711664416846, 5780.653160810365, 5807.157962095388, 5815.592908496534, 5819.5635327351465, 5882.117682347682, 5888.440598143169, 5923.940760592339, 5942.376050514807, 5978.252718410199, 5713.514351280188, 5744.971275143597, 5797.333306669619, 5833.270841144857, 5855.38518455556, 5777.768889244383, 5812.360640329476, 5840.2991641003355, 5850.063989761617, 5871.7651293949475, 5642.23829782974, 5703.657780533182, 5711.942880571141, 5713.714314284186, 5738.053221218453, 5788.421157884178, 5811.53507719373, 5831.7375718091935, 5840.094785308284, 5854.151148083419, 5660.575456840671, 5706.714664266853, 5707.857303567444, 5717.256756621613, 5728.598998070095], "value": 5460.797433512249, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.7022259093046, 662.618994078405, 668.7928289437564, 670.5607826873398, 691.1671435919717, 30866.845665771667, 37690.24619507611, 38462.0, 38596.22807543851, 38674.806625966834, 42250.78874605623, 42627.14745705084, 42835.78582107093, 42884.571154288526, 42900.0, 8584.871226931586, 8751.168638979287, 8753.912460875405, 8773.078826723198, 8788.824223515527, 8580.270676992432, 8632.697855575056, 8709.912900870973, 8726.214640682338, 8901.06538813425, 8952.104789521061, 8975.775605609846, 9022.548872556346, 9035.457872527637, 9040.231580315649, 8931.419457735226, 8964.372493925428, 8973.775655608597, 8980.371374003822, 8989.235914947238, 8896.466212027299, 9025.142611451902, 9025.23285520725, 9031.864522032174, 9034.954825225897, 41926.0, 42089.579104208875, 42313.365299520534, 42384.78807605973, 42456.0, 3315.2209230830736, 3495.353359628477, 4005.819738111792, 4017.4375587417785, 4044.716869819114, 32221.194470138198, 32897.50653740196, 32933.3413331732, 33038.6696133038, 33232.16919577006, 4317.179735850178, 4365.934510982338, 4405.185040767468, 4406.757628330441, 4444.355568442557, 293457.0, 293809.530952346, 294117.0, 294509.0, 295636.1309160707, 36427.0, 62128.689356552924, 62304.376956229855, 62373.68813155905, 62408.375916241166, 35488.29023419517, 35658.64341356605, 35795.28409431797, 35865.64134358675, 35900.82049589735, 14600.85399145995, 14621.342039608031, 14779.778303325458, 14786.704265914621, 14794.778078328834, 12993.285369304589, 13068.673283167996, 13074.542391016459, 13090.607281781562, 13118.409671564803, 8621.09478504748, 8662.78343041429, 8675.262602678717, 8706.434081784664, 8805.603747831363, 3386.204242003127, 3416.931661366759, 3419.452887537982, 3456.3605732939486, 3481.2515309208643, 1050.222835102019, 1109.2180013090913, 1119.7200699825044, 1123.8819923907872, 1162.2387336294742, 31708.0, 32065.679343206735, 32093.839530802663, 32379.838100809346, 32635.347293054005, 1127.5940661361903, 1135.4890299365318, 1193.8448001759716, 1221.9450124744408, 1252.2799390350585, 15075.54773356801, 15193.316300766492, 15844.60388490297, 16064.357425702841, 16084.713222942137, 453114.0, 455561.0, 461135.0, 461415.0, 463746.0, 59277.40722592805, 59328.40671593315, 60066.0, 60078.09882851673, 60235.0, 1364.9044566880423, 1367.0703921333588, 1388.645895296693, 1398.8880889529016, 1399.8180236569385, 28944.56583151212, 29589.0, 29825.850870745508, 29867.55198672065, 30659.386812264074, 48489.75755121202, 48724.512754873416, 49001.509984901124, 49067.0, 49084.0, 430194.0, 430315.0, 431686.0, 432154.0, 433007.0, 29151.0, 29319.853400733715, 29468.263293417836, 29790.404191916474, 29795.0, 50350.0, 50765.746171268904, 50777.49222507728, 51376.0, 51857.481425185266, 41713.0, 42820.571794281655, 42830.0, 43681.34477982769, 44005.33991990059, 41788.0, 41954.580454195064, 42389.576104238564, 42587.57412425836, 43130.56869431391, 36967.44548831716, 42923.35614965841, 43388.78305608452, 43566.0, 43572.78213608912, 34165.658343416246, 34174.31651366909, 35300.82349588236, 35363.29273414569, 35684.46473302954, 27519.17442476729, 28273.293167670974, 28371.858140709166, 28403.289917752223, 28424.30484037062], "value": 18856.48654406443, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.9135590170165, 397.5011360742268, 398.1459768795934, 410.38032570818064, 417.6679539765886, 14904.40382384706, 17812.821871781278, 18517.90741046296, 18594.256229750794, 18597.535061623465, 17605.119744012813, 17693.57152429974, 17902.28390864364, 18611.813881861177, 18633.627327453443, 5545.528630066449, 5559.249501317311, 5676.148577713356, 5689.800856970007, 5709.457601527869, 5372.677639341652, 5568.610197286192, 5633.126865335879, 5651.095824668054, 5724.141378793193, 5672.943270567303, 5675.404082571333, 5691.601587888849, 5693.686847223401, 5701.059325211356, 5622.4939755422, 5650.434956504358, 5940.346561878211, 6196.597221180609, 6197.752089916398, 5401.486858748452, 5518.779248830042, 5537.446255374471, 5538.584606154554, 5541.6674999499755, 12144.174585005694, 12843.550475733398, 12951.80572291407, 12980.675483112904, 13052.086353955227, 2093.6231478333893, 2127.1597718901103, 2203.6804663323887, 2207.6578130389653, 2250.797428231451, 9467.337286389955, 9824.312298139133, 9979.950100249525, 9981.201503879673, 13176.0, 1789.642071585688, 1945.2413558712115, 1950.600126973981, 1958.7355706979517, 1964.7052942058663, 79707.0, 79886.6005669968, 80001.0, 80793.59603201946, 81738.18261817425, 10593.57625694979, 10872.402017889091, 10981.0, 10988.945055274673, 11165.218434709492, 12019.63941081769, 13631.250281234428, 14369.137851728721, 15300.387984480718, 15358.769618455732, 6396.200474940632, 6654.301298363699, 7685.346745526693, 8232.135625759329, 8380.53907035119, 7958.562279074707, 8040.396970227256, 8045.718399856094, 8103.554304513308, 8215.09633940266, 4654.301854721751, 4667.089917466062, 4667.789949452283, 4684.110019096429, 4731.905361892812, 1867.4771064102074, 1925.9229630814891, 1985.1662301833264, 2021.6057868715754, 2042.816146546818, 1021.841106695756, 1052.3373070548514, 1064.164630764846, 1068.076114161245, 1076.8761592416815, 17749.822501774815, 17873.28506859737, 18040.729389059175, 18230.45308640743, 19626.901865490865, 1029.840374741916, 1033.764317685639, 1064.5582083435443, 1064.8455973883742, 1093.9726506837392, 10020.899791002143, 10518.421486818299, 10525.578976840841, 10656.04095631397, 10708.678739637824, 471657.0, 483324.0, 487951.0, 491003.0, 496535.0, 99004.50497747466, 99275.0, 99335.50332248292, 99419.50290248648, 101113.0, 1059.1209296284067, 1072.9839052414377, 1075.9031687148195, 1078.1105587890022, 1103.2222283290262, 16564.503064908073, 16758.748618770485, 16924.492265232064, 16932.40736574214, 17141.914290428467, 30406.391872161992, 35696.92909212728, 36007.0, 37937.24125517529, 40232.59767402289, 49917.25124123214, 50749.0, 52341.7382913083, 52639.0, 53810.0, 7300.452466065172, 7841.451098423056, 7855.0, 7941.642626081724, 8124.593770311342, 10815.729606759895, 12874.16317939331, 13088.0, 13149.408276627384, 13389.933050334686, 10878.292910960763, 11518.36648984314, 11573.421328933688, 11625.18623696333, 11909.642710718692, 11463.541458341573, 11545.769084618429, 11631.941840290745, 11632.0, 11731.824022639497, 11559.884401155881, 11702.648920532398, 11765.11761617865, 11828.34944078084, 11868.465919033491, 7980.12218655959, 8020.398470114648, 8102.675892964216, 8161.551114688749, 8182.4681395709085, 8179.386546008954, 10138.594456221668, 11144.442777861237, 11342.886571134513, 11425.143114266297], "value": 8874.366846378485, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1566.6396728752386, 1576.5743249322684, 1734.366956061038, 1840.7238914162883, 1873.4566975577084, 7562.319391254786, 8143.429959902809, 8180.141085186059, 8352.624131914063, 8457.746267611974, 8227.67089316428, 8231.506109633427, 8254.257116859482, 8274.586270686457, 8312.459690120138, 2327.860328380298, 2358.0332063853825, 2361.2089949866813, 2367.6448532720055, 2368.6498695743435, 2305.7002589663402, 2320.385097949045, 2362.681038059857, 2375.0143690368564, 2380.0241900820665, 2338.286822519131, 2349.2364981381033, 2365.27859003004, 2368.526294741059, 2371.7865392114704, 2305.2853615379286, 2308.088305119477, 2314.0743702519044, 2314.5833749925005, 2321.2688003278913, 2235.0, 2237.093976939326, 2238.3173132194675, 2252.0991603358625, 2254.1772253127656, 8239.629216685264, 8426.410151289412, 8437.95781021091, 8468.110848360957, 8490.150984901522, 4964.255361695775, 5076.060928728197, 5096.598435430249, 5099.617528685363, 5111.4121875984365, 3185.490321548541, 3187.6174859016833, 3207.903762887117, 3238.3847069056806, 3342.5320455136302, 1119.6249256499002, 1127.954881804727, 1129.7743445412525, 1157.2593540134321, 1189.9702507437296, 11623.476943537562, 11636.883631163664, 11672.35802030888, 11694.239874408137, 11696.356700381475, 4580.0, 4646.814127434933, 4791.353167322367, 4811.302361157613, 4812.302216178705, 10032.849507257397, 10097.545610447547, 10114.0, 10152.543135558917, 10190.949045254727, 5351.785928562814, 5353.357597088374, 5365.356157261153, 5390.21841832932, 5408.48619381166, 4062.309407400749, 4843.709377437365, 4873.585745211697, 4885.706857588556, 4919.852404427873, 3915.1190982029384, 3920.6863450923856, 4032.334664780337, 4060.918781624351, 4112.856050038235, 1305.693162106904, 1316.394458549059, 1324.576135636587, 1330.4079684540286, 1338.3910320804011, 862.8490014247482, 1001.5543083327849, 1005.6781829814389, 1015.0458568945168, 1021.3157184686278, 5699.971500142473, 5807.216025836543, 5881.941180588139, 5897.734601942923, 5957.6127551709, 422.5014482910195, 424.45881501086365, 425.6637256567277, 427.45926403100106, 449.9190145773792, 3929.9214015719526, 3936.5079365079364, 3952.802359882052, 3976.0, 3999.460072890123, 10199.7450063749, 10642.0, 10723.19576031785, 10769.569217231223, 10799.83800242997, 10399.84400233997, 10458.424786636655, 10542.73643158912, 10619.522121504397, 10693.78612427747, 7936.4047696423, 7980.84038319242, 8033.799155021171, 8044.557549334842, 8100.959495202605, 5600.159976003469, 5649.152627105803, 5685.0, 5791.305043394819, 5838.211841401357, 9677.516124193622, 9765.707028789147, 9838.114569688762, 9848.753781155528, 9857.556409961713, 9584.424934503952, 9864.260180486348, 9904.158146557624, 10061.798764024532, 10127.949360253151, 6761.053452516553, 7114.537555058904, 7321.74373896911, 7484.401247900046, 7591.58246296459, 8090.595470226583, 8144.67421303165, 8194.590270486333, 8216.055153657406, 8216.794580135305, 7016.403605693573, 7432.6283685814415, 7525.774226773206, 7693.346065584488, 7774.494657847448, 7527.8118047049265, 7554.169041405331, 7568.772936811904, 7619.352355049883, 7647.541147531166, 6424.10062591247, 6433.613983161025, 6439.903401448888, 6458.773942911976, 6483.157189565515, 4738.976305118453, 4928.827491037797, 5075.264086707333, 5078.035173317058, 5087.287779710918, 5220.791168353223, 5243.161094225058, 5257.185136303879, 5306.8407947761625, 5312.229726689686], "value": 4470.138784535147, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.97192252697266, 319.51752853191675, 326.61785710718465, 330.3541576218493, 332.76706305586094, 5895.823125306248, 5937.732802023908, 6101.908471372933, 6126.816195514136, 6135.9079613805825, 5991.310999235089, 5992.22101126854, 6016.789412370568, 6019.428154325332, 6020.6086604370685, 4458.9331160032625, 4462.598366147046, 4465.687401881862, 4472.776361181945, 4487.19230538503, 4343.978280108595, 4460.710053846506, 4478.305862591304, 4482.618977386926, 4487.663425243103, 4348.195583816988, 4403.097365040175, 4419.558044195587, 4422.09347083847, 4422.916385485561, 4361.847335343264, 4413.4262545869, 4418.933715994247, 4438.4451943507065, 4438.778061096932, 3613.0606042428894, 3817.141143242776, 3830.272248272819, 3835.137094153821, 3856.67218286446, 5705.800296989627, 5734.448170564101, 5745.080787074048, 5751.1085781703905, 5772.6536407815665, 5121.28302037715, 5130.256112863651, 5133.6919784813035, 5165.096108181053, 5178.508041736029, 6142.539309551801, 6153.077038444269, 6153.630782153085, 6175.59858609189, 6293.2762732285455, 4125.381192821071, 4158.542560318362, 4187.91624167518, 4206.747595144301, 4208.410822484854, 6503.349665033506, 6527.086207930894, 6597.439217666504, 6598.60408375499, 6605.504587155934, 4194.182134483746, 4283.785810709452, 4305.913881722348, 4319.416878721395, 4323.697341186087, 4329.242382583036, 4343.652507799368, 4352.738835669807, 4367.781610919441, 4390.890227744332, 5097.209932460474, 5118.97440512795, 5129.948700513021, 5142.994232249425, 5153.871153221125, 5836.474717275466, 6164.352742961924, 6289.937100629027, 6360.14138091361, 6370.554061215763, 1504.0372314130166, 1529.495266562032, 1530.4566878758103, 1536.5159974607964, 1537.415782002854, 953.5536620203966, 973.4013581647235, 977.8386566216636, 978.7014960437135, 980.9411435313904, 6125.693715314305, 6127.601705889192, 6167.784127555604, 6172.753089876444, 6223.408776166257, 6441.227052753606, 6495.870082598416, 6496.967515162489, 6555.213374395008, 6562.409383155539, 6024.608400453956, 6137.202163718688, 6140.754369825247, 6162.383761623802, 6167.444929956326, 3462.6364231755806, 3485.5643044619424, 3488.127968007998, 3490.7556471046782, 3499.562554680665, 6624.701888415033, 6705.0, 6734.865302693918, 6745.392914637706, 6767.330541926055, 6649.035889795952, 6671.299513551105, 6680.83297917556, 6689.933100668931, 6703.927371620614, 6570.967145164243, 6653.9667301663185, 6741.0, 6742.460603151736, 6757.493188010919, 6380.234371875405, 6415.133956915944, 6452.0, 6461.64460954652, 6462.838429039311, 6287.497000239879, 6402.35976402356, 6413.775517856852, 6424.93575064262, 6429.7749578764515, 6761.729530818909, 6790.287019862843, 6794.456443484411, 6801.89797153053, 6803.591784492946, 4284.007936309631, 4291.806868690854, 4327.415798867112, 4359.106383191502, 4361.912761744811, 6291.874162516816, 6428.4214420702365, 6477.902831457626, 6549.869002619826, 6575.605463672195, 6316.989281714904, 6333.556651034568, 6351.460125889351, 6352.269489008823, 6354.0, 6138.324784273816, 6302.275238347649, 6336.7465301389275, 6339.461145802658, 6351.364863513611, 6142.662153581417, 6179.443850053517, 6207.6585787782105, 6219.440250377488, 6290.811275661737, 6417.7753778617525, 6431.067495213074, 6447.516436267392, 6450.580712253689, 6479.967600161969, 6022.247219097613, 6269.185005949197, 6284.905726414016, 6302.180716506825, 6334.144890439732], "value": 4696.958771945802, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.1007266099026, 749.5165618176277, 765.4679997401804, 863.8358711844749, 881.8236352729454, 13161.539346122887, 13265.0, 13288.402021909013, 13528.391222394992, 13610.0, 14066.085704429204, 14110.365033573487, 14135.293235338244, 14238.857611423882, 14270.785938210935, 683.6991723641606, 803.4014659078995, 813.820959388935, 831.4844796226348, 836.0135040652028, 824.2499325613693, 826.8222332198576, 829.2453866981049, 829.6847198064727, 830.7881490219985, 852.1946760311508, 858.9570521473902, 865.6926790989203, 867.371155911965, 867.3841572483512, 856.6915910272297, 857.3869683176528, 861.9655213791441, 863.9092895246034, 866.0300463480879, 632.7152781248457, 634.7524465458475, 635.586868535451, 636.1221514310269, 636.7675798333621, 13126.0, 13207.801882971764, 13252.734945301136, 13295.268760218185, 13337.399817008161, 13329.66675833112, 13394.598162055056, 13575.932120339336, 13638.727225455435, 13696.178229306273, 11251.09991200702, 11311.773764524663, 11350.262232954914, 11388.886111138949, 11435.885641143564, 3836.76979381238, 3849.788261645608, 3885.2229554089295, 3946.4277679736565, 3955.920881582381, 53733.19400209, 53991.19013214805, 54049.1892621611, 54185.45814541844, 54250.18624720632, 10520.631777887736, 10898.945505272422, 11065.668029959113, 11099.223054386277, 11195.4962026709, 20030.198792048446, 20211.292604759055, 20217.090230939644, 20378.59242815165, 20380.898095509427, 8423.705170319132, 8545.957270213608, 8576.1423857615, 8590.0, 8663.826723465496, 4692.835750748775, 4762.761861906891, 4772.76136193189, 4784.210605250164, 4825.6139508839915, 3487.3548393546766, 3585.964140358615, 3587.712982961357, 3589.6051434342726, 3602.441621548664, 644.1239913717341, 650.7657243392375, 659.8383396067898, 668.5286872754697, 676.3067855448205, 688.7176257734305, 711.5090587494716, 795.9920400796034, 822.5722624235364, 826.1655727715051, 9152.771180720401, 9594.0, 9876.160526355197, 9880.35777674449, 9890.456024918698, 608.0848323273445, 634.8317695810614, 664.5974801094106, 684.9931500685029, 713.8429545499981, 4454.910901781946, 4544.681872268976, 4573.6569757268335, 4580.702254353457, 4594.747288899142, 57969.71015144897, 59515.702421487615, 60000.0, 60512.579496820515, 60522.0, 53498.73250633722, 54386.728066359414, 54395.45604543983, 55934.160987585215, 56164.71917640467, 48194.5180548197, 48759.26861097087, 48839.75580122077, 49265.26102108471, 49645.25532117021, 8795.604197810986, 8872.24585910205, 8872.778180545538, 8939.776505587412, 8986.505742183981, 32102.0, 32111.839440802647, 32304.515432268065, 32309.838450807594, 33031.17422064468, 41634.375484368364, 43844.34233486564, 44279.335809962235, 44673.32990005217, 44760.77619611881, 11553.942230288794, 11673.708157296136, 11716.648500544998, 11725.179237453638, 11749.118816088656, 12907.677308067374, 12992.675183120498, 12997.15518491295, 13231.66920826987, 13563.59309220725, 12060.638180854588, 12174.208676436003, 12205.389730513261, 12469.0, 12563.560275390317, 11409.25839820409, 11728.179027468337, 12013.219140755822, 12354.135210535176, 12561.24632522015, 11382.0, 11724.472398741906, 12875.484980600671, 13315.134516256412, 13404.530841420503, 10599.0, 10646.8402973957, 10767.300125491818, 10793.40636265013, 10981.83527247076, 10684.626038088629, 10921.344719316867, 10962.835557466804, 11175.441227938409, 11186.552537898393], "value": 6734.14650418179, "unit": "score"}], "name": "dromaeo_css", "value": 7110.262080253114, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 105.0, 111.0, 110.0, 110.0, 126.0, 113.0, 112.0, 110.0, 110.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 129.0, 163.0, 193.0, 129.0, 152.0, 154.0, 131.0, 184.0, 128.0], "value": 151.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 162.0, 163.0, 160.0, 163.0, 168.0, 164.0, 166.0, 165.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 76.0, 181.0, 76.0, 73.0, 76.0, 77.0, 164.0, 74.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 151.0, 93.0, 93.0, 94.0, 139.0, 93.0, 92.0, 154.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 119.0, 120.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 97.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 60.0, 58.0, 60.0, 59.0, 59.0, 58.0, 84.0, 56.0, 57.0], "value": 60.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 61.0, 67.0, 62.0, 62.0, 63.0, 61.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 81.0, 79.0, 81.0, 81.0, 82.0, 82.0, 82.0, 88.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 131.0, 129.0, 131.0, 128.0, 136.0, 134.0, 135.0, 171.0, 137.0], "value": 136.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 170.0, 172.0, 161.0, 164.0, 169.0, 167.0, 164.0, 168.0, 161.0], "value": 166.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 70.0, 72.0, 72.0, 70.0, 71.0, 67.0, 68.0, 67.0], "value": 70.0, "unit": "score"}], "name": "kraken", "value": 1568.1, "alertThreshold": 2.0}]} 19:29:01 INFO - Return code: 0 19:29:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:29:01 ERROR - # TBPL SUCCESS # 19:29:01 INFO - Running post-action listener: _resource_record_post_action 19:29:01 INFO - Running post-run listener: _resource_record_post_run 19:29:02 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 552792064; Read time: 8; Write time: 647520 19:29:02 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 261726208; Read time: 0; Write time: 431572 19:29:02 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291004416; Read time: 8; Write time: 215948 19:29:02 INFO - Running post-run listener: _upload_blobber_files 19:29:02 INFO - Blob upload gear active. 19:29:02 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:29:02 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:29:02 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:29:02 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:29:03 INFO - (blobuploader) - INFO - Open directory for files ... 19:29:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:29:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:29:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:29:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:29:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:29:04 INFO - (blobuploader) - INFO - Done attempting. 19:29:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:29:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:29:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:29:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:29:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:29:04 INFO - (blobuploader) - INFO - Done attempting. 19:29:04 INFO - (blobuploader) - INFO - Iteration through files over. 19:29:04 INFO - Return code: 0 19:29:04 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:29:04 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:29:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2599023864739a3c18c0294ce444ec42194c7054596195f0c6815d598170b56944afcb4fadbeca434048c7c46c2fea017912c97717c48e88bf33ae2a58e34586", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/900a1d31d2fa0391e2047236df1a45b7e0002099eaa0f5b786339cbe3ffd37b4afdecfb4d39e271b88e5a9d38fd8530d631c8b75015eed5f3c8df19c1acd9804"} 19:29:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:29:04 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:29:04 INFO - Contents: 19:29:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2599023864739a3c18c0294ce444ec42194c7054596195f0c6815d598170b56944afcb4fadbeca434048c7c46c2fea017912c97717c48e88bf33ae2a58e34586", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/900a1d31d2fa0391e2047236df1a45b7e0002099eaa0f5b786339cbe3ffd37b4afdecfb4d39e271b88e5a9d38fd8530d631c8b75015eed5f3c8df19c1acd9804"} 19:29:04 INFO - Running post-run listener: copy_logs_to_upload_dir 19:29:04 INFO - Copying logs to upload dir... 19:29:04 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:29:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.124246 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-04-13 19:29:04.732581) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 19:29:04.737121) ========= 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=0274524eba3bdaad075c2247000001d4-1460595134.771347-1256880993 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/2599023864739a3c18c0294ce444ec42194c7054596195f0c6815d598170b56944afcb4fadbeca434048c7c46c2fea017912c97717c48e88bf33ae2a58e34586", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/900a1d31d2fa0391e2047236df1a45b7e0002099eaa0f5b786339cbe3ffd37b4afdecfb4d39e271b88e5a9d38fd8530d631c8b75015eed5f3c8df19c1acd9804"} build_url:https://queue.taskcluster.net/v1/task/bEIea4yMSDy8y4-ni3t_tQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011389 build_url: 'https://queue.taskcluster.net/v1/task/bEIea4yMSDy8y4-ni3t_tQ/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/2599023864739a3c18c0294ce444ec42194c7054596195f0c6815d598170b56944afcb4fadbeca434048c7c46c2fea017912c97717c48e88bf33ae2a58e34586", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/900a1d31d2fa0391e2047236df1a45b7e0002099eaa0f5b786339cbe3ffd37b4afdecfb4d39e271b88e5a9d38fd8530d631c8b75015eed5f3c8df19c1acd9804"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 19:29:04.764069) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 19:29:04.764384) ========= 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=0274524eba3bdaad075c2247000001d4-1460595134.771347-1256880993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004544 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 19:29:04.845318) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 19:29:04.845623) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 19:29:04.846308) ========= ========= Total master_lag: 0.29 =========