builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1458987208.15 results: success (0) buildid: 20160326004034 builduid: 7ebc44b71d844affbe9af384f8bb061a revision: 5629a22932f74f3e2d647c3462c32191a791afed ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-26 03:13:28.145379) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-26 03:13:28.145757) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-26 03:13:28.146035) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1458986068.545408-207911920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006308 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-26 03:13:28.169909) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-26 03:13:28.170177) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-26 03:13:28.192315) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-26 03:13:28.192568) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1458986068.545408-207911920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.025672 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-26 03:13:28.243277) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-26 03:13:28.243539) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-26 03:13:28.243884) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-26 03:13:28.244155) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1458986068.545408-207911920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-26 03:13:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 31.3M=0s 2016-03-26 03:13:28 (31.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171168 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-26 03:13:28.535817) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-26 03:13:28.536095) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1458986068.545408-207911920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.037273 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-26 03:13:28.589403) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-26 03:13:28.592733) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5629a22932f74f3e2d647c3462c32191a791afed --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5629a22932f74f3e2d647c3462c32191a791afed --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=5ac5dba3e01a12f1ff77ab15000001b1-1458986068.545408-207911920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-26 03:13:28,782 truncating revision to first 12 chars 2016-03-26 03:13:28,782 Setting DEBUG logging. 2016-03-26 03:13:28,782 attempt 1/10 2016-03-26 03:13:28,782 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5629a22932f7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-26 03:13:29,562 unpacking tar archive at: mozilla-aurora-5629a22932f7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.118404 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-26 03:13:29.735928) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-26 03:13:29.736225) ========= echo 5629a22932f74f3e2d647c3462c32191a791afed in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5629a22932f74f3e2d647c3462c32191a791afed'] 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=5ac5dba3e01a12f1ff77ab15000001b1-1458986068.545408-207911920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5629a22932f74f3e2d647c3462c32191a791afed program finished with exit code 0 elapsedTime=0.004720 script_repo_revision: '5629a22932f74f3e2d647c3462c32191a791afed' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-26 03:13:29.788257) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-26 03:13:29.788531) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-26 03:13:29.807389) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-03-26 03:13:29.807647) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=5ac5dba3e01a12f1ff77ab15000001b1-1458986068.545408-207911920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:13:30 INFO - MultiFileLogger online at 20160326 03:13:30 in /builds/slave/test-pgo 03:13:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:13:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:13:30 INFO - {'append_to_log': False, 03:13:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:13:30 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:13:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:13:30 INFO - 'branch': 'Mozilla-Aurora', 03:13:30 INFO - 'buildbot_json_path': 'buildprops.json', 03:13:30 INFO - 'config_files': ('talos/linux_config.py',), 03:13:30 INFO - 'default_actions': ('clobber', 03:13:30 INFO - 'read-buildbot-config', 03:13:30 INFO - 'download-and-extract', 03:13:30 INFO - 'populate-webroot', 03:13:30 INFO - 'create-virtualenv', 03:13:30 INFO - 'install', 03:13:30 INFO - 'run-tests'), 03:13:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:13:30 INFO - 'download_minidump_stackwalk': True, 03:13:30 INFO - 'download_symbols': 'ondemand', 03:13:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:13:30 INFO - 'tooltool.py': '/tools/tooltool.py', 03:13:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:13:30 INFO - '/tools/misc-python/virtualenv.py')}, 03:13:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:13:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:13:30 INFO - 'installer_path': 'installer.exe', 03:13:30 INFO - 'log_level': 'info', 03:13:30 INFO - 'log_name': 'talos', 03:13:30 INFO - 'log_to_console': True, 03:13:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:13:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:13:30 INFO - 'opt_config_files': (), 03:13:30 INFO - 'pip_index': False, 03:13:30 INFO - 'sps_profile': False, 03:13:30 INFO - 'sps_profile_interval': 0, 03:13:30 INFO - 'suite': 'dromaeojs-e10s', 03:13:30 INFO - 'system_bits': '32', 03:13:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:13:30 INFO - 'title': 'talos-linux64-ix-051', 03:13:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:13:30 INFO - 'use_talos_json': True, 03:13:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:13:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:13:30 INFO - 'work_dir': 'build'} 03:13:30 INFO - ##### 03:13:30 INFO - ##### Running clobber step. 03:13:30 INFO - ##### 03:13:30 INFO - Running pre-action listener: _resource_record_pre_action 03:13:30 INFO - Running main action method: clobber 03:13:30 INFO - rmtree: /builds/slave/test-pgo/build 03:13:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:13:31 INFO - Running post-action listener: _resource_record_post_action 03:13:31 INFO - ##### 03:13:31 INFO - ##### Running read-buildbot-config step. 03:13:31 INFO - ##### 03:13:31 INFO - Running pre-action listener: _resource_record_pre_action 03:13:31 INFO - Running main action method: read_buildbot_config 03:13:31 INFO - Using buildbot properties: 03:13:31 INFO - { 03:13:31 INFO - "project": "", 03:13:31 INFO - "product": "firefox", 03:13:31 INFO - "script_repo_revision": "production", 03:13:31 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:13:31 INFO - "repository": "", 03:13:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:13:31 INFO - "buildid": "20160326004034", 03:13:31 INFO - "stage_platform": "linux64-pgo", 03:13:31 INFO - "basedir": "/builds/slave/test-pgo", 03:13:31 INFO - "nightly_build": "True", 03:13:31 INFO - "buildnumber": 264, 03:13:31 INFO - "slavename": "talos-linux64-ix-051", 03:13:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:13:31 INFO - "platform": "ubuntu64_hw", 03:13:31 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:13:31 INFO - "branch": "mozilla-aurora", 03:13:31 INFO - "repo_path": "releases/mozilla-aurora", 03:13:31 INFO - "revision": "5629a22932f74f3e2d647c3462c32191a791afed", 03:13:31 INFO - "pgo_build": "True", 03:13:31 INFO - "builduid": "7ebc44b71d844affbe9af384f8bb061a", 03:13:31 INFO - "slavebuilddir": "test" 03:13:31 INFO - } 03:13:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 03:13:31 INFO - Running post-action listener: _resource_record_post_action 03:13:31 INFO - ##### 03:13:31 INFO - ##### Running download-and-extract step. 03:13:31 INFO - ##### 03:13:31 INFO - Running pre-action listener: _resource_record_pre_action 03:13:31 INFO - Running main action method: download_and_extract 03:13:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:13:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:31 INFO - https://queue.taskcluster.net/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:13:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:13:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:13:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:13:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:13:34 INFO - Downloaded 1448 bytes. 03:13:34 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:13:34 INFO - Using the following test package requirements: 03:13:34 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:13:34 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:13:34 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:13:34 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:13:34 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:13:34 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:13:34 INFO - u'jsshell-linux-x86_64.zip'], 03:13:34 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:13:34 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:13:34 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:13:34 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:13:34 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:13:34 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:13:34 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:13:34 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:13:34 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:13:34 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:13:34 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:13:34 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:13:34 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:34 INFO - https://queue.taskcluster.net/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:13:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:13:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:13:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:13:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:13:36 INFO - Downloaded 23311012 bytes. 03:13:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 03:13:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 03:13:38 INFO - Return code: 0 03:13:38 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:38 INFO - https://queue.taskcluster.net/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:13:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:13:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:13:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:13:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:13:39 INFO - Downloaded 23311012 bytes. 03:13:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 03:13:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 03:13:41 INFO - Return code: 0 03:13:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:41 INFO - https://queue.taskcluster.net/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:13:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:13:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:13:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:13:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:13:42 INFO - Downloaded 10845161 bytes. 03:13:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 03:13:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 03:13:42 INFO - Return code: 0 03:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:42 INFO - https://queue.taskcluster.net/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:13:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:13:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:13:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:13:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:13:43 INFO - Downloaded 60443766 bytes. 03:13:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:13:43 INFO - mkdir: /builds/slave/test-pgo/properties 03:13:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:13:43 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:13:43 INFO - Contents: 03:13:43 INFO - build_url:https://queue.taskcluster.net/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:13:44 INFO - Running post-action listener: _resource_record_post_action 03:13:44 INFO - Running post-action listener: set_extra_try_arguments 03:13:44 INFO - ##### 03:13:44 INFO - ##### Running populate-webroot step. 03:13:44 INFO - ##### 03:13:44 INFO - Running pre-action listener: _resource_record_pre_action 03:13:44 INFO - Running main action method: populate_webroot 03:13:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:13:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:13:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:13:44 INFO - '--tppagecycles', 03:13:44 INFO - '7'], 03:13:44 INFO - 'tests': ['tsvgm']}}, 03:13:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:13:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:13:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:13:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:13:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:13:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:13:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:13:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:44 INFO - 'talos_options': ['--e10s'], 03:13:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:13:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:44 INFO - 'tests': ['damp', 'tps']}, 03:13:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:44 INFO - 'talos_options': ['--e10s'], 03:13:44 INFO - 'tests': ['damp', 'tps']}, 03:13:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:13:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:13:44 INFO - 'other': {'tests': ['a11yr', 03:13:44 INFO - 'ts_paint', 03:13:44 INFO - 'tpaint', 03:13:44 INFO - 'sessionrestore', 03:13:44 INFO - 'sessionrestore_no_auto_restore', 03:13:44 INFO - 'tabpaint']}, 03:13:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:13:44 INFO - 'tests': ['a11yr', 03:13:44 INFO - 'ts_paint', 03:13:44 INFO - 'tpaint', 03:13:44 INFO - 'sessionrestore', 03:13:44 INFO - 'sessionrestore_no_auto_restore', 03:13:44 INFO - 'tabpaint']}, 03:13:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:13:44 INFO - 'tests': ['a11yr', 03:13:44 INFO - 'ts_paint', 03:13:44 INFO - 'tpaint', 03:13:44 INFO - 'sessionrestore', 03:13:44 INFO - 'sessionrestore_no_auto_restore', 03:13:44 INFO - 'tabpaint']}, 03:13:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:13:44 INFO - 'tests': ['a11yr', 03:13:44 INFO - 'ts_paint', 03:13:44 INFO - 'tpaint', 03:13:44 INFO - 'sessionrestore', 03:13:44 INFO - 'sessionrestore_no_auto_restore', 03:13:44 INFO - 'tabpaint']}, 03:13:44 INFO - 'other_l64': {'tests': ['a11yr', 03:13:44 INFO - 'ts_paint', 03:13:44 INFO - 'tpaint', 03:13:44 INFO - 'sessionrestore', 03:13:44 INFO - 'sessionrestore_no_auto_restore', 03:13:44 INFO - 'tabpaint']}, 03:13:44 INFO - 'other_nol64': {'tests': ['a11yr', 03:13:44 INFO - 'ts_paint', 03:13:44 INFO - 'tpaint', 03:13:44 INFO - 'sessionrestore', 03:13:44 INFO - 'sessionrestore_no_auto_restore', 03:13:44 INFO - 'tabpaint']}, 03:13:44 INFO - 'svgr': {'tests': ['tsvgx', 03:13:44 INFO - 'tsvgr_opacity', 03:13:44 INFO - 'tart', 03:13:44 INFO - 'tscrollx', 03:13:44 INFO - 'cart']}, 03:13:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:13:44 INFO - 'tests': ['tsvgx', 03:13:44 INFO - 'tsvgr_opacity', 03:13:44 INFO - 'tart', 03:13:44 INFO - 'tscrollx', 03:13:44 INFO - 'cart']}, 03:13:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:44 INFO - 'tests': ['tp5o']}, 03:13:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:44 INFO - 'talos_options': ['--e10s'], 03:13:44 INFO - 'tests': ['tp5o']}, 03:13:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:44 INFO - 'talos_options': ['--xperf_path', 03:13:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:13:44 INFO - 'tests': ['tp5n']}, 03:13:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:44 INFO - 'talos_options': ['--e10s', 03:13:44 INFO - '--xperf_path', 03:13:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:13:44 INFO - 'tests': ['tp5n']}}, 03:13:44 INFO - 'talos.zip': {'path': '', 03:13:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:13:44 INFO - Running post-action listener: _resource_record_post_action 03:13:44 INFO - ##### 03:13:44 INFO - ##### Running create-virtualenv step. 03:13:44 INFO - ##### 03:13:44 INFO - Running pre-action listener: _resource_record_pre_action 03:13:44 INFO - Running main action method: create_virtualenv 03:13:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:13:44 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 03:13:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:13:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:13:44 INFO - Using real prefix '/usr' 03:13:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:13:45 INFO - Installing distribute.............................................................................................................................................................................................done. 03:13:47 INFO - Installing pip.................done. 03:13:47 INFO - Return code: 0 03:13:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:13: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')]} 03:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13: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')]} 03:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:47 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 0x7fe2a04a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4d6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc920>, '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 0x1ddd820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dddcb0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1458986068.545408-207911920', '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 03:13:47 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 03:13:47 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 03:13:47 INFO - Using env: {'DISPLAY': ':0', 03:13:47 INFO - 'HOME': '/home/cltbld', 03:13:47 INFO - 'LANG': 'en_US.UTF-8', 03:13:47 INFO - 'LANGUAGE': 'en_US:en', 03:13:47 INFO - 'LOGNAME': 'cltbld', 03:13:47 INFO - 'MAIL': '/var/mail/cltbld', 03:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:47 INFO - 'MOZ_NO_REMOTE': '1', 03:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:47 INFO - 'NO_EM_RESTART': '1', 03:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:13:47 INFO - 'PWD': '/builds/slave/test-pgo', 03:13:47 INFO - 'SHELL': '/bin/bash', 03:13:47 INFO - 'SHLVL': '1', 03:13:47 INFO - 'TERM': 'linux', 03:13:47 INFO - 'TMOUT': '86400', 03:13:47 INFO - 'USER': 'cltbld', 03:13:47 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458986068.545408-207911920', 03:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:47 INFO - '_': '/tools/buildbot/bin/python'} 03:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:47 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 03:13:47 INFO - Cleaning up... 03:13:47 INFO - Return code: 0 03:13:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:13: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')]} 03:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13: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')]} 03:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:47 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 0x7fe2a04a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4d6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc920>, '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 0x1ddd820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dddcb0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1458986068.545408-207911920', '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 03:13:47 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 03:13:47 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 03:13:47 INFO - Using env: {'DISPLAY': ':0', 03:13:47 INFO - 'HOME': '/home/cltbld', 03:13:47 INFO - 'LANG': 'en_US.UTF-8', 03:13:47 INFO - 'LANGUAGE': 'en_US:en', 03:13:47 INFO - 'LOGNAME': 'cltbld', 03:13:47 INFO - 'MAIL': '/var/mail/cltbld', 03:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:47 INFO - 'MOZ_NO_REMOTE': '1', 03:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:47 INFO - 'NO_EM_RESTART': '1', 03:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:13:47 INFO - 'PWD': '/builds/slave/test-pgo', 03:13:47 INFO - 'SHELL': '/bin/bash', 03:13:47 INFO - 'SHLVL': '1', 03:13:47 INFO - 'TERM': 'linux', 03:13:47 INFO - 'TMOUT': '86400', 03:13:47 INFO - 'USER': 'cltbld', 03:13:47 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458986068.545408-207911920', 03:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:47 INFO - '_': '/tools/buildbot/bin/python'} 03:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:47 INFO - Downloading/unpacking psutil>=0.7.1 03:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:13:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:13:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:13:49 INFO - Installing collected packages: psutil 03:13:49 INFO - Running setup.py install for psutil 03:13:49 INFO - building 'psutil._psutil_linux' extension 03:13:49 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 03:13:49 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 03:13:49 INFO - building 'psutil._psutil_posix' extension 03:13:49 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 03:13:50 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 03:13:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:13:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:13:50 INFO - Successfully installed psutil 03:13:50 INFO - Cleaning up... 03:13:50 INFO - Return code: 0 03:13:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe2a04a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4d6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc920>, '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 0x1ddd820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dddcb0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1458986068.545408-207911920', '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 03:13:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 03:13:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:13:50 INFO - Using env: {'DISPLAY': ':0', 03:13:50 INFO - 'HOME': '/home/cltbld', 03:13:50 INFO - 'LANG': 'en_US.UTF-8', 03:13:50 INFO - 'LANGUAGE': 'en_US:en', 03:13:50 INFO - 'LOGNAME': 'cltbld', 03:13:50 INFO - 'MAIL': '/var/mail/cltbld', 03:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:50 INFO - 'MOZ_NO_REMOTE': '1', 03:13:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:50 INFO - 'NO_EM_RESTART': '1', 03:13:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:13:50 INFO - 'PWD': '/builds/slave/test-pgo', 03:13:50 INFO - 'SHELL': '/bin/bash', 03:13:50 INFO - 'SHLVL': '1', 03:13:50 INFO - 'TERM': 'linux', 03:13:50 INFO - 'TMOUT': '86400', 03:13:50 INFO - 'USER': 'cltbld', 03:13:50 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458986068.545408-207911920', 03:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:50 INFO - '_': '/tools/buildbot/bin/python'} 03:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:13:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:13:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:13:52 INFO - Installing collected packages: mozsystemmonitor 03:13:52 INFO - Running setup.py install for mozsystemmonitor 03:13:52 INFO - Successfully installed mozsystemmonitor 03:13:52 INFO - Cleaning up... 03:13:52 INFO - Return code: 0 03:13:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe2a04a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4d6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc920>, '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 0x1ddd820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dddcb0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1458986068.545408-207911920', '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 03:13:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 03:13:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:13:52 INFO - Using env: {'DISPLAY': ':0', 03:13:52 INFO - 'HOME': '/home/cltbld', 03:13:52 INFO - 'LANG': 'en_US.UTF-8', 03:13:52 INFO - 'LANGUAGE': 'en_US:en', 03:13:52 INFO - 'LOGNAME': 'cltbld', 03:13:52 INFO - 'MAIL': '/var/mail/cltbld', 03:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:52 INFO - 'MOZ_NO_REMOTE': '1', 03:13:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:52 INFO - 'NO_EM_RESTART': '1', 03:13:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:13:52 INFO - 'PWD': '/builds/slave/test-pgo', 03:13:52 INFO - 'SHELL': '/bin/bash', 03:13:52 INFO - 'SHLVL': '1', 03:13:52 INFO - 'TERM': 'linux', 03:13:52 INFO - 'TMOUT': '86400', 03:13:52 INFO - 'USER': 'cltbld', 03:13:52 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458986068.545408-207911920', 03:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:52 INFO - '_': '/tools/buildbot/bin/python'} 03:13:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:52 INFO - Downloading/unpacking blobuploader==1.2.4 03:13: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 03:13: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 03:13: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 03:13: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 03:13: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 03:13: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 03:13:54 INFO - Downloading blobuploader-1.2.4.tar.gz 03:13:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:13:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:13: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 03:13: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 03:13: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 03:13: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 03:13: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 03:13: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 03:13:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:13:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:13: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 03:13: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 03:13: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 03:13: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 03:13: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 03:13: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 03:13:55 INFO - Downloading docopt-0.6.1.tar.gz 03:13:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:13:55 INFO - Installing collected packages: blobuploader, requests, docopt 03:13:55 INFO - Running setup.py install for blobuploader 03:13:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:13:55 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:13:55 INFO - Running setup.py install for requests 03:13:55 INFO - Running setup.py install for docopt 03:13:55 INFO - Successfully installed blobuploader requests docopt 03:13:55 INFO - Cleaning up... 03:13:55 INFO - Return code: 0 03:13:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:13:55 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')]} 03:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:55 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')]} 03:13:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:55 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 0x7fe2a04a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4d6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc920>, '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 0x1ddd820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dddcb0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1458986068.545408-207911920', '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 03:13:55 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 03:13:55 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 03:13:55 INFO - Using env: {'DISPLAY': ':0', 03:13:55 INFO - 'HOME': '/home/cltbld', 03:13:55 INFO - 'LANG': 'en_US.UTF-8', 03:13:55 INFO - 'LANGUAGE': 'en_US:en', 03:13:55 INFO - 'LOGNAME': 'cltbld', 03:13:55 INFO - 'MAIL': '/var/mail/cltbld', 03:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:55 INFO - 'MOZ_NO_REMOTE': '1', 03:13:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:55 INFO - 'NO_EM_RESTART': '1', 03:13:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:13:55 INFO - 'PWD': '/builds/slave/test-pgo', 03:13:55 INFO - 'SHELL': '/bin/bash', 03:13:55 INFO - 'SHLVL': '1', 03:13:55 INFO - 'TERM': 'linux', 03:13:55 INFO - 'TMOUT': '86400', 03:13:55 INFO - 'USER': 'cltbld', 03:13:55 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458986068.545408-207911920', 03:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:55 INFO - '_': '/tools/buildbot/bin/python'} 03:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:13:56 INFO - Running setup.py (path:/tmp/pip-KK9qTv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:13:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:13:56 INFO - Running setup.py (path:/tmp/pip-joYEd6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:13:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:13:56 INFO - Running setup.py (path:/tmp/pip-zYEwEi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:13:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:13:56 INFO - Running setup.py (path:/tmp/pip-xeagm6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:13:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:13:56 INFO - Running setup.py (path:/tmp/pip-ZMfjZv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:13:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:13:56 INFO - Running setup.py (path:/tmp/pip-1pojh5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:13:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:13:56 INFO - Running setup.py (path:/tmp/pip-2C7_Uw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:13:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:13:56 INFO - Running setup.py (path:/tmp/pip-zMte7B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:13:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:13:56 INFO - Running setup.py (path:/tmp/pip-z_pBrp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:13:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:13:56 INFO - Running setup.py (path:/tmp/pip-i7V7Iv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:13:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:13:56 INFO - Running setup.py (path:/tmp/pip-of1gWV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:13:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:13:56 INFO - Running setup.py (path:/tmp/pip-o8z0np-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:13:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:13:56 INFO - Running setup.py (path:/tmp/pip-QeyLBv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:13:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:13:57 INFO - Running setup.py (path:/tmp/pip-i9nBfI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:13:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:13:57 INFO - Running setup.py (path:/tmp/pip-pAEGpl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:13:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:13:57 INFO - Running setup.py (path:/tmp/pip-jcq6vO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:13:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:13:57 INFO - Running setup.py (path:/tmp/pip-A4ihPh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:13:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:13:57 INFO - Running setup.py install for manifestparser 03:13:57 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:13:57 INFO - Running setup.py install for mozcrash 03:13:57 INFO - Running setup.py install for mozdebug 03:13:57 INFO - Running setup.py install for mozdevice 03:13:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:13:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:13:57 INFO - Running setup.py install for mozfile 03:13:57 INFO - Running setup.py install for mozhttpd 03:13:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:13:57 INFO - Running setup.py install for mozinfo 03:13:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:13:58 INFO - Running setup.py install for mozInstall 03:13:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:13:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:13:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:13:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:13:58 INFO - Running setup.py install for mozleak 03:13:58 INFO - Running setup.py install for mozlog 03:13:58 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:13:58 INFO - Running setup.py install for moznetwork 03:13:58 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:13:58 INFO - Running setup.py install for mozprocess 03:13:58 INFO - Running setup.py install for mozprofile 03:13:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:13:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:13:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:13:58 INFO - Running setup.py install for mozrunner 03:13:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:13:58 INFO - Running setup.py install for mozscreenshot 03:13:58 INFO - Running setup.py install for moztest 03:13:58 INFO - Running setup.py install for mozversion 03:13:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:13:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:13:59 INFO - Cleaning up... 03:13:59 INFO - Return code: 0 03:13:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:13:59 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')]} 03:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:59 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')]} 03:13:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:59 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 0x7fe2a04a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4d6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc920>, '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 0x1ddd820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dddcb0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1458986068.545408-207911920', '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 03:13:59 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 03:13:59 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 03:13:59 INFO - Using env: {'DISPLAY': ':0', 03:13:59 INFO - 'HOME': '/home/cltbld', 03:13:59 INFO - 'LANG': 'en_US.UTF-8', 03:13:59 INFO - 'LANGUAGE': 'en_US:en', 03:13:59 INFO - 'LOGNAME': 'cltbld', 03:13:59 INFO - 'MAIL': '/var/mail/cltbld', 03:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:59 INFO - 'MOZ_NO_REMOTE': '1', 03:13:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:59 INFO - 'NO_EM_RESTART': '1', 03:13:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:13:59 INFO - 'PWD': '/builds/slave/test-pgo', 03:13:59 INFO - 'SHELL': '/bin/bash', 03:13:59 INFO - 'SHLVL': '1', 03:13:59 INFO - 'TERM': 'linux', 03:13:59 INFO - 'TMOUT': '86400', 03:13:59 INFO - 'USER': 'cltbld', 03:13:59 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458986068.545408-207911920', 03:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:59 INFO - '_': '/tools/buildbot/bin/python'} 03:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:13:59 INFO - Running setup.py (path:/tmp/pip-bckYA8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:13:59 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)) 03:13:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:13:59 INFO - Running setup.py (path:/tmp/pip-AGfJwB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:13:59 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)) 03:13:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:13:59 INFO - Running setup.py (path:/tmp/pip-WEOd1S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:13:59 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)) 03:13:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:13:59 INFO - Running setup.py (path:/tmp/pip-0BrFe5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:13:59 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)) 03:13:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:13:59 INFO - Running setup.py (path:/tmp/pip-XXuFHX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:13:59 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)) 03:13:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:13:59 INFO - Running setup.py (path:/tmp/pip-ApJlot-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:13:59 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)) 03:13:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:13:59 INFO - Running setup.py (path:/tmp/pip-PkLDBG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:13:59 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)) 03:13:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:13:59 INFO - Running setup.py (path:/tmp/pip-zyNEqN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:13:59 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)) 03:13:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:13:59 INFO - Running setup.py (path:/tmp/pip-lfIZSL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:13:59 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)) 03:13:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:13:59 INFO - Running setup.py (path:/tmp/pip-CnuU8F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:14:00 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)) 03:14:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:14:00 INFO - Running setup.py (path:/tmp/pip-OdRnng-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:14:00 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)) 03:14:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:14:00 INFO - Running setup.py (path:/tmp/pip-jspAX6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:14:00 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)) 03:14:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:14:00 INFO - Running setup.py (path:/tmp/pip-nwQKbz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:14:00 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)) 03:14:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:14:00 INFO - Running setup.py (path:/tmp/pip-s71EQN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:14:00 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)) 03:14:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:14:00 INFO - Running setup.py (path:/tmp/pip-KcDGUH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:14:00 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)) 03:14:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:14:00 INFO - Running setup.py (path:/tmp/pip-VdKhtq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:14:00 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)) 03:14:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:14:00 INFO - Running setup.py (path:/tmp/pip-asTiEh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:14:00 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)) 03:14:00 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)) 03:14:00 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)) 03:14:00 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)) 03:14:00 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)) 03:14:00 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)) 03:14:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:14:00 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 03:14:00 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 03:14:00 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 03:14:00 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 03:14:00 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 03:14:00 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 03:14:02 INFO - Downloading blessings-1.6.tar.gz 03:14:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:14:02 INFO - Installing collected packages: blessings 03:14:02 INFO - Running setup.py install for blessings 03:14:02 INFO - Successfully installed blessings 03:14:02 INFO - Cleaning up... 03:14:02 INFO - Return code: 0 03:14:02 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:14:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:14:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:14:02 INFO - Reading from file tmpfile_stdout 03:14:02 INFO - Current package versions: 03:14:02 INFO - argparse == 1.2.1 03:14:02 INFO - blessings == 1.6 03:14:02 INFO - blobuploader == 1.2.4 03:14:02 INFO - docopt == 0.6.1 03:14:02 INFO - manifestparser == 1.1 03:14:02 INFO - mozInstall == 1.12 03:14:02 INFO - mozcrash == 0.17 03:14:02 INFO - mozdebug == 0.1 03:14:02 INFO - mozdevice == 0.48 03:14:02 INFO - mozfile == 1.2 03:14:02 INFO - mozhttpd == 0.7 03:14:02 INFO - mozinfo == 0.9 03:14:02 INFO - mozleak == 0.1 03:14:02 INFO - mozlog == 3.1 03:14:02 INFO - moznetwork == 0.27 03:14:02 INFO - mozprocess == 0.22 03:14:02 INFO - mozprofile == 0.28 03:14:02 INFO - mozrunner == 6.11 03:14:02 INFO - mozscreenshot == 0.1 03:14:02 INFO - mozsystemmonitor == 0.0 03:14:02 INFO - moztest == 0.7 03:14:02 INFO - mozversion == 1.4 03:14:02 INFO - psutil == 3.1.1 03:14:02 INFO - requests == 1.2.3 03:14:02 INFO - wsgiref == 0.1.2 03:14:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:14:02 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')]} 03:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:02 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')]} 03:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:02 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 0x7fe2a04a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4d6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc920>, '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 0x1ddd820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dddcb0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1458986068.545408-207911920', '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 03:14:02 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 03:14:02 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 03:14:02 INFO - Using env: {'DISPLAY': ':0', 03:14:02 INFO - 'HOME': '/home/cltbld', 03:14:02 INFO - 'LANG': 'en_US.UTF-8', 03:14:02 INFO - 'LANGUAGE': 'en_US:en', 03:14:02 INFO - 'LOGNAME': 'cltbld', 03:14:02 INFO - 'MAIL': '/var/mail/cltbld', 03:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:02 INFO - 'MOZ_NO_REMOTE': '1', 03:14:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:14:02 INFO - 'NO_EM_RESTART': '1', 03:14:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:14:02 INFO - 'PWD': '/builds/slave/test-pgo', 03:14:02 INFO - 'SHELL': '/bin/bash', 03:14:02 INFO - 'SHLVL': '1', 03:14:02 INFO - 'TERM': 'linux', 03:14:02 INFO - 'TMOUT': '86400', 03:14:02 INFO - 'USER': 'cltbld', 03:14:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458986068.545408-207911920', 03:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:02 INFO - '_': '/tools/buildbot/bin/python'} 03:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:03 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)) 03:14:03 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)) 03:14:03 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)) 03:14:03 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)) 03:14:03 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)) 03:14:03 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)) 03:14:03 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)) 03:14:03 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)) 03:14:03 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)) 03:14:03 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)) 03:14:03 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)) 03:14:03 INFO - Cleaning up... 03:14:03 INFO - Return code: 0 03:14:03 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:14: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')]} 03:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14: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')]} 03:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:03 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 0x7fe2a04a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4d6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc920>, '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 0x1ddd820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dddcb0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1458986068.545408-207911920', '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 03:14:03 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 03:14:03 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 03:14:03 INFO - Using env: {'DISPLAY': ':0', 03:14:03 INFO - 'HOME': '/home/cltbld', 03:14:03 INFO - 'LANG': 'en_US.UTF-8', 03:14:03 INFO - 'LANGUAGE': 'en_US:en', 03:14:03 INFO - 'LOGNAME': 'cltbld', 03:14:03 INFO - 'MAIL': '/var/mail/cltbld', 03:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:03 INFO - 'MOZ_NO_REMOTE': '1', 03:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:14:03 INFO - 'NO_EM_RESTART': '1', 03:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:14:03 INFO - 'PWD': '/builds/slave/test-pgo', 03:14:03 INFO - 'SHELL': '/bin/bash', 03:14:03 INFO - 'SHLVL': '1', 03:14:03 INFO - 'TERM': 'linux', 03:14:03 INFO - 'TMOUT': '86400', 03:14:03 INFO - 'USER': 'cltbld', 03:14:03 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458986068.545408-207911920', 03:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:03 INFO - '_': '/tools/buildbot/bin/python'} 03:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:03 INFO - Downloading/unpacking jsonschema 03:14:03 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 03:14:03 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 03:14:03 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 03:14:03 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 03:14:03 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 03:14:03 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 03:14:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:14:05 INFO - Downloading/unpacking functools32 (from jsonschema) 03:14: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 03:14: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 03:14: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 03:14: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 03:14: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 03:14: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 03:14:05 INFO - Downloading functools32-3.2.3-2.tar.gz 03:14:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:14:05 INFO - warning: no files found matching '*.txt' 03:14:05 INFO - no previously-included directories found matching 'build' 03:14:05 INFO - no previously-included directories found matching 'dist' 03:14:05 INFO - no previously-included directories found matching '.git*' 03:14:05 INFO - Installing collected packages: jsonschema, functools32 03:14:05 INFO - Running setup.py install for functools32 03:14:05 INFO - warning: no files found matching '*.txt' 03:14:05 INFO - no previously-included directories found matching 'build' 03:14:05 INFO - no previously-included directories found matching 'dist' 03:14:05 INFO - no previously-included directories found matching '.git*' 03:14:05 INFO - Successfully installed jsonschema functools32 03:14:05 INFO - Cleaning up... 03:14:05 INFO - Return code: 0 03:14:05 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:14:05 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')]} 03:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:05 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')]} 03:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:05 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 0x7fe2a04a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4d6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc920>, '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 0x1ddd820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dddcb0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1458986068.545408-207911920', '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 03:14:05 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 03:14:05 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 03:14:05 INFO - Using env: {'DISPLAY': ':0', 03:14:05 INFO - 'HOME': '/home/cltbld', 03:14:05 INFO - 'LANG': 'en_US.UTF-8', 03:14:05 INFO - 'LANGUAGE': 'en_US:en', 03:14:05 INFO - 'LOGNAME': 'cltbld', 03:14:05 INFO - 'MAIL': '/var/mail/cltbld', 03:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:05 INFO - 'MOZ_NO_REMOTE': '1', 03:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:14:05 INFO - 'NO_EM_RESTART': '1', 03:14:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:14:05 INFO - 'PWD': '/builds/slave/test-pgo', 03:14:05 INFO - 'SHELL': '/bin/bash', 03:14:05 INFO - 'SHLVL': '1', 03:14:05 INFO - 'TERM': 'linux', 03:14:05 INFO - 'TMOUT': '86400', 03:14:05 INFO - 'USER': 'cltbld', 03:14:05 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458986068.545408-207911920', 03:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:05 INFO - '_': '/tools/buildbot/bin/python'} 03:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:05 INFO - Downloading/unpacking flake8 03:14: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 03:14: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 03:14: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 03:14: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 03:14: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 03:14: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 03:14:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:14:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:14: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 03:14: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 03:14: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 03:14: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 03:14: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 03:14: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 03:14:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:14:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:14: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 03:14: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 03:14: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 03:14: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 03:14: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 03:14: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 03:14:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:14:08 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 03:14:08 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 03:14:08 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 03:14:08 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 03:14:08 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 03:14:08 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 03:14:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:14:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:14:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:14:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:14:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:14:08 INFO - no previously-included directories found matching 'docs/_build' 03:14:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:14:08 INFO - Running setup.py install for pep8 03:14:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:14:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:14:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:14:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:14:08 INFO - no previously-included directories found matching 'docs/_build' 03:14:08 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:14:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:14:08 INFO - Cleaning up... 03:14:08 INFO - Return code: 0 03:14:08 INFO - Running post-action listener: _resource_record_post_action 03:14:08 INFO - Running post-action listener: _start_resource_monitoring 03:14:08 INFO - Starting resource monitoring. 03:14:08 INFO - ##### 03:14:08 INFO - ##### Running install step. 03:14:08 INFO - ##### 03:14:08 INFO - Running pre-action listener: _resource_record_pre_action 03:14:08 INFO - Running main action method: install 03:14:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:14:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:14:08 INFO - Reading from file tmpfile_stdout 03:14:08 INFO - Detecting whether we're running mozinstall >=1.0... 03:14:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:14:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:14:09 INFO - Reading from file tmpfile_stdout 03:14:09 INFO - Output received: 03:14:09 INFO - Usage: mozinstall [options] installer 03:14:09 INFO - Options: 03:14:09 INFO - -h, --help show this help message and exit 03:14:09 INFO - -d DEST, --destination=DEST 03:14:09 INFO - Directory to install application into. [default: 03:14:09 INFO - "/builds/slave/test-pgo"] 03:14:09 INFO - --app=APP Application being installed. [default: firefox] 03:14:09 INFO - mkdir: /builds/slave/test-pgo/build/application 03:14:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 03:14:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 03:14:24 INFO - Reading from file tmpfile_stdout 03:14:24 INFO - Output received: 03:14:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:14:24 INFO - Running post-action listener: _resource_record_post_action 03:14:24 INFO - ##### 03:14:24 INFO - ##### Running run-tests step. 03:14:24 INFO - ##### 03:14:24 INFO - Running pre-action listener: _resource_record_pre_action 03:14:24 INFO - Running main action method: run_tests 03:14:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:14:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:14:24 INFO - Python 2.7.3 03:14:24 INFO - Return code: 0 03:14:24 INFO - grabbing minidump binary from tooltool 03:14:24 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')]} 03:14:24 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 0x1ddc920>, '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 0x1ddd820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dddcb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:14:24 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 03:14:24 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 03:14:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:14:24 INFO - Return code: 0 03:14:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:14:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:14:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:14:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:14:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:14:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:14:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:14:25 INFO - Return code: 0 03:14:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 03:14:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 03:14:25 INFO - Using env: {'DISPLAY': ':0', 03:14:25 INFO - 'HOME': '/home/cltbld', 03:14:25 INFO - 'LANG': 'en_US.UTF-8', 03:14:25 INFO - 'LANGUAGE': 'en_US:en', 03:14:25 INFO - 'LOGNAME': 'cltbld', 03:14:25 INFO - 'MAIL': '/var/mail/cltbld', 03:14:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:14:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:25 INFO - 'MOZ_NO_REMOTE': '1', 03:14:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:14:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:14:25 INFO - 'NO_EM_RESTART': '1', 03:14:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:14:25 INFO - 'PWD': '/builds/slave/test-pgo', 03:14:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:14:25 INFO - 'SHELL': '/bin/bash', 03:14:25 INFO - 'SHLVL': '1', 03:14:25 INFO - 'TERM': 'linux', 03:14:25 INFO - 'TMOUT': '86400', 03:14:25 INFO - 'USER': 'cltbld', 03:14:25 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458986068.545408-207911920', 03:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:25 INFO - '_': '/tools/buildbot/bin/python'} 03:14:25 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 03:14:25 INFO - mozversion application_buildid: 20160326004034 03:14:25 INFO - mozversion application_changeset: 5629a22932f74f3e2d647c3462c32191a791afed 03:14:25 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:14:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:14:25 INFO - mozversion application_name: Firefox 03:14:25 INFO - mozversion application_remotingname: firefox-dev 03:14:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:14:25 INFO - mozversion application_vendor: Mozilla 03:14:25 INFO - mozversion application_version: 47.0a2 03:14:25 INFO - mozversion platform_buildid: 20160326004034 03:14:25 INFO - mozversion platform_changeset: 5629a22932f74f3e2d647c3462c32191a791afed 03:14:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:14:25 INFO - mozversion platform_version: 47.0a2 03:14:25 INFO - using testdate: 1458987265 03:14:25 INFO - actual date: 1458987265 03:14:25 INFO - starting webserver on 'localhost:46212' 03:14:25 INFO - SUITE-START | Running 2 tests 03:14:25 INFO - TEST-START | dromaeo_css 03:14:25 INFO - operating with platform_type : linux_ 03:14:25 INFO - Initialising browser for dromaeo_css test... 03:14:25 INFO - TEST-INFO | started process 16702 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuM_aUm/profile http://localhost:46212/getInfo.html) 03:14:28 INFO - PROCESS | 16702 | 03:14:28 INFO - PROCESS | 16702 | (process:16778): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:14:29 INFO - PROCESS | 16702 | __metrics Screen width/height:1600/1200 03:14:29 INFO - PROCESS | 16702 | colorDepth:24 03:14:29 INFO - PROCESS | 16702 | Browser inner width/height: 1024/697 03:14:29 INFO - PROCESS | 16702 | __metrics 03:14:30 ERROR - PROCESS | 16702 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:14:31 INFO - TEST-INFO | 16702: exit 0 03:14:31 INFO - Browser initialized. 03:14:31 INFO - Running cycle 1/1 for dromaeo_css test... 03:14:31 INFO - TEST-INFO | started process 16829 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuM_aUm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:14:33 INFO - PROCESS | 16829 | 03:14:33 INFO - PROCESS | 16829 | (process:16897): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:14:43 INFO - PROCESS | 16829 | RSS: Main: 152862720 03:14:43 INFO - PROCESS | 16829 | 03:15:32 INFO - PROCESS | 16829 | 1458987332676 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] 03:17:40 INFO - PROCESS | 16829 | Cycle 1(1): loaded http://localhost:46212/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46212/tests/dromaeo/cssquery-ext.html) 03:17:41 INFO - PROCESS | 16829 | RSS: Main: 158330880 03:17:41 INFO - PROCESS | 16829 | 03:20:43 INFO - PROCESS | 16829 | Cycle 1(1): loaded http://localhost:46212/tests/dromaeo/cssquery-ext.html (next: http://localhost:46212/tests/dromaeo/cssquery-jquery.html) 03:20:43 INFO - PROCESS | 16829 | RSS: Main: 156413952 03:20:43 INFO - PROCESS | 16829 | 03:23:45 INFO - PROCESS | 16829 | Cycle 1(1): loaded http://localhost:46212/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46212/tests/dromaeo/cssquery-mootools.html) 03:23:46 INFO - PROCESS | 16829 | RSS: Main: 155467776 03:23:46 INFO - PROCESS | 16829 | 03:26:47 INFO - PROCESS | 16829 | Cycle 1(1): loaded http://localhost:46212/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46212/tests/dromaeo/cssquery-prototype.html) 03:26:48 INFO - PROCESS | 16829 | RSS: Main: 155582464 03:26:48 INFO - PROCESS | 16829 | 03:29:50 INFO - PROCESS | 16829 | Cycle 1(1): loaded http://localhost:46212/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46212/tests/dromaeo/cssquery-yui.html) 03:29:51 INFO - PROCESS | 16829 | RSS: Main: 157151232 03:29:51 INFO - PROCESS | 16829 | 03:32:53 INFO - PROCESS | 16829 | Cycle 1(1): loaded http://localhost:46212/tests/dromaeo/cssquery-yui.html (next: http://localhost:46212/tests/dromaeo/cssquery-dojo.html) 03:32:53 INFO - PROCESS | 16829 | RSS: Main: 157904896 03:32:53 INFO - PROCESS | 16829 | 03:32:53 INFO - PROCESS | 16829 | __start_tp_report 03:32:53 INFO - PROCESS | 16829 | _x_x_mozilla_page_load 03:32:53 INFO - PROCESS | 16829 | _x_x_mozilla_page_load_details 03:32:53 INFO - PROCESS | 16829 | |i|pagename|runs| 03:32:53 INFO - PROCESS | 16829 | |0;dojo.html;3291.489819078043;3302.504624306353;3323.916902077446;3352.497125431185;3356.765026448148;5404.648697834638;5467.425920278368;5472.972635136829;5478.369987451444;5488.313960754911;5441.673499590027;5471.151971444432;5480.534154596854;5480.890382192364;5490.80782172623;4951.82668606598;4992.750362481879;5073.188289873621;5079.746012699368;5083.618728595352;4960.479149689285;5066.544011039005;5096.388433387999;5100.923486147711;5105.2086926526445;5050.318207042039;5060.4686507916695;5164.561012313939;5172.069027575035;5178.48215178481;5106.055379754739;5131.409887862887;5138.254953031789;5141.948580514184;5143.8456846294675;4871.951280487186;4897.804087836482;5090.77091530882;5123.257127716461;5129.974350128263;5295.099833028395;5332.466753324637;5353.919691204596;5361.705106219196;5383.892322153535;5915.881682366372;5950.821475355746;5956.493698035672;5957.255343082114;5962.1951036609935;5981.641101533878;6003;6041.516678665696;6083;6118.296395914483;5557.888842223173;5594.832155035356;5601.60788744788;5602.747876345534;5609.747561359749;5988.880222395528;6117.143599896018;6136.539759517965;6151.169592105009;6152.323244443108;5839.474447299764;5859.472647461664;5889.440503152194;5892.793752218652;5905.320888097924;5960.5827592068135;5964.045752679551;5980.312264089685;5993.280806303272;5995.52035837132;5723.227364305849;5909.527237820964;5932.555058370639;5937.050071988548;5939.346671866091;5900.291964964232;5940.70296485174;5943.613665111754;5957.195778569924;5970.253718285215;4529.365888775574;4530.456345238593;4533.070720502289;4534.183846907588;4574.6340292776495;3997.1805779815068;4042.717009809285;4067.3898915162963;4084.1219137885496;4109.157622687342;5565.359983601857;5677.318721753333;5693.943060569424;5721.39925307845;5747.1379293106365;5931.08068249422;5973.701314934236;5981.970090149608;5988.101784732325;6018.729157187937;5564.805231816867;5675.914861277084;5718.857028574319;5721.056025755787;5729.742161602738;5021.59827213822;5027.044861476308;5043.646944713835;5061.670991385548;5073.492650734897;6168.074788781629;6203.441690247809;6204;6217.6891155442045;6217.844553886189;5791.131330300489;5872.882542349043;5919.171316015675;5982.641041537521;6025.035994240988;6142.416470435302;6187.319394866471;6215.160953271251;6229.719662615103;6250.718717657807;5864.120381942743;5917.526597872246;5918.881622367615;5954.523638108854;5990.400959903975;5830.912536312044;5974.074018527135;5994.550408719277;6018.428249316308;6075.726592303268;5804.158397032491;5850.23946886902;5866.941330586639;5889.970550147222;5905.084711869667;5819.15622234782;5848.561357898089;5873.03094989322;5885.529157667462;5902.970485147547;5568.081266590967;5772.595918285848;5842.152887831326;5849.415058494286;5863.91517569251;5802.1586869902785;5908.3796201399955;5920.911186332122;5929;5946.524278057658;5640.435956404327;5807.186993820784;5808.157817116579;5819.127130930395;5820.534357251325 03:32:53 INFO - PROCESS | 16829 | |1;ext.html;550.0982318271119;561.9915701264479;570.2785975740688;585.6954383720464;592.5289394931029;39916.80041599792;40863;40931.18137637249;41011.79494102533;41087.178256434854;41364.79317603408;42085.78957105218;42185;42225;42441.15117697644;8712.520811355389;8935.910640893606;8975.102489751005;8986.415882967585;9007.594658240396;8722.21500064994;9032.141946515103;9091;9115.589798459085;9145.268378529701;9078.228350590207;9102.408343457688;9170.358074934757;9175.128362805555;9208.631654733803;9005.639774409015;9017.504037277948;9070.138336857988;9101.226395756368;9133.086691330815;9096.545172741402;9155.13026262504;9176.770580735469;9231.307651926132;9249.167574918223;34961.82519087388;41382.79308603438;41438.37842432366;41914.58085419137;42031.579684203076;3535.9646403535894;3590.6947909427467;3703.5370578677666;3789.753666011728;3839.3281175794123;29608.40783184346;29751.25621859449;29869.850650746608;30668.693313066808;30719.692803071906;4094.754314741125;4159.8960025999595;4169.187008533338;4215.936760948588;4216.662666986665;195271;195843;196484;197122;197222;47111.29333060007;47373;47451.5254847454;47759.283610745864;60753.69623151856;44555.55444445579;44854.77572612116;45006.54993450024;45112.3233151503;45330.32004519935;15767.369305227892;15836.049837009816;15861.286242119133;15968.520944371687;15980.680386392207;13304.667383315495;13442.059055865995;13448.798268025987;13485.595432137052;13502;16033.839661603235;16181.11003894797;16186.19069046543;16223.594410139842;16254.837451625332;6325.082862984841;6326.588771729823;6473.676316184172;6510.316416776265;6524.478041756743;1040.5005597313182;1094.529352378469;1131.9943400282946;1138.584416687903;1220.6277085489012;27354.042608508607;28575.14274571766;28596.857015714788;28754.856225718737;29101.7089829099;1121.8092924202906;1171.554809172509;1207.1067410116625;1224.7795396828656;1248.843894513186;14793.186374749277;14972.700545989019;15220;15616.063036217636;15695.822813289049;342396;529294;531232;536328;567281;56035;56726.7163664179;56823.71588142033;56956.715216423654;57364.42635573591;1485.9777103343458;1491.0904348347499;1492.5895378770708;1510.3807438949977;1520.9619759506102;27488.312792180357;28227.294317642223;28325.71674283231;28768;28909.56635650509;52228.73885630548;52535.73732131315;52708.73645631747;53107.468925310255;53337.19994200012;299345;304077;304668;305826;306952;36398.27203455969;36425.817870910476;36677.26645467129;36770;37119.257614848095;48826.75586622044;51780;52107;53064.73467632637;53999;38561.614383855805;39968;40959;41293.793531032155;42380.57619423766;39620.603793961694;40152.39771403373;40433.39349909813;40684.38973415342;41194.38208426816;40450.59549404586;40554.594454055084;41094.38358424566;41385.79307103445;41455.7927210362;34366.65633343734;35272.11819704528;35355.46966795551;35413.46879796754;35640.465393019644;25058.37354066163;25543.87228063848;25575.360615984748;25754.87122564375;26012 03:32:53 INFO - PROCESS | 16829 | |2;jquery.html;386.98452061917544;389.6250104014215;390.5528170245069;391.26637554585153;400.9198160367927;18723.157457914393;19051.90474047631;19204.23183072677;19303.131359088857;19886.40340789775;11402.885971140286;11743.882561174385;11748.295102293869;11748.353840538766;11801.763964720722;5152.716600586966;5249;5311.336082989626;5708.857278568027;5743.5118014968775;5633.042382794934;5661.2923384576925;5680.687562184078;5682.914756278659;5689.886202275952;5341;5506.5870059745475;5607.299087614048;5616.073347897592;5636.859078523029;5529.751161197756;5558.110702287615;5563.721813909288;5597.496225339698;5613.129964855454;5410.215518749798;5685.54515638752;5689.231953686241;5689.943100568983;5697.116946873241;13041.08712390133;13462.124961877447;13526.797098043537;13734.862651373558;13802.723945521033;2345.870977096259;2380.857148571074;2508.7742103210617;2889.537673972154;2963.851807409621;9997.900020999843;10174.389536627827;10222.591096356211;10330.741731456774;10474.109700675452;1951.278027129971;1955.4817973236961;1980.564275859323;1999.8300144487737;2018.596280743857;62577.68711156415;63476;64236.67881660609;65294.67352663206;70592.2940770596;10849.349039057683;11160.107191424666;11254.887451125547;11303.886961130447;11467.885321146849;14974.251287435585;14979;15094.24528773557;15133.394664213309;15141.697166056838;7558.735444259424;7864.842703145905;8325.625346859406;8415.11641277657;8636.827263454696;7482.401407887356;7614.466987310946;7682.231776822273;7725.768226953201;7729.768106956688;4637.582617564368;4650.116477869194;4650.325702773079;4650.767461626905;4671.252599584051;1930.6621341265222;1947.575268790365;1965.5184479802253;1983.9801601984084;2024.4432780985053;926.1710768861966;976.5459061536278;991.7371896447447;994;1044.7440377107657;15188.620284492976;16737.07946062954;16771.580710482336;17087.963609520717;17257.223424945907;1002.2683441088046;1019.9337043092175;1032.256775121911;1061.6072053340313;1096.6764804382726;9913.142560145621;10070.446125463024;10137.493125343703;10162.339447935861;10255.58977640901;446433;448593;457873;460400;463511;75334;75949.62025189839;77915;78490.6075469619;79706.60146699345;1096.9012788849043;1137.2153214282118;1142.440204299887;1146.8279758036194;1147.5065721739566;15567.143807090719;15731.606709832346;15748.133852638215;15832.208389580705;15906.9204653976;35228.295434090665;35621.57513699423;35785;36022.81988590145;36837;47942;48252.51747482621;50093.74953125357;52078.47921520888;55036.174457383975;7814.53112813233;8106.878396823934;8356;8585.184407481529;8677.739667809976;12332.075094368138;12337.629871103882;12484.438200280827;12499.875001250235;12714.982801376053;5287.339082614673;5442.836714898559;10043.096121349114;10186.796264074528;10677.825439201837;10429.53067111997;10434.217433692655;10566.8414973777;10655.20085993569;10661.626843060456;10194.541245643815;10587.364758114538;10902.672919812418;10913.78172436531;11452.427378631202;7788.104367997753;8000.159983201913;8080.63637136342;8333.499990000619;8455.830883382176;7864.252895974873;9504.572294246636;9815;10139.391636501834;10253.538590763583 03:32:53 INFO - PROCESS | 16829 | |3;mootools.html;1569.419314853504;1575.9763603545946;1855.1095474172396;1937.6512227799008;1993.1927569334425;7203.06360173178;7902.170272121431;8033.87949180762;8256.215659512343;8260.339172866172;7929.207079292068;7968.442209045369;8052.476589021724;8054.637541310641;8088.029436467632;2412.9396765080883;2430.4652976345174;2442.05980697431;2443.5479436304254;2457.8279520433575;2267.444476103357;2299.298713892262;2299.9655005174936;2309.93070207894;2372.833901626887;2418.1657328221736;2441.951160976779;2451.117597664839;2456.4718585504115;2466.149178533412;2428.76926691964;2432.8905199266073;2433.987830060856;2444.144549407702;2474.505098980193;2410.180538616861;2423.4062654649724;2426.2721183644835;2432.4405386761146;2436.3300092474533;8227.71203007892;8294.668213271521;8316.708915187939;8325.417220794547;8352.290055345304;4919.508049195088;5039.370078740158;5040.974795126001;5051.797928082872;5063.088644044071;3177.952330715041;3179.332340208559;3268.150280926976;3287.671232876717;3365.057783820534;1036.424784244744;2038.7349644546262;2052.435580215453;2081.261152290945;2084.458040909359;10896.073833724144;10985.835212471819;11003.449827508593;11026.724331891606;11031;4076.5108187017154;4227.365895115696;4242.618164365222;4302.870913872589;4334.371516130143;8842.292616590657;8905.332100092519;8911.331650126267;8948.328875334377;8973.102689730975;4879.39007624047;4910.042541704404;4922.1140194765285;4925.679830810986;4927.187014142698;4099.323611604112;4500.077484115748;4525.502194758574;4526.864194074183;4531.546845315508;3602.369585322558;3635.600083990759;3639.636036396339;3669.504616876741;3710.239400922804;1037.2946396450486;1090.1170052257696;1099.3074363151163;1116.3580940958982;1118.7762447510531;1108.5067145120506;1124.1849658997162;1127.22784892349;1299.5191779041816;1372.8078069070339;7746.883796743054;7889.368850491946;7909.05091389037;7909.09045459768;7952.681892724227;1187.649643355195;1202.939853007346;1219.3171823778534;1220.2068655374078;1236.9072319576069;6019.277686677539;6136.110264011693;6150.138980542728;6192;6222.253329600387;9614.567344469515;9885.555150018123;9942.552585133686;9942.801143977225;10053.447060411747;9798.902010979798;9922.206223502102;9931.354461959949;9946.850797238047;9977.501124943868;7718.652660630173;7740.225977402328;7791.4935529190425;7798.220177982156;7845.921540784633;7477.476576639583;7538;7647.349975251944;7659.234076592296;7684.961575192088;8685.174908383693;8840.557972101498;8876.600552975002;8974.237189838937;9116.179543841086;8927.062658420773;9065.592048357708;9197.54012299369;9202.309826762885;9245.676401325922;6121.234845644294;6436.388543088399;6561.475081993524;6627.701753421204;6748.223954245324;7791.104023037423;7806.4925779824125;7811.453198276066;7835.177306382748;7854.1753115922;7071.964640176766;7130.750423735144;7145.356917877416;7169.4622903281415;7177.784666460015;6737.562058466184;6824.522283440111;6827.453803695593;6928.549644273106;6929.792106236821;7120.1099862517185;7189.964050179925;7249.093863267091;7396.149442814145;7471;6609.4712423007;6639;6640.83397915056;6677.065210870579;6693.397594216543;6608.504362172953;6609.900851487328;6639.136912201576;6706.530542862148;6723.596584204964 03:32:53 INFO - PROCESS | 16829 | |4;prototype.html;353.0978350314945;360.35316606691;361.7142457458608;365.97438179327423;370.3999520776343;6352.269489008765;6389.488840892729;6422.261439934409;6441.581297215689;6446.742130314788;6284.5600807943465;6296.6536840473755;6308.243010838694;6317.589356691812;6342.460890824285;4644.674872758908;4734.266188740734;4875.756212189394;4877.073356062355;4894.97552512237;4807.038592281558;4864.562189402953;4865.48912364202;4890.657653964224;4908.9263661045115;4824.059308434857;4850.126977144113;4852.757362131897;4853.587445067174;4860.368152140234;4834.516548345155;4850.102730994778;4859.295402166701;4866.245731911559;4873.463918968911;4285.271503844323;4293.699441039129;4296.57034296571;4296.6777491687935;4300.118475712503;5813;6031.517478601701;6051.213342265477;6061.242344706911;6062.363451837582;5602.691851948182;5605.1872478490795;5625.268715067056;5638.830835074954;5687.914681279784;6752.155980502437;6769.153855768029;6788.59268443895;6791.524593278473;6815.863682726367;4640.814367425299;4642.558956899089;4643.628509719214;4649;4653.511381304948;7012.614306213156;7034.120734908137;7072.186698529632;7079.079719636415;7102.218755936791;4599.149157405891;4756.025014872012;4777.187878060738;4779.880502987453;4793.089313030513;4808.711477311373;4827.058723548875;4836.927446088312;4840.540148685869;4845.152098382769;5597.244372009808;5608.747606357723;5612.849365879984;5621.634593751393;5625.296837895263;6809.319068093151;6819.113515242987;6822.692978815965;6824.18109826814;6833.863322733518;1667.4497415852738;1708.3081352052438;1709.529879283207;1714.9571260718333;1720.6558688262398;1098.417838545572;1118.4463690473267;1134.3137401871913;1144.9942750286195;1158.449736375215;6499.122618446544;6499.38255865692;6525.804225873137;6528.738850446024;6546.476281897437;6924.61914594692;6969.2682268362105;6973.12835895513;6981.5461994970165;6988.755393561201;6586.604803711793;6588.044733513614;6604.834879127964;6628.105205797252;6632.701528431232;3745.6254374562327;3806.352920003606;3809.9238015240094;3816.6183381661613;3818.7517811342173;7375.520591161665;7384.556926584422;7385.335319821242;7412.740554080581;7436.070491188601;7038.155421349471;7206.495545311778;7250.3112204340505;7273.89089163663;7293.963530182421;7422.962885185648;7423.406127509894;7452;7466.2160473150625;7466.36535894455;7032.789016329519;7061.6822243000215;7069.469789765685;7080;7114.039604653305;6945.062416573698;6950.16598008222;6959.8956015660815;6983;6987.965060174666;7264.782056538101;7390.260973902567;7415.8146046349275;7450.143233528213;7453.366463850417;4653.046125544323;4661.184292748823;4683.718976861399;4691.390119284608;4696.788644510937;7080.539764915264;7091.539049961736;7110.6089165094345;7113.181984071898;7116.573005619679;6837.829054273683;6875.862482750417;6882.552634078769;6886.311368863074;6899.862002760017;6818.93181068183;6841.828954275984;6897.793066208022;6903.551269167488;6942.791716248521;6735.191776986793;6756.391924726799;6756.527043106936;6765.932340676531;6774.254831968381;6856.691448884712;6867.759628412981;6868.828279292858;6869.210040845367;6872.278410766998;6690.531662783753;6693.431058359899;6710.060591517289;6728.461723062242;6729.024291477611 03:32:53 INFO - PROCESS | 16829 | |5;yui.html;758.9924100758992;779.6257796257793;865.1175800683303;873.4235404632941;876.9912300876989;13534.458621655134;13540.526081587146;13616;13627.182369057851;13646.181229126247;13199.142055766368;13874.861251387483;13897.722045559083;13903.93048034761;13937.651558711037;760.1220590218306;922.114769820971;923.8983711791698;944.5702205496517;944.914957653811;916.5234078279291;916.715818096389;921.7280902133887;921.8156368726249;924.1728652855691;985.6205360936056;987.1609132237612;995.4276291132592;996.267743208741;997.0677416615451;976.4092723902008;977.7360112769547;981.102291403365;983.8081574092984;985.2955137077024;731.1591669579973;731.7987553422798;731.8499707559937;733.787201711503;734.2877408913346;14462.92768536161;14571.052881562664;14576.344064517121;14603.269836508132;14613.342399592044;13679.589612311647;13803.2408217548;13815;13846.376913038937;13915.095518791246;11213;11230;11255.324680519196;11452.656420307405;11457.942710286396;3525.2596954639557;3714.052916506301;3728.7017038637114;3757.5490941086973;3786.413105968552;50826;51104;52688.209676854494;52704.47295527072;53026.46973530254;10951.945240273748;11154.609588664358;11318.547258109747;11319;11403.771924561463;19236.134373953206;19269.4219173425;19290.71063934042;19302.745321554055;19517.902410487855;8035.718749843727;8165.877511837327;8290.544020078833;8359.164083591591;8362.45644033136;4546.863594092182;4570.291604801261;4625;4688.085823264499;4769.57073863354;3184.5064015077237;3192.5849639547173;3195.3769015041844;3225.3549290142064;3225.741940644743;544.1973089692672;550.3285991090863;552.6214543037952;561.5283162143819;564.3087218157806;656.5961933410917;659.9076129341896;684.4934748286232;704.992950070503;707.518887156728;7665.348445382094;7762.7671169865;7937.603119843985;7942.364610831235;8246.299064579458;507.421539445033;555.038867641131;701.6596950479013;710.5665544018145;712.6757325417027;3966.6231707987695;4050.7569545827346;4064.1058967027207;4228.5982831630945;4317.978410107929;56719;56932.715336423884;57050;57962.420375796544;58522.7073864628;49532.75233623809;50721;50833.71248293762;51246;55084.72457637767;46784.2982355265;47404.25276669796;47422;47950.28074578954;48123.5187648119;8418.242358187792;8462.703805366782;8665.956670216608;8823;8957.59690813928;34813.303733925684;35420.82289588536;35711;36532.452013220354;36595.45106823453;41407.792961035004;43988.34017489676;45146.097078057595;45817.77091114523;46014.769926150155;11455.770884582094;11762.470688818852;11877.168598198043;11994.820077698667;12037.578684745991;13273.39429555942;13376.464941402624;13489;13557.525486607921;13708.314584270547;11761.294322340687;11853.229540080212;11862.940685296518;12026.939865300617;12063.517459301529;11815.881841181477;11907.82138267944;11918.225315354473;12036.398180091135;12094.213876098025;11755;11792.941035294769;11852.525898963944;11944.522219111139;12070.396480176132;10107.595696172071;10455.11131553796;10615.097716694167;10646.148308135485;10683.198760093179;9548.618055277711;10021.749456263651;10064.345817521838;10075.848862266925;10119.59521619127 03:32:53 INFO - PROCESS | 16829 | __end_tp_report 03:32:53 INFO - PROCESS | 16829 | __start_cc_report 03:32:53 INFO - PROCESS | 16829 | _x_x_mozilla_cycle_collect,336 03:32:53 INFO - PROCESS | 16829 | __end_cc_report 03:32:53 INFO - PROCESS | 16829 | __startTimestamp1458988373668__endTimestamp 03:32:53 INFO - PROCESS | 16829 | 03:32:53 INFO - PROCESS | 16829 | ------- Summary: start ------- 03:32:53 INFO - PROCESS | 16829 | Number of tests: 6 03:32:53 INFO - PROCESS | 16829 | 03:32:53 INFO - PROCESS | 16829 | [#0] dojo.html Cycles:165 Average:5538.84 Median:5807.19 stddev:628.47 (10.8%) stddev-sans-first:605.16 03:32:53 INFO - PROCESS | 16829 | Values: 3291.5 3302.5 3323.9 3352.5 3356.8 5404.6 5467.4 5473.0 5478.4 5488.3 5441.7 5471.2 5480.5 5480.9 5490.8 4951.8 4992.8 5073.2 5079.7 5083.6 4960.5 5066.5 5096.4 5100.9 5105.2 5050.3 5060.5 5164.6 5172.1 5178.5 5106.1 5131.4 5138.3 5141.9 5143.8 4872.0 4897.8 5090.8 5123.3 5130.0 5295.1 5332.5 5353.9 5361.7 5383.9 5915.9 5950.8 5956.5 5957.3 5962.2 5981.6 6003.0 6041.5 6083.0 6118.3 5557.9 5594.8 5601.6 5602.7 5609.7 5988.9 6117.1 6136.5 6151.2 6152.3 5839.5 5859.5 5889.4 5892.8 5905.3 5960.6 5964.0 5980.3 5993.3 5995.5 5723.2 5909.5 5932.6 5937.1 5939.3 5900.3 5940.7 5943.6 5957.2 5970.3 4529.4 4530.5 4533.1 4534.2 4574.6 3997.2 4042.7 4067.4 4084.1 4109.2 5565.4 5677.3 5693.9 5721.4 5747.1 5931.1 5973.7 5982.0 5988.1 6018.7 5564.8 5675.9 5718.9 5721.1 5729.7 5021.6 5027.0 5043.6 5061.7 5073.5 6168.1 6203.4 6204.0 6217.7 6217.8 5791.1 5872.9 5919.2 5982.6 6025.0 6142.4 6187.3 6215.2 6229.7 6250.7 5864.1 5917.5 5918.9 5954.5 5990.4 5830.9 5974.1 5994.6 6018.4 6075.7 5804.2 5850.2 5866.9 5890.0 5905.1 5819.2 5848.6 5873.0 5885.5 5903.0 5568.1 5772.6 5842.2 5849.4 5863.9 5802.2 5908.4 5920.9 5929.0 5946.5 5640.4 5807.2 5808.2 5819.1 5820.5 03:32:53 INFO - PROCESS | 16829 | 03:32:53 INFO - PROCESS | 16829 | [#1] ext.html Cycles:180 Average:50357.17 Median:40773.69 stddev:95733.23 (234.8%) stddev-sans-first:95928.75 03:32:53 INFO - PROCESS | 16829 | Values: 550.1 562.0 570.3 585.7 592.5 39916.8 40863.0 40931.2 41011.8 41087.2 41364.8 42085.8 42185.0 42225.0 42441.2 8712.5 8935.9 8975.1 8986.4 9007.6 8722.2 9032.1 9091.0 9115.6 9145.3 9078.2 9102.4 9170.4 9175.1 9208.6 9005.6 9017.5 9070.1 9101.2 9133.1 9096.5 9155.1 9176.8 9231.3 9249.2 34961.8 41382.8 41438.4 41914.6 42031.6 3536.0 3590.7 3703.5 3789.8 3839.3 29608.4 29751.3 29869.9 30668.7 30719.7 4094.8 4159.9 4169.2 4215.9 4216.7 195271.0 195843.0 196484.0 197122.0 197222.0 47111.3 47373.0 47451.5 47759.3 60753.7 44555.6 44854.8 45006.5 45112.3 45330.3 15767.4 15836.0 15861.3 15968.5 15980.7 13304.7 13442.1 13448.8 13485.6 13502.0 16033.8 16181.1 16186.2 16223.6 16254.8 6325.1 6326.6 6473.7 6510.3 6524.5 1040.5 1094.5 1132.0 1138.6 1220.6 27354.0 28575.1 28596.9 28754.9 29101.7 1121.8 1171.6 1207.1 1224.8 1248.8 14793.2 14972.7 15220.0 15616.1 15695.8 342396.0 529294.0 531232.0 536328.0 567281.0 56035.0 56726.7 56823.7 56956.7 57364.4 1486.0 1491.1 1492.6 1510.4 1521.0 27488.3 28227.3 28325.7 28768.0 28909.6 52228.7 52535.7 52708.7 53107.5 53337.2 299345.0 304077.0 304668.0 305826.0 306952.0 36398.3 36425.8 36677.3 36770.0 37119.3 48826.8 51780.0 52107.0 53064.7 53999.0 38561.6 39968.0 40959.0 41293.8 42380.6 39620.6 40152.4 40433.4 40684.4 41194.4 40450.6 40554.6 41094.4 41385.8 41455.8 34366.7 35272.1 35355.5 35413.5 35640.5 25058.4 25543.9 25575.4 25754.9 26012.0 03:32:53 INFO - PROCESS | 16829 | 03:32:53 INFO - PROCESS | 16829 | [#2] jquery.html Cycles:180 Average:25961.90 Median:35703.29 stddev:74752.52 (209.4%) stddev-sans-first:74937.55 03:32:53 INFO - PROCESS | 16829 | Values: 387.0 389.6 390.6 391.3 400.9 18723.2 19051.9 19204.2 19303.1 19886.4 11402.9 11743.9 11748.3 11748.4 11801.8 5152.7 5249.0 5311.3 5708.9 5743.5 5633.0 5661.3 5680.7 5682.9 5689.9 5341.0 5506.6 5607.3 5616.1 5636.9 5529.8 5558.1 5563.7 5597.5 5613.1 5410.2 5685.5 5689.2 5689.9 5697.1 13041.1 13462.1 13526.8 13734.9 13802.7 2345.9 2380.9 2508.8 2889.5 2963.9 9997.9 10174.4 10222.6 10330.7 10474.1 1951.3 1955.5 1980.6 1999.8 2018.6 62577.7 63476.0 64236.7 65294.7 70592.3 10849.3 11160.1 11254.9 11303.9 11467.9 14974.3 14979.0 15094.2 15133.4 15141.7 7558.7 7864.8 8325.6 8415.1 8636.8 7482.4 7614.5 7682.2 7725.8 7729.8 4637.6 4650.1 4650.3 4650.8 4671.3 1930.7 1947.6 1965.5 1984.0 2024.4 926.2 976.5 991.7 994.0 1044.7 15188.6 16737.1 16771.6 17088.0 17257.2 1002.3 1019.9 1032.3 1061.6 1096.7 9913.1 10070.4 10137.5 10162.3 10255.6 446433.0 448593.0 457873.0 460400.0 463511.0 75334.0 75949.6 77915.0 78490.6 79706.6 1096.9 1137.2 1142.4 1146.8 1147.5 15567.1 15731.6 15748.1 15832.2 15906.9 35228.3 35621.6 35785.0 36022.8 36837.0 47942.0 48252.5 50093.7 52078.5 55036.2 7814.5 8106.9 8356.0 8585.2 8677.7 12332.1 12337.6 12484.4 12499.9 12715.0 5287.3 5442.8 10043.1 10186.8 10677.8 10429.5 10434.2 10566.8 10655.2 10661.6 10194.5 10587.4 10902.7 10913.8 11452.4 7788.1 8000.2 8080.6 8333.5 8455.8 7864.3 9504.6 9815.0 10139.4 10253.5 03:32:53 INFO - PROCESS | 16829 | 03:32:53 INFO - PROCESS | 16829 | [#3] mootools.html Cycles:180 Average:5695.30 Median:6207.13 stddev:2893.45 (46.6%) stddev-sans-first:2884.94 03:32:53 INFO - PROCESS | 16829 | Values: 1569.4 1576.0 1855.1 1937.7 1993.2 7203.1 7902.2 8033.9 8256.2 8260.3 7929.2 7968.4 8052.5 8054.6 8088.0 2412.9 2430.5 2442.1 2443.5 2457.8 2267.4 2299.3 2300.0 2309.9 2372.8 2418.2 2442.0 2451.1 2456.5 2466.1 2428.8 2432.9 2434.0 2444.1 2474.5 2410.2 2423.4 2426.3 2432.4 2436.3 8227.7 8294.7 8316.7 8325.4 8352.3 4919.5 5039.4 5041.0 5051.8 5063.1 3178.0 3179.3 3268.2 3287.7 3365.1 1036.4 2038.7 2052.4 2081.3 2084.5 10896.1 10985.8 11003.4 11026.7 11031.0 4076.5 4227.4 4242.6 4302.9 4334.4 8842.3 8905.3 8911.3 8948.3 8973.1 4879.4 4910.0 4922.1 4925.7 4927.2 4099.3 4500.1 4525.5 4526.9 4531.5 3602.4 3635.6 3639.6 3669.5 3710.2 1037.3 1090.1 1099.3 1116.4 1118.8 1108.5 1124.2 1127.2 1299.5 1372.8 7746.9 7889.4 7909.1 7909.1 7952.7 1187.6 1202.9 1219.3 1220.2 1236.9 6019.3 6136.1 6150.1 6192.0 6222.3 9614.6 9885.6 9942.6 9942.8 10053.4 9798.9 9922.2 9931.4 9946.9 9977.5 7718.7 7740.2 7791.5 7798.2 7845.9 7477.5 7538.0 7647.3 7659.2 7685.0 8685.2 8840.6 8876.6 8974.2 9116.2 8927.1 9065.6 9197.5 9202.3 9245.7 6121.2 6436.4 6561.5 6627.7 6748.2 7791.1 7806.5 7811.5 7835.2 7854.2 7072.0 7130.8 7145.4 7169.5 7177.8 6737.6 6824.5 6827.5 6928.5 6929.8 7120.1 7190.0 7249.1 7396.1 7471.0 6609.5 6639.0 6640.8 6677.1 6693.4 6608.5 6609.9 6639.1 6706.5 6723.6 03:32:53 INFO - PROCESS | 16829 | 03:32:53 INFO - PROCESS | 16829 | [#4] prototype.html Cycles:180 Average:5693.86 Median:6499.25 stddev:1744.30 (26.8%) stddev-sans-first:1702.51 03:32:53 INFO - PROCESS | 16829 | Values: 353.1 360.4 361.7 366.0 370.4 6352.3 6389.5 6422.3 6441.6 6446.7 6284.6 6296.7 6308.2 6317.6 6342.5 4644.7 4734.3 4875.8 4877.1 4895.0 4807.0 4864.6 4865.5 4890.7 4908.9 4824.1 4850.1 4852.8 4853.6 4860.4 4834.5 4850.1 4859.3 4866.2 4873.5 4285.3 4293.7 4296.6 4296.7 4300.1 5813.0 6031.5 6051.2 6061.2 6062.4 5602.7 5605.2 5625.3 5638.8 5687.9 6752.2 6769.2 6788.6 6791.5 6815.9 4640.8 4642.6 4643.6 4649.0 4653.5 7012.6 7034.1 7072.2 7079.1 7102.2 4599.1 4756.0 4777.2 4779.9 4793.1 4808.7 4827.1 4836.9 4840.5 4845.2 5597.2 5608.7 5612.8 5621.6 5625.3 6809.3 6819.1 6822.7 6824.2 6833.9 1667.4 1708.3 1709.5 1715.0 1720.7 1098.4 1118.4 1134.3 1145.0 1158.4 6499.1 6499.4 6525.8 6528.7 6546.5 6924.6 6969.3 6973.1 6981.5 6988.8 6586.6 6588.0 6604.8 6628.1 6632.7 3745.6 3806.4 3809.9 3816.6 3818.8 7375.5 7384.6 7385.3 7412.7 7436.1 7038.2 7206.5 7250.3 7273.9 7294.0 7423.0 7423.4 7452.0 7466.2 7466.4 7032.8 7061.7 7069.5 7080.0 7114.0 6945.1 6950.2 6959.9 6983.0 6988.0 7264.8 7390.3 7415.8 7450.1 7453.4 4653.0 4661.2 4683.7 4691.4 4696.8 7080.5 7091.5 7110.6 7113.2 7116.6 6837.8 6875.9 6882.6 6886.3 6899.9 6818.9 6841.8 6897.8 6903.6 6942.8 6735.2 6756.4 6756.5 6765.9 6774.3 6856.7 6867.8 6868.8 6869.2 6872.3 6690.5 6693.4 6710.1 6728.5 6729.0 03:32:53 INFO - PROCESS | 16829 | 03:32:53 INFO - PROCESS | 16829 | [#5] yui.html Cycles:180 Average:14324.23 Median:44567.22 stddev:16238.26 (36.4%) stddev-sans-first:16251.85 03:32:53 INFO - PROCESS | 16829 | Values: 759.0 779.6 865.1 873.4 877.0 13534.5 13540.5 13616.0 13627.2 13646.2 13199.1 13874.9 13897.7 13903.9 13937.7 760.1 922.1 923.9 944.6 944.9 916.5 916.7 921.7 921.8 924.2 985.6 987.2 995.4 996.3 997.1 976.4 977.7 981.1 983.8 985.3 731.2 731.8 731.8 733.8 734.3 14462.9 14571.1 14576.3 14603.3 14613.3 13679.6 13803.2 13815.0 13846.4 13915.1 11213.0 11230.0 11255.3 11452.7 11457.9 3525.3 3714.1 3728.7 3757.5 3786.4 50826.0 51104.0 52688.2 52704.5 53026.5 10951.9 11154.6 11318.5 11319.0 11403.8 19236.1 19269.4 19290.7 19302.7 19517.9 8035.7 8165.9 8290.5 8359.2 8362.5 4546.9 4570.3 4625.0 4688.1 4769.6 3184.5 3192.6 3195.4 3225.4 3225.7 544.2 550.3 552.6 561.5 564.3 656.6 659.9 684.5 705.0 707.5 7665.3 7762.8 7937.6 7942.4 8246.3 507.4 555.0 701.7 710.6 712.7 3966.6 4050.8 4064.1 4228.6 4318.0 56719.0 56932.7 57050.0 57962.4 58522.7 49532.8 50721.0 50833.7 51246.0 55084.7 46784.3 47404.3 47422.0 47950.3 48123.5 8418.2 8462.7 8666.0 8823.0 8957.6 34813.3 35420.8 35711.0 36532.5 36595.5 41407.8 43988.3 45146.1 45817.8 46014.8 11455.8 11762.5 11877.2 11994.8 12037.6 13273.4 13376.5 13489.0 13557.5 13708.3 11761.3 11853.2 11862.9 12026.9 12063.5 11815.9 11907.8 11918.2 12036.4 12094.2 11755.0 11792.9 11852.5 11944.5 12070.4 10107.6 10455.1 10615.1 10646.1 10683.2 9548.6 10021.7 10064.3 10075.8 10119.6 03:32:53 INFO - PROCESS | 16829 | -------- Summary: end -------- 03:32:53 INFO - PROCESS | 16829 | 03:32:54 INFO - TEST-INFO | 16829: exit 0 03:32:54 INFO - TEST-OK | dromaeo_css | took 1108854ms 03:32:54 INFO - TEST-START | kraken 03:32:54 INFO - operating with platform_type : linux_ 03:32:54 INFO - Initialising browser for kraken test... 03:32:54 INFO - TEST-INFO | started process 17073 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkkR8_d/profile http://localhost:46212/getInfo.html) 03:32:57 INFO - PROCESS | 17073 | 03:32:57 INFO - PROCESS | 17073 | (process:17145): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:32:58 INFO - PROCESS | 17073 | __metrics Screen width/height:1600/1200 03:32:58 INFO - PROCESS | 17073 | colorDepth:24 03:32:58 INFO - PROCESS | 17073 | Browser inner width/height: 1024/697 03:32:58 INFO - PROCESS | 17073 | __metrics 03:32:59 ERROR - PROCESS | 17073 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:33:00 INFO - TEST-INFO | 17073: exit 0 03:33:00 INFO - Browser initialized. 03:33:00 INFO - Running cycle 1/1 for kraken test... 03:33:00 INFO - TEST-INFO | started process 17196 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkkR8_d/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:33:01 INFO - PROCESS | 17196 | 03:33:01 INFO - PROCESS | 17196 | (process:17264): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:33:11 INFO - PROCESS | 17196 | RSS: Main: 154574848 03:33:11 INFO - PROCESS | 17196 | 03:33:14 INFO - PROCESS | 17196 | Cycle 1(1): loaded http://localhost:46212/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46212/tests/kraken/driver.html?testName=audio-beat-detection) 03:33:15 INFO - PROCESS | 17196 | RSS: Main: 159506432 03:33:15 INFO - PROCESS | 17196 | 03:33:17 INFO - PROCESS | 17196 | Cycle 1(1): loaded http://localhost:46212/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46212/tests/kraken/driver.html?testName=audio-dft) 03:33:18 INFO - PROCESS | 17196 | RSS: Main: 159035392 03:33:18 INFO - PROCESS | 17196 | 03:33:21 INFO - PROCESS | 17196 | Cycle 1(1): loaded http://localhost:46212/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46212/tests/kraken/driver.html?testName=audio-fft) 03:33:21 INFO - PROCESS | 17196 | RSS: Main: 158863360 03:33:21 INFO - PROCESS | 17196 | 03:33:23 INFO - PROCESS | 17196 | Cycle 1(1): loaded http://localhost:46212/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46212/tests/kraken/driver.html?testName=audio-oscillator) 03:33:24 INFO - PROCESS | 17196 | RSS: Main: 158793728 03:33:24 INFO - PROCESS | 17196 | 03:33:26 INFO - PROCESS | 17196 | Cycle 1(1): loaded http://localhost:46212/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46212/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:33:27 INFO - PROCESS | 17196 | RSS: Main: 158482432 03:33:27 INFO - PROCESS | 17196 | 03:33:30 INFO - PROCESS | 17196 | Cycle 1(1): loaded http://localhost:46212/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46212/tests/kraken/driver.html?testName=imaging-darkroom) 03:33:30 INFO - PROCESS | 17196 | RSS: Main: 159219712 03:33:30 INFO - PROCESS | 17196 | 03:33:34 INFO - PROCESS | 17196 | Cycle 1(1): loaded http://localhost:46212/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46212/tests/kraken/driver.html?testName=imaging-desaturate) 03:33:34 INFO - PROCESS | 17196 | RSS: Main: 159703040 03:33:34 INFO - PROCESS | 17196 | 03:33:37 INFO - PROCESS | 17196 | Cycle 1(1): loaded http://localhost:46212/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46212/tests/kraken/driver.html?testName=json-parse-financial) 03:33:38 INFO - PROCESS | 17196 | RSS: Main: 159174656 03:33:38 INFO - PROCESS | 17196 | 03:33:39 INFO - PROCESS | 17196 | Cycle 1(1): loaded http://localhost:46212/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46212/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:33:40 INFO - PROCESS | 17196 | RSS: Main: 158433280 03:33:40 INFO - PROCESS | 17196 | 03:33:42 INFO - PROCESS | 17196 | Cycle 1(1): loaded http://localhost:46212/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46212/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:33:42 INFO - PROCESS | 17196 | RSS: Main: 158826496 03:33:42 INFO - PROCESS | 17196 | 03:33:44 INFO - PROCESS | 17196 | Cycle 1(1): loaded http://localhost:46212/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46212/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:33:45 INFO - PROCESS | 17196 | RSS: Main: 159428608 03:33:45 INFO - PROCESS | 17196 | 03:33:47 INFO - PROCESS | 17196 | Cycle 1(1): loaded http://localhost:46212/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46212/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:33:48 INFO - PROCESS | 17196 | RSS: Main: 159281152 03:33:48 INFO - PROCESS | 17196 | 03:33:50 INFO - PROCESS | 17196 | Cycle 1(1): loaded http://localhost:46212/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46212/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:33:51 INFO - PROCESS | 17196 | RSS: Main: 158453760 03:33:51 INFO - PROCESS | 17196 | 03:33:53 INFO - PROCESS | 17196 | Cycle 1(1): loaded http://localhost:46212/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46212/tests/kraken/driver.html?testName=ai-astar) 03:33:53 INFO - PROCESS | 17196 | RSS: Main: 161009664 03:33:53 INFO - PROCESS | 17196 | 03:33:53 INFO - PROCESS | 17196 | __start_tp_report 03:33:53 INFO - PROCESS | 17196 | _x_x_mozilla_page_load 03:33:53 INFO - PROCESS | 17196 | _x_x_mozilla_page_load_details 03:33:53 INFO - PROCESS | 17196 | |i|pagename|runs| 03:33:53 INFO - PROCESS | 17196 | |0;ai-astar;110;104;110;110;111;122;109;111;111;111 03:33:53 INFO - PROCESS | 17196 | |1;audio-beat-detection;151;127;149;159;127;147;161;128;167;127 03:33:53 INFO - PROCESS | 17196 | |2;audio-dft;163;162;161;160;161;163;161;161;166;161 03:33:53 INFO - PROCESS | 17196 | |3;audio-fft;74;76;72;162;76;75;76;72;159;75 03:33:53 INFO - PROCESS | 17196 | |4;audio-oscillator;93;94;152;92;94;93;145;93;94;137 03:33:53 INFO - PROCESS | 17196 | |5;imaging-gaussian-blur;118;117;118;118;117;117;117;117;117;117 03:33:53 INFO - PROCESS | 17196 | |6;imaging-darkroom;147;148;146;148;147;146;148;147;146;146 03:33:53 INFO - PROCESS | 17196 | |7;imaging-desaturate;96;97;96;97;97;98;96;96;97;97 03:33:53 INFO - PROCESS | 17196 | |8;json-parse-financial;58;56;55;57;56;57;63;62;55;55 03:33:53 INFO - PROCESS | 17196 | |9;json-stringify-tinderbox;63;64;64;65;64;63;65;63;64;64 03:33:53 INFO - PROCESS | 17196 | |10;stanford-crypto-aes;84;77;80;81;79;79;81;80;79;79 03:33:53 INFO - PROCESS | 17196 | |11;stanford-crypto-ccm;116;118;119;110;115;118;123;126;112;114 03:33:53 INFO - PROCESS | 17196 | |12;stanford-crypto-pbkdf2;137;146;145;143;148;137;154;150;144;135 03:33:53 INFO - PROCESS | 17196 | |13;stanford-crypto-sha256-iterative;71;68;66;74;66;71;67;71;67;65 03:33:53 INFO - PROCESS | 17196 | __end_tp_report 03:33:53 INFO - PROCESS | 17196 | __start_cc_report 03:33:53 INFO - PROCESS | 17196 | _x_x_mozilla_cycle_collect,834 03:33:53 INFO - PROCESS | 17196 | __end_cc_report 03:33:53 INFO - PROCESS | 17196 | __startTimestamp1458988433399__endTimestamp 03:33:53 INFO - PROCESS | 17196 | 03:33:53 INFO - PROCESS | 17196 | ------- Summary: start ------- 03:33:53 INFO - PROCESS | 17196 | Number of tests: 14 03:33:53 INFO - PROCESS | 17196 | 03:33:53 INFO - PROCESS | 17196 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:4.43 (4.0%) stddev-sans-first:4.69 03:33:53 INFO - PROCESS | 17196 | Values: 110.0 104.0 110.0 110.0 111.0 122.0 109.0 111.0 111.0 111.0 03:33:53 INFO - PROCESS | 17196 | 03:33:53 INFO - PROCESS | 17196 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:150.00 stddev:15.80 (10.5%) stddev-sans-first:16.58 03:33:53 INFO - PROCESS | 17196 | Values: 151.0 127.0 149.0 159.0 127.0 147.0 161.0 128.0 167.0 127.0 03:33:53 INFO - PROCESS | 17196 | 03:33:53 INFO - PROCESS | 17196 | [#2] audio-dft Cycles:10 Average:161.90 Median:161.50 stddev:1.73 (1.1%) stddev-sans-first:1.79 03:33:53 INFO - PROCESS | 17196 | Values: 163.0 162.0 161.0 160.0 161.0 163.0 161.0 161.0 166.0 161.0 03:33:53 INFO - PROCESS | 17196 | 03:33:53 INFO - PROCESS | 17196 | [#3] audio-fft Cycles:10 Average:91.70 Median:75.00 stddev:36.30 (48.4%) stddev-sans-first:37.93 03:33:53 INFO - PROCESS | 17196 | Values: 74.0 76.0 72.0 162.0 76.0 75.0 76.0 72.0 159.0 75.0 03:33:53 INFO - PROCESS | 17196 | 03:33:53 INFO - PROCESS | 17196 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:93.00 stddev:25.08 (27.0%) stddev-sans-first:25.95 03:33:53 INFO - PROCESS | 17196 | Values: 93.0 94.0 152.0 92.0 94.0 93.0 145.0 93.0 94.0 137.0 03:33:53 INFO - PROCESS | 17196 | 03:33:53 INFO - PROCESS | 17196 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 03:33:53 INFO - PROCESS | 17196 | Values: 118.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 03:33:53 INFO - PROCESS | 17196 | 03:33:53 INFO - PROCESS | 17196 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 03:33:53 INFO - PROCESS | 17196 | Values: 147.0 148.0 146.0 148.0 147.0 146.0 148.0 147.0 146.0 146.0 03:33:53 INFO - PROCESS | 17196 | 03:33:53 INFO - PROCESS | 17196 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 03:33:53 INFO - PROCESS | 17196 | Values: 96.0 97.0 96.0 97.0 97.0 98.0 96.0 96.0 97.0 97.0 03:33:53 INFO - PROCESS | 17196 | 03:33:53 INFO - PROCESS | 17196 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:57.00 stddev:2.88 (5.0%) stddev-sans-first:3.04 03:33:53 INFO - PROCESS | 17196 | Values: 58.0 56.0 55.0 57.0 56.0 57.0 63.0 62.0 55.0 55.0 03:33:53 INFO - PROCESS | 17196 | 03:33:53 INFO - PROCESS | 17196 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 03:33:53 INFO - PROCESS | 17196 | Values: 63.0 64.0 64.0 65.0 64.0 63.0 65.0 63.0 64.0 64.0 03:33:53 INFO - PROCESS | 17196 | 03:33:53 INFO - PROCESS | 17196 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:80.00 stddev:1.85 (2.3%) stddev-sans-first:1.24 03:33:53 INFO - PROCESS | 17196 | Values: 84.0 77.0 80.0 81.0 79.0 79.0 81.0 80.0 79.0 79.0 03:33:53 INFO - PROCESS | 17196 | 03:33:53 INFO - PROCESS | 17196 | [#11] stanford-crypto-ccm Cycles:10 Average:117.10 Median:118.00 stddev:4.84 (4.1%) stddev-sans-first:5.12 03:33:53 INFO - PROCESS | 17196 | Values: 116.0 118.0 119.0 110.0 115.0 118.0 123.0 126.0 112.0 114.0 03:33:53 INFO - PROCESS | 17196 | 03:33:53 INFO - PROCESS | 17196 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.90 Median:145.50 stddev:6.12 (4.2%) stddev-sans-first:5.96 03:33:53 INFO - PROCESS | 17196 | Values: 137.0 146.0 145.0 143.0 148.0 137.0 154.0 150.0 144.0 135.0 03:33:53 INFO - PROCESS | 17196 | 03:33:53 INFO - PROCESS | 17196 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.50 stddev:2.95 (4.2%) stddev-sans-first:3.00 03:33:53 INFO - PROCESS | 17196 | Values: 71.0 68.0 66.0 74.0 66.0 71.0 67.0 71.0 67.0 65.0 03:33:53 INFO - PROCESS | 17196 | -------- Summary: end -------- 03:33:53 INFO - PROCESS | 17196 | 03:33:54 INFO - TEST-INFO | 17196: exit 0 03:33:54 INFO - TEST-OK | kraken | took 59994ms 03:33:54 INFO - SUITE-END | took 1168s 03:33:54 INFO - Completed test suite (00:19:29) 03:33:54 INFO - javascript benchmark 03:33:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3291.489819078043, 3302.504624306353, 3323.916902077446, 3352.497125431185, 3356.765026448148, 5404.648697834638, 5467.425920278368, 5472.972635136829, 5478.369987451444, 5488.313960754911, 5441.673499590027, 5471.151971444432, 5480.534154596854, 5480.890382192364, 5490.80782172623, 4951.82668606598, 4992.750362481879, 5073.188289873621, 5079.746012699368, 5083.618728595352, 4960.479149689285, 5066.544011039005, 5096.388433387999, 5100.923486147711, 5105.2086926526445, 5050.318207042039, 5060.4686507916695, 5164.561012313939, 5172.069027575035, 5178.48215178481, 5106.055379754739, 5131.409887862887, 5138.254953031789, 5141.948580514184, 5143.8456846294675, 4871.951280487186, 4897.804087836482, 5090.77091530882, 5123.257127716461, 5129.974350128263, 5295.099833028395, 5332.466753324637, 5353.919691204596, 5361.705106219196, 5383.892322153535, 5915.881682366372, 5950.821475355746, 5956.493698035672, 5957.255343082114, 5962.1951036609935, 5981.641101533878, 6003.0, 6041.516678665696, 6083.0, 6118.296395914483, 5557.888842223173, 5594.832155035356, 5601.60788744788, 5602.747876345534, 5609.747561359749, 5988.880222395528, 6117.143599896018, 6136.539759517965, 6151.169592105009, 6152.323244443108, 5839.474447299764, 5859.472647461664, 5889.440503152194, 5892.793752218652, 5905.320888097924, 5960.5827592068135, 5964.045752679551, 5980.312264089685, 5993.280806303272, 5995.52035837132, 5723.227364305849, 5909.527237820964, 5932.555058370639, 5937.050071988548, 5939.346671866091, 5900.291964964232, 5940.70296485174, 5943.613665111754, 5957.195778569924, 5970.253718285215, 4529.365888775574, 4530.456345238593, 4533.070720502289, 4534.183846907588, 4574.6340292776495, 3997.1805779815068, 4042.717009809285, 4067.3898915162963, 4084.1219137885496, 4109.157622687342, 5565.359983601857, 5677.318721753333, 5693.943060569424, 5721.39925307845, 5747.1379293106365, 5931.08068249422, 5973.701314934236, 5981.970090149608, 5988.101784732325, 6018.729157187937, 5564.805231816867, 5675.914861277084, 5718.857028574319, 5721.056025755787, 5729.742161602738, 5021.59827213822, 5027.044861476308, 5043.646944713835, 5061.670991385548, 5073.492650734897, 6168.074788781629, 6203.441690247809, 6204.0, 6217.6891155442045, 6217.844553886189, 5791.131330300489, 5872.882542349043, 5919.171316015675, 5982.641041537521, 6025.035994240988, 6142.416470435302, 6187.319394866471, 6215.160953271251, 6229.719662615103, 6250.718717657807, 5864.120381942743, 5917.526597872246, 5918.881622367615, 5954.523638108854, 5990.400959903975, 5830.912536312044, 5974.074018527135, 5994.550408719277, 6018.428249316308, 6075.726592303268, 5804.158397032491, 5850.23946886902, 5866.941330586639, 5889.970550147222, 5905.084711869667, 5819.15622234782, 5848.561357898089, 5873.03094989322, 5885.529157667462, 5902.970485147547, 5568.081266590967, 5772.595918285848, 5842.152887831326, 5849.415058494286, 5863.91517569251, 5802.1586869902785, 5908.3796201399955, 5920.911186332122, 5929.0, 5946.524278057658, 5640.435956404327, 5807.186993820784, 5808.157817116579, 5819.127130930395, 5820.534357251325], "unit": "score", "name": "dojo.html", "value": 5497.224481090989}, {"lowerIsBetter": false, "replicates": [550.0982318271119, 561.9915701264479, 570.2785975740688, 585.6954383720464, 592.5289394931029, 39916.80041599792, 40863.0, 40931.18137637249, 41011.79494102533, 41087.178256434854, 41364.79317603408, 42085.78957105218, 42185.0, 42225.0, 42441.15117697644, 8712.520811355389, 8935.910640893606, 8975.102489751005, 8986.415882967585, 9007.594658240396, 8722.21500064994, 9032.141946515103, 9091.0, 9115.589798459085, 9145.268378529701, 9078.228350590207, 9102.408343457688, 9170.358074934757, 9175.128362805555, 9208.631654733803, 9005.639774409015, 9017.504037277948, 9070.138336857988, 9101.226395756368, 9133.086691330815, 9096.545172741402, 9155.13026262504, 9176.770580735469, 9231.307651926132, 9249.167574918223, 34961.82519087388, 41382.79308603438, 41438.37842432366, 41914.58085419137, 42031.579684203076, 3535.9646403535894, 3590.6947909427467, 3703.5370578677666, 3789.753666011728, 3839.3281175794123, 29608.40783184346, 29751.25621859449, 29869.850650746608, 30668.693313066808, 30719.692803071906, 4094.754314741125, 4159.8960025999595, 4169.187008533338, 4215.936760948588, 4216.662666986665, 195271.0, 195843.0, 196484.0, 197122.0, 197222.0, 47111.29333060007, 47373.0, 47451.5254847454, 47759.283610745864, 60753.69623151856, 44555.55444445579, 44854.77572612116, 45006.54993450024, 45112.3233151503, 45330.32004519935, 15767.369305227892, 15836.049837009816, 15861.286242119133, 15968.520944371687, 15980.680386392207, 13304.667383315495, 13442.059055865995, 13448.798268025987, 13485.595432137052, 13502.0, 16033.839661603235, 16181.11003894797, 16186.19069046543, 16223.594410139842, 16254.837451625332, 6325.082862984841, 6326.588771729823, 6473.676316184172, 6510.316416776265, 6524.478041756743, 1040.5005597313182, 1094.529352378469, 1131.9943400282946, 1138.584416687903, 1220.6277085489012, 27354.042608508607, 28575.14274571766, 28596.857015714788, 28754.856225718737, 29101.7089829099, 1121.8092924202906, 1171.554809172509, 1207.1067410116625, 1224.7795396828656, 1248.843894513186, 14793.186374749277, 14972.700545989019, 15220.0, 15616.063036217636, 15695.822813289049, 342396.0, 529294.0, 531232.0, 536328.0, 567281.0, 56035.0, 56726.7163664179, 56823.71588142033, 56956.715216423654, 57364.42635573591, 1485.9777103343458, 1491.0904348347499, 1492.5895378770708, 1510.3807438949977, 1520.9619759506102, 27488.312792180357, 28227.294317642223, 28325.71674283231, 28768.0, 28909.56635650509, 52228.73885630548, 52535.73732131315, 52708.73645631747, 53107.468925310255, 53337.19994200012, 299345.0, 304077.0, 304668.0, 305826.0, 306952.0, 36398.27203455969, 36425.817870910476, 36677.26645467129, 36770.0, 37119.257614848095, 48826.75586622044, 51780.0, 52107.0, 53064.73467632637, 53999.0, 38561.614383855805, 39968.0, 40959.0, 41293.793531032155, 42380.57619423766, 39620.603793961694, 40152.39771403373, 40433.39349909813, 40684.38973415342, 41194.38208426816, 40450.59549404586, 40554.594454055084, 41094.38358424566, 41385.79307103445, 41455.7927210362, 34366.65633343734, 35272.11819704528, 35355.46966795551, 35413.46879796754, 35640.465393019644, 25058.37354066163, 25543.87228063848, 25575.360615984748, 25754.87122564375, 26012.0], "unit": "score", "name": "ext.html", "value": 19156.34824377271}, {"lowerIsBetter": false, "replicates": [386.98452061917544, 389.6250104014215, 390.5528170245069, 391.26637554585153, 400.9198160367927, 18723.157457914393, 19051.90474047631, 19204.23183072677, 19303.131359088857, 19886.40340789775, 11402.885971140286, 11743.882561174385, 11748.295102293869, 11748.353840538766, 11801.763964720722, 5152.716600586966, 5249.0, 5311.336082989626, 5708.857278568027, 5743.5118014968775, 5633.042382794934, 5661.2923384576925, 5680.687562184078, 5682.914756278659, 5689.886202275952, 5341.0, 5506.5870059745475, 5607.299087614048, 5616.073347897592, 5636.859078523029, 5529.751161197756, 5558.110702287615, 5563.721813909288, 5597.496225339698, 5613.129964855454, 5410.215518749798, 5685.54515638752, 5689.231953686241, 5689.943100568983, 5697.116946873241, 13041.08712390133, 13462.124961877447, 13526.797098043537, 13734.862651373558, 13802.723945521033, 2345.870977096259, 2380.857148571074, 2508.7742103210617, 2889.537673972154, 2963.851807409621, 9997.900020999843, 10174.389536627827, 10222.591096356211, 10330.741731456774, 10474.109700675452, 1951.278027129971, 1955.4817973236961, 1980.564275859323, 1999.8300144487737, 2018.596280743857, 62577.68711156415, 63476.0, 64236.67881660609, 65294.67352663206, 70592.2940770596, 10849.349039057683, 11160.107191424666, 11254.887451125547, 11303.886961130447, 11467.885321146849, 14974.251287435585, 14979.0, 15094.24528773557, 15133.394664213309, 15141.697166056838, 7558.735444259424, 7864.842703145905, 8325.625346859406, 8415.11641277657, 8636.827263454696, 7482.401407887356, 7614.466987310946, 7682.231776822273, 7725.768226953201, 7729.768106956688, 4637.582617564368, 4650.116477869194, 4650.325702773079, 4650.767461626905, 4671.252599584051, 1930.6621341265222, 1947.575268790365, 1965.5184479802253, 1983.9801601984084, 2024.4432780985053, 926.1710768861966, 976.5459061536278, 991.7371896447447, 994.0, 1044.7440377107657, 15188.620284492976, 16737.07946062954, 16771.580710482336, 17087.963609520717, 17257.223424945907, 1002.2683441088046, 1019.9337043092175, 1032.256775121911, 1061.6072053340313, 1096.6764804382726, 9913.142560145621, 10070.446125463024, 10137.493125343703, 10162.339447935861, 10255.58977640901, 446433.0, 448593.0, 457873.0, 460400.0, 463511.0, 75334.0, 75949.62025189839, 77915.0, 78490.6075469619, 79706.60146699345, 1096.9012788849043, 1137.2153214282118, 1142.440204299887, 1146.8279758036194, 1147.5065721739566, 15567.143807090719, 15731.606709832346, 15748.133852638215, 15832.208389580705, 15906.9204653976, 35228.295434090665, 35621.57513699423, 35785.0, 36022.81988590145, 36837.0, 47942.0, 48252.51747482621, 50093.74953125357, 52078.47921520888, 55036.174457383975, 7814.53112813233, 8106.878396823934, 8356.0, 8585.184407481529, 8677.739667809976, 12332.075094368138, 12337.629871103882, 12484.438200280827, 12499.875001250235, 12714.982801376053, 5287.339082614673, 5442.836714898559, 10043.096121349114, 10186.796264074528, 10677.825439201837, 10429.53067111997, 10434.217433692655, 10566.8414973777, 10655.20085993569, 10661.626843060456, 10194.541245643815, 10587.364758114538, 10902.672919812418, 10913.78172436531, 11452.427378631202, 7788.104367997753, 8000.159983201913, 8080.63637136342, 8333.499990000619, 8455.830883382176, 7864.252895974873, 9504.572294246636, 9815.0, 10139.391636501834, 10253.538590763583], "unit": "score", "name": "jquery.html", "value": 8527.873718174473}, {"lowerIsBetter": false, "replicates": [1569.419314853504, 1575.9763603545946, 1855.1095474172396, 1937.6512227799008, 1993.1927569334425, 7203.06360173178, 7902.170272121431, 8033.87949180762, 8256.215659512343, 8260.339172866172, 7929.207079292068, 7968.442209045369, 8052.476589021724, 8054.637541310641, 8088.029436467632, 2412.9396765080883, 2430.4652976345174, 2442.05980697431, 2443.5479436304254, 2457.8279520433575, 2267.444476103357, 2299.298713892262, 2299.9655005174936, 2309.93070207894, 2372.833901626887, 2418.1657328221736, 2441.951160976779, 2451.117597664839, 2456.4718585504115, 2466.149178533412, 2428.76926691964, 2432.8905199266073, 2433.987830060856, 2444.144549407702, 2474.505098980193, 2410.180538616861, 2423.4062654649724, 2426.2721183644835, 2432.4405386761146, 2436.3300092474533, 8227.71203007892, 8294.668213271521, 8316.708915187939, 8325.417220794547, 8352.290055345304, 4919.508049195088, 5039.370078740158, 5040.974795126001, 5051.797928082872, 5063.088644044071, 3177.952330715041, 3179.332340208559, 3268.150280926976, 3287.671232876717, 3365.057783820534, 1036.424784244744, 2038.7349644546262, 2052.435580215453, 2081.261152290945, 2084.458040909359, 10896.073833724144, 10985.835212471819, 11003.449827508593, 11026.724331891606, 11031.0, 4076.5108187017154, 4227.365895115696, 4242.618164365222, 4302.870913872589, 4334.371516130143, 8842.292616590657, 8905.332100092519, 8911.331650126267, 8948.328875334377, 8973.102689730975, 4879.39007624047, 4910.042541704404, 4922.1140194765285, 4925.679830810986, 4927.187014142698, 4099.323611604112, 4500.077484115748, 4525.502194758574, 4526.864194074183, 4531.546845315508, 3602.369585322558, 3635.600083990759, 3639.636036396339, 3669.504616876741, 3710.239400922804, 1037.2946396450486, 1090.1170052257696, 1099.3074363151163, 1116.3580940958982, 1118.7762447510531, 1108.5067145120506, 1124.1849658997162, 1127.22784892349, 1299.5191779041816, 1372.8078069070339, 7746.883796743054, 7889.368850491946, 7909.05091389037, 7909.09045459768, 7952.681892724227, 1187.649643355195, 1202.939853007346, 1219.3171823778534, 1220.2068655374078, 1236.9072319576069, 6019.277686677539, 6136.110264011693, 6150.138980542728, 6192.0, 6222.253329600387, 9614.567344469515, 9885.555150018123, 9942.552585133686, 9942.801143977225, 10053.447060411747, 9798.902010979798, 9922.206223502102, 9931.354461959949, 9946.850797238047, 9977.501124943868, 7718.652660630173, 7740.225977402328, 7791.4935529190425, 7798.220177982156, 7845.921540784633, 7477.476576639583, 7538.0, 7647.349975251944, 7659.234076592296, 7684.961575192088, 8685.174908383693, 8840.557972101498, 8876.600552975002, 8974.237189838937, 9116.179543841086, 8927.062658420773, 9065.592048357708, 9197.54012299369, 9202.309826762885, 9245.676401325922, 6121.234845644294, 6436.388543088399, 6561.475081993524, 6627.701753421204, 6748.223954245324, 7791.104023037423, 7806.4925779824125, 7811.453198276066, 7835.177306382748, 7854.1753115922, 7071.964640176766, 7130.750423735144, 7145.356917877416, 7169.4622903281415, 7177.784666460015, 6737.562058466184, 6824.522283440111, 6827.453803695593, 6928.549644273106, 6929.792106236821, 7120.1099862517185, 7189.964050179925, 7249.093863267091, 7396.149442814145, 7471.0, 6609.4712423007, 6639.0, 6640.83397915056, 6677.065210870579, 6693.397594216543, 6608.504362172953, 6609.900851487328, 6639.136912201576, 6706.530542862148, 6723.596584204964], "unit": "score", "name": "mootools.html", "value": 4748.217892978646}, {"lowerIsBetter": false, "replicates": [353.0978350314945, 360.35316606691, 361.7142457458608, 365.97438179327423, 370.3999520776343, 6352.269489008765, 6389.488840892729, 6422.261439934409, 6441.581297215689, 6446.742130314788, 6284.5600807943465, 6296.6536840473755, 6308.243010838694, 6317.589356691812, 6342.460890824285, 4644.674872758908, 4734.266188740734, 4875.756212189394, 4877.073356062355, 4894.97552512237, 4807.038592281558, 4864.562189402953, 4865.48912364202, 4890.657653964224, 4908.9263661045115, 4824.059308434857, 4850.126977144113, 4852.757362131897, 4853.587445067174, 4860.368152140234, 4834.516548345155, 4850.102730994778, 4859.295402166701, 4866.245731911559, 4873.463918968911, 4285.271503844323, 4293.699441039129, 4296.57034296571, 4296.6777491687935, 4300.118475712503, 5813.0, 6031.517478601701, 6051.213342265477, 6061.242344706911, 6062.363451837582, 5602.691851948182, 5605.1872478490795, 5625.268715067056, 5638.830835074954, 5687.914681279784, 6752.155980502437, 6769.153855768029, 6788.59268443895, 6791.524593278473, 6815.863682726367, 4640.814367425299, 4642.558956899089, 4643.628509719214, 4649.0, 4653.511381304948, 7012.614306213156, 7034.120734908137, 7072.186698529632, 7079.079719636415, 7102.218755936791, 4599.149157405891, 4756.025014872012, 4777.187878060738, 4779.880502987453, 4793.089313030513, 4808.711477311373, 4827.058723548875, 4836.927446088312, 4840.540148685869, 4845.152098382769, 5597.244372009808, 5608.747606357723, 5612.849365879984, 5621.634593751393, 5625.296837895263, 6809.319068093151, 6819.113515242987, 6822.692978815965, 6824.18109826814, 6833.863322733518, 1667.4497415852738, 1708.3081352052438, 1709.529879283207, 1714.9571260718333, 1720.6558688262398, 1098.417838545572, 1118.4463690473267, 1134.3137401871913, 1144.9942750286195, 1158.449736375215, 6499.122618446544, 6499.38255865692, 6525.804225873137, 6528.738850446024, 6546.476281897437, 6924.61914594692, 6969.2682268362105, 6973.12835895513, 6981.5461994970165, 6988.755393561201, 6586.604803711793, 6588.044733513614, 6604.834879127964, 6628.105205797252, 6632.701528431232, 3745.6254374562327, 3806.352920003606, 3809.9238015240094, 3816.6183381661613, 3818.7517811342173, 7375.520591161665, 7384.556926584422, 7385.335319821242, 7412.740554080581, 7436.070491188601, 7038.155421349471, 7206.495545311778, 7250.3112204340505, 7273.89089163663, 7293.963530182421, 7422.962885185648, 7423.406127509894, 7452.0, 7466.2160473150625, 7466.36535894455, 7032.789016329519, 7061.6822243000215, 7069.469789765685, 7080.0, 7114.039604653305, 6945.062416573698, 6950.16598008222, 6959.8956015660815, 6983.0, 6987.965060174666, 7264.782056538101, 7390.260973902567, 7415.8146046349275, 7450.143233528213, 7453.366463850417, 4653.046125544323, 4661.184292748823, 4683.718976861399, 4691.390119284608, 4696.788644510937, 7080.539764915264, 7091.539049961736, 7110.6089165094345, 7113.181984071898, 7116.573005619679, 6837.829054273683, 6875.862482750417, 6882.552634078769, 6886.311368863074, 6899.862002760017, 6818.93181068183, 6841.828954275984, 6897.793066208022, 6903.551269167488, 6942.791716248521, 6735.191776986793, 6756.391924726799, 6756.527043106936, 6765.932340676531, 6774.254831968381, 6856.691448884712, 6867.759628412981, 6868.828279292858, 6869.210040845367, 6872.278410766998, 6690.531662783753, 6693.431058359899, 6710.060591517289, 6728.461723062242, 6729.024291477611], "unit": "score", "name": "prototype.html", "value": 5126.286626023725}, {"lowerIsBetter": false, "replicates": [758.9924100758992, 779.6257796257793, 865.1175800683303, 873.4235404632941, 876.9912300876989, 13534.458621655134, 13540.526081587146, 13616.0, 13627.182369057851, 13646.181229126247, 13199.142055766368, 13874.861251387483, 13897.722045559083, 13903.93048034761, 13937.651558711037, 760.1220590218306, 922.114769820971, 923.8983711791698, 944.5702205496517, 944.914957653811, 916.5234078279291, 916.715818096389, 921.7280902133887, 921.8156368726249, 924.1728652855691, 985.6205360936056, 987.1609132237612, 995.4276291132592, 996.267743208741, 997.0677416615451, 976.4092723902008, 977.7360112769547, 981.102291403365, 983.8081574092984, 985.2955137077024, 731.1591669579973, 731.7987553422798, 731.8499707559937, 733.787201711503, 734.2877408913346, 14462.92768536161, 14571.052881562664, 14576.344064517121, 14603.269836508132, 14613.342399592044, 13679.589612311647, 13803.2408217548, 13815.0, 13846.376913038937, 13915.095518791246, 11213.0, 11230.0, 11255.324680519196, 11452.656420307405, 11457.942710286396, 3525.2596954639557, 3714.052916506301, 3728.7017038637114, 3757.5490941086973, 3786.413105968552, 50826.0, 51104.0, 52688.209676854494, 52704.47295527072, 53026.46973530254, 10951.945240273748, 11154.609588664358, 11318.547258109747, 11319.0, 11403.771924561463, 19236.134373953206, 19269.4219173425, 19290.71063934042, 19302.745321554055, 19517.902410487855, 8035.718749843727, 8165.877511837327, 8290.544020078833, 8359.164083591591, 8362.45644033136, 4546.863594092182, 4570.291604801261, 4625.0, 4688.085823264499, 4769.57073863354, 3184.5064015077237, 3192.5849639547173, 3195.3769015041844, 3225.3549290142064, 3225.741940644743, 544.1973089692672, 550.3285991090863, 552.6214543037952, 561.5283162143819, 564.3087218157806, 656.5961933410917, 659.9076129341896, 684.4934748286232, 704.992950070503, 707.518887156728, 7665.348445382094, 7762.7671169865, 7937.603119843985, 7942.364610831235, 8246.299064579458, 507.421539445033, 555.038867641131, 701.6596950479013, 710.5665544018145, 712.6757325417027, 3966.6231707987695, 4050.7569545827346, 4064.1058967027207, 4228.5982831630945, 4317.978410107929, 56719.0, 56932.715336423884, 57050.0, 57962.420375796544, 58522.7073864628, 49532.75233623809, 50721.0, 50833.71248293762, 51246.0, 55084.72457637767, 46784.2982355265, 47404.25276669796, 47422.0, 47950.28074578954, 48123.5187648119, 8418.242358187792, 8462.703805366782, 8665.956670216608, 8823.0, 8957.59690813928, 34813.303733925684, 35420.82289588536, 35711.0, 36532.452013220354, 36595.45106823453, 41407.792961035004, 43988.34017489676, 45146.097078057595, 45817.77091114523, 46014.769926150155, 11455.770884582094, 11762.470688818852, 11877.168598198043, 11994.820077698667, 12037.578684745991, 13273.39429555942, 13376.464941402624, 13489.0, 13557.525486607921, 13708.314584270547, 11761.294322340687, 11853.229540080212, 11862.940685296518, 12026.939865300617, 12063.517459301529, 11815.881841181477, 11907.82138267944, 11918.225315354473, 12036.398180091135, 12094.213876098025, 11755.0, 11792.941035294769, 11852.525898963944, 11944.522219111139, 12070.396480176132, 10107.595696172071, 10455.11131553796, 10615.097716694167, 10646.148308135485, 10683.198760093179, 9548.618055277711, 10021.749456263651, 10064.345817521838, 10075.848862266925, 10119.59521619127], "unit": "score", "name": "yui.html", "value": 6670.044400149888}], "name": "dromaeo_css", "value": 7254.914857675887}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 104.0, 110.0, 110.0, 111.0, 122.0, 109.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [151.0, 127.0, 149.0, 159.0, 127.0, 147.0, 161.0, 128.0, 167.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 144.3}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 161.0, 160.0, 161.0, 163.0, 161.0, 161.0, 166.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 72.0, 162.0, 76.0, 75.0, 76.0, 72.0, 159.0, 75.0], "unit": "score", "name": "audio-fft", "value": 91.7}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 152.0, 92.0, 94.0, 93.0, 145.0, 93.0, 94.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.3}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 146.0, 148.0, 147.0, 146.0, 148.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 97.0, 97.0, 98.0, 96.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [58.0, 56.0, 55.0, 57.0, 56.0, 57.0, 63.0, 62.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.4}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 65.0, 64.0, 63.0, 65.0, 63.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.9}, {"lowerIsBetter": true, "replicates": [84.0, 77.0, 80.0, 81.0, 79.0, 79.0, 81.0, 80.0, 79.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.9}, {"lowerIsBetter": true, "replicates": [116.0, 118.0, 119.0, 110.0, 115.0, 118.0, 123.0, 126.0, 112.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.1}, {"lowerIsBetter": true, "replicates": [137.0, 146.0, 145.0, 143.0, 148.0, 137.0, 154.0, 150.0, 144.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.9}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 66.0, 74.0, 66.0, 71.0, 67.0, 71.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1509.2}]} 03:33:54 INFO - Return code: 0 03:33:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 03:33:54 ERROR - # TBPL SUCCESS # 03:33:54 INFO - Running post-action listener: _resource_record_post_action 03:33:54 INFO - Running post-run listener: _resource_record_post_run 03:33:55 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 286720; Write bytes: 498819072; Read time: 56; Write time: 421116 03:33:55 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 244170752; Read time: 0; Write time: 258544 03:33:55 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 286720; Write bytes: 254648320; Read time: 56; Write time: 162572 03:33:55 INFO - Running post-run listener: _upload_blobber_files 03:33:55 INFO - Blob upload gear active. 03:33:55 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 03:33:55 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 03:33:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 03:33:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 03:33:56 INFO - (blobuploader) - INFO - Open directory for files ... 03:33:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:33:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:33:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:33:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:33:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:33:57 INFO - (blobuploader) - INFO - Done attempting. 03:33:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:33:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:33:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:33:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:33:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:33:58 INFO - (blobuploader) - INFO - Done attempting. 03:33:58 INFO - (blobuploader) - INFO - Iteration through files over. 03:33:58 INFO - Return code: 0 03:33:58 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 03:33:58 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 03:33:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/28811aabbcc85347fda54686e09e9880ae28194d6f1b63ac895f291f2145bede1066519748e22c05638fce80ef2a7c2093f7406e3da44a91974088f964d6f797", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/404055ffd40a1f030cda352a9fe7b07e78deb2aa1d12db8f9dd63033b777516693c75ad99a2b310d5cc6615b2e7413d5cf9397754e4d2fc609935c25137dc258"} 03:33:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 03:33:58 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 03:33:58 INFO - Contents: 03:33:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/28811aabbcc85347fda54686e09e9880ae28194d6f1b63ac895f291f2145bede1066519748e22c05638fce80ef2a7c2093f7406e3da44a91974088f964d6f797", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/404055ffd40a1f030cda352a9fe7b07e78deb2aa1d12db8f9dd63033b777516693c75ad99a2b310d5cc6615b2e7413d5cf9397754e4d2fc609935c25137dc258"} 03:33:58 INFO - Running post-run listener: copy_logs_to_upload_dir 03:33:58 INFO - Copying logs to upload dir... 03:33:58 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 03:33:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.126494 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-03-26 03:33:57.943509) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-26 03:33:57.947023) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1458986068.545408-207911920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/28811aabbcc85347fda54686e09e9880ae28194d6f1b63ac895f291f2145bede1066519748e22c05638fce80ef2a7c2093f7406e3da44a91974088f964d6f797", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/404055ffd40a1f030cda352a9fe7b07e78deb2aa1d12db8f9dd63033b777516693c75ad99a2b310d5cc6615b2e7413d5cf9397754e4d2fc609935c25137dc258"} build_url:https://queue.taskcluster.net/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011355 build_url: 'https://queue.taskcluster.net/v1/task/TPXfxFc3S4iYZGxvhgdd2g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/28811aabbcc85347fda54686e09e9880ae28194d6f1b63ac895f291f2145bede1066519748e22c05638fce80ef2a7c2093f7406e3da44a91974088f964d6f797", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/404055ffd40a1f030cda352a9fe7b07e78deb2aa1d12db8f9dd63033b777516693c75ad99a2b310d5cc6615b2e7413d5cf9397754e4d2fc609935c25137dc258"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-26 03:33:57.971222) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-26 03:33:57.971503) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1458986068.545408-207911920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004562 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-26 03:33:58.068745) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-26 03:33:58.069028) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-26 03:33:58.069568) ========= ========= Total master_lag: 0.37 =========