builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1459183700.23 results: success (0) buildid: 20160328073141 builduid: a5a4168dfbdd43ff8c40e6c00080e285 revision: 073bbd96f75766ec2843bb905da2f7d1f0eaa0d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-28 09:48:20.232461) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-28 09:48:20.233001) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-28 09:48:20.233378) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1459174066.371837-1748513583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006330 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-28 09:48:20.257085) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-28 09:48:20.257478) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-28 09:48:20.270774) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:48:20.271096) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1459174066.371837-1748513583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004616 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:48:20.320451) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-28 09:48:20.320800) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-28 09:48:20.321268) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:48:20.321591) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1459174066.371837-1748513583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-28 09:48:20-- 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% 70.8M=0s 2016-03-28 09:48:21 (70.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.212542 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:48:20.551400) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:48:20.552118) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1459174066.371837-1748513583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015127 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:48:20.604886) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:48:20.605675) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 073bbd96f75766ec2843bb905da2f7d1f0eaa0d2 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 073bbd96f75766ec2843bb905da2f7d1f0eaa0d2 --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=2c5dd2b0a310ecf02fd87158000001b4-1459174066.371837-1748513583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-28 09:48:21,131 truncating revision to first 12 chars 2016-03-28 09:48:21,131 Setting DEBUG logging. 2016-03-28 09:48:21,131 attempt 1/10 2016-03-28 09:48:21,131 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/073bbd96f757?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-28 09:48:21,435 unpacking tar archive at: mozilla-inbound-073bbd96f757/testing/mozharness/ program finished with exit code 0 elapsedTime=0.569418 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:48:21.259574) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-28 09:48:21.259922) ========= echo 073bbd96f75766ec2843bb905da2f7d1f0eaa0d2 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'073bbd96f75766ec2843bb905da2f7d1f0eaa0d2'] 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=2c5dd2b0a310ecf02fd87158000001b4-1459174066.371837-1748513583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 073bbd96f75766ec2843bb905da2f7d1f0eaa0d2 program finished with exit code 0 elapsedTime=0.004689 script_repo_revision: '073bbd96f75766ec2843bb905da2f7d1f0eaa0d2' ========= master_lag: 0.02 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-28 09:48:21.283617) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-28 09:48:21.283938) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-28 09:48:21.294587) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-03-28 09:48:21.295037) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1459174066.371837-1748513583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:48:21 INFO - MultiFileLogger online at 20160328 09:48:21 in /builds/slave/test-pgo 09:48:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 09:48:21 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:48:21 INFO - {'append_to_log': False, 09:48:21 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:48:21 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:48:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:48:21 INFO - 'branch': 'Mozilla-Inbound', 09:48:21 INFO - 'buildbot_json_path': 'buildprops.json', 09:48:21 INFO - 'config_files': ('talos/linux_config.py',), 09:48:21 INFO - 'default_actions': ('clobber', 09:48:21 INFO - 'read-buildbot-config', 09:48:21 INFO - 'download-and-extract', 09:48:21 INFO - 'populate-webroot', 09:48:21 INFO - 'create-virtualenv', 09:48:21 INFO - 'install', 09:48:21 INFO - 'run-tests'), 09:48:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:48:21 INFO - 'download_minidump_stackwalk': True, 09:48:21 INFO - 'download_symbols': 'ondemand', 09:48:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:48:21 INFO - 'tooltool.py': '/tools/tooltool.py', 09:48:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:48:21 INFO - '/tools/misc-python/virtualenv.py')}, 09:48:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:48:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:48:21 INFO - 'installer_path': 'installer.exe', 09:48:21 INFO - 'log_level': 'info', 09:48:21 INFO - 'log_name': 'talos', 09:48:21 INFO - 'log_to_console': True, 09:48:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:48:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:48:21 INFO - 'opt_config_files': (), 09:48:21 INFO - 'pip_index': False, 09:48:21 INFO - 'sps_profile': False, 09:48:21 INFO - 'sps_profile_interval': 0, 09:48:21 INFO - 'suite': 'dromaeojs', 09:48:21 INFO - 'system_bits': '32', 09:48:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:48:21 INFO - 'title': 'talos-linux64-ix-012', 09:48:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:48:21 INFO - 'use_talos_json': True, 09:48:21 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:48:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:48:21 INFO - 'work_dir': 'build'} 09:48:21 INFO - ##### 09:48:21 INFO - ##### Running clobber step. 09:48:21 INFO - ##### 09:48:21 INFO - Running pre-action listener: _resource_record_pre_action 09:48:21 INFO - Running main action method: clobber 09:48:21 INFO - rmtree: /builds/slave/test-pgo/build 09:48:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:48:22 INFO - Running post-action listener: _resource_record_post_action 09:48:22 INFO - ##### 09:48:22 INFO - ##### Running read-buildbot-config step. 09:48:22 INFO - ##### 09:48:22 INFO - Running pre-action listener: _resource_record_pre_action 09:48:22 INFO - Running main action method: read_buildbot_config 09:48:22 INFO - Using buildbot properties: 09:48:22 INFO - { 09:48:22 INFO - "project": "", 09:48:22 INFO - "product": "firefox", 09:48:22 INFO - "script_repo_revision": "production", 09:48:22 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 09:48:22 INFO - "repository": "", 09:48:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 09:48:22 INFO - "buildid": "20160328073141", 09:48:22 INFO - "pgo_build": "True", 09:48:22 INFO - "basedir": "/builds/slave/test-pgo", 09:48:22 INFO - "buildnumber": 810, 09:48:22 INFO - "slavename": "talos-linux64-ix-012", 09:48:22 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:48:22 INFO - "platform": "ubuntu64_hw", 09:48:22 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 09:48:22 INFO - "branch": "mozilla-inbound", 09:48:22 INFO - "repo_path": "integration/mozilla-inbound", 09:48:22 INFO - "revision": "073bbd96f75766ec2843bb905da2f7d1f0eaa0d2", 09:48:22 INFO - "stage_platform": "linux64-pgo", 09:48:22 INFO - "builduid": "a5a4168dfbdd43ff8c40e6c00080e285", 09:48:22 INFO - "slavebuilddir": "test" 09:48:22 INFO - } 09:48:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 09:48:22 INFO - Running post-action listener: _resource_record_post_action 09:48:22 INFO - ##### 09:48:22 INFO - ##### Running download-and-extract step. 09:48:22 INFO - ##### 09:48:22 INFO - Running pre-action listener: _resource_record_pre_action 09:48:22 INFO - Running main action method: download_and_extract 09:48:22 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:22 INFO - https://queue.taskcluster.net/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:48:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:48:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:48:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:48:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:48:23 INFO - Downloaded 1361 bytes. 09:48:23 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:48:23 INFO - Using the following test package requirements: 09:48:23 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:48:23 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:48:23 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:48:23 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:23 INFO - u'jsshell-linux-x86_64.zip'], 09:48:23 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:48:23 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:48:23 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:48:23 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:48:23 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:48:23 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:48:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:23 INFO - https://queue.taskcluster.net/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:48:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:48:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:48:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:48:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:48:28 INFO - Downloaded 23655790 bytes. 09:48:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:48:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 09:48:29 INFO - Return code: 0 09:48:29 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:48:29 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')]} 09:48:29 INFO - https://queue.taskcluster.net/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:48:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:48:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:48:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:48:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:48:37 INFO - Downloaded 23655790 bytes. 09:48:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:48:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 09:48:38 INFO - Return code: 0 09:48: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')]} 09:48:38 INFO - https://queue.taskcluster.net/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:48:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:48:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:48:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:48:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:48:39 INFO - Downloaded 10847531 bytes. 09:48:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:48:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 09:48:39 INFO - Return code: 0 09:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:39 INFO - https://queue.taskcluster.net/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:48:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:48:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:48:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:48:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:48:41 INFO - Downloaded 57828226 bytes. 09:48:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:48:41 INFO - mkdir: /builds/slave/test-pgo/properties 09:48:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:48:41 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:48:41 INFO - Contents: 09:48:41 INFO - build_url:https://queue.taskcluster.net/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:48:42 INFO - Running post-action listener: _resource_record_post_action 09:48:42 INFO - Running post-action listener: set_extra_try_arguments 09:48:42 INFO - ##### 09:48:42 INFO - ##### Running populate-webroot step. 09:48:42 INFO - ##### 09:48:42 INFO - Running pre-action listener: _resource_record_pre_action 09:48:42 INFO - Running main action method: populate_webroot 09:48:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:48:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:48:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:48:42 INFO - '--tppagecycles', 09:48:42 INFO - '7'], 09:48:42 INFO - 'tests': ['tsvgm']}}, 09:48:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:48:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:48:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:48:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:48:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:48:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:48:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:42 INFO - 'talos_options': ['--e10s'], 09:48:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:42 INFO - 'tests': ['damp', 'tps']}, 09:48:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:42 INFO - 'talos_options': ['--e10s'], 09:48:42 INFO - 'tests': ['damp', 'tps']}, 09:48:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:48:42 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 09:48:42 INFO - 'tests': ['dromaeo_dom']}, 09:48:42 INFO - 'other': {'tests': ['a11yr', 09:48:42 INFO - 'ts_paint', 09:48:42 INFO - 'tpaint', 09:48:42 INFO - 'sessionrestore', 09:48:42 INFO - 'sessionrestore_no_auto_restore', 09:48:42 INFO - 'tabpaint']}, 09:48:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:48:42 INFO - 'tests': ['a11yr', 09:48:42 INFO - 'ts_paint', 09:48:42 INFO - 'tpaint', 09:48:42 INFO - 'sessionrestore', 09:48:42 INFO - 'sessionrestore_no_auto_restore', 09:48:42 INFO - 'tabpaint']}, 09:48:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:48:42 INFO - 'tests': ['a11yr', 09:48:42 INFO - 'ts_paint', 09:48:42 INFO - 'tpaint', 09:48:42 INFO - 'sessionrestore', 09:48:42 INFO - 'sessionrestore_no_auto_restore', 09:48:42 INFO - 'tabpaint']}, 09:48:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:48:42 INFO - 'tests': ['a11yr', 09:48:42 INFO - 'ts_paint', 09:48:42 INFO - 'tpaint', 09:48:42 INFO - 'sessionrestore', 09:48:42 INFO - 'sessionrestore_no_auto_restore', 09:48:42 INFO - 'tabpaint']}, 09:48:42 INFO - 'other_l64': {'tests': ['a11yr', 09:48:42 INFO - 'ts_paint', 09:48:42 INFO - 'tpaint', 09:48:42 INFO - 'sessionrestore', 09:48:42 INFO - 'sessionrestore_no_auto_restore', 09:48:42 INFO - 'tabpaint']}, 09:48:42 INFO - 'other_nol64': {'tests': ['a11yr', 09:48:42 INFO - 'ts_paint', 09:48:42 INFO - 'tpaint', 09:48:42 INFO - 'sessionrestore', 09:48:42 INFO - 'sessionrestore_no_auto_restore', 09:48:42 INFO - 'tabpaint']}, 09:48:42 INFO - 'svgr': {'tests': ['tsvgx', 09:48:42 INFO - 'tsvgr_opacity', 09:48:42 INFO - 'tart', 09:48:42 INFO - 'tscrollx', 09:48:42 INFO - 'cart']}, 09:48:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:48:42 INFO - 'tests': ['tsvgx', 09:48:42 INFO - 'tsvgr_opacity', 09:48:42 INFO - 'tart', 09:48:42 INFO - 'tscrollx', 09:48:42 INFO - 'cart']}, 09:48:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:42 INFO - 'tests': ['tp5o']}, 09:48:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:42 INFO - 'talos_options': ['--e10s'], 09:48:42 INFO - 'tests': ['tp5o']}, 09:48:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:42 INFO - 'talos_options': ['--xperf_path', 09:48:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:42 INFO - 'tests': ['tp5n']}, 09:48:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:42 INFO - 'talos_options': ['--e10s', 09:48:42 INFO - '--xperf_path', 09:48:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:42 INFO - 'tests': ['tp5n']}}, 09:48:42 INFO - 'talos.zip': {'path': '', 09:48:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:48:42 INFO - Running post-action listener: _resource_record_post_action 09:48:42 INFO - ##### 09:48:42 INFO - ##### Running create-virtualenv step. 09:48:42 INFO - ##### 09:48:42 INFO - Running pre-action listener: _resource_record_pre_action 09:48:42 INFO - Running main action method: create_virtualenv 09:48:42 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:48:42 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 09:48:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:48:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:48:42 INFO - Using real prefix '/usr' 09:48:42 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:48:42 INFO - Installing distribute.............................................................................................................................................................................................done. 09:48:44 INFO - Installing pip.................done. 09:48:44 INFO - Return code: 0 09:48:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:48:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac087a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bad8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3c8b0>, '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 0x1c3d7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3dc60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1459174066.371837-1748513583', '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 09:48:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 09:48:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:48:44 INFO - Using env: {'DISPLAY': ':0', 09:48:44 INFO - 'HOME': '/home/cltbld', 09:48:44 INFO - 'LANG': 'en_US.UTF-8', 09:48:44 INFO - 'LANGUAGE': 'en_US:en', 09:48:44 INFO - 'LOGNAME': 'cltbld', 09:48:44 INFO - 'MAIL': '/var/mail/cltbld', 09:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:44 INFO - 'MOZ_NO_REMOTE': '1', 09:48:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:44 INFO - 'NO_EM_RESTART': '1', 09:48:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:48:44 INFO - 'PWD': '/builds/slave/test-pgo', 09:48:44 INFO - 'SHELL': '/bin/bash', 09:48:44 INFO - 'SHLVL': '1', 09:48:44 INFO - 'TERM': 'linux', 09:48:44 INFO - 'TMOUT': '86400', 09:48:44 INFO - 'USER': 'cltbld', 09:48:44 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1459174066.371837-1748513583', 09:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:44 INFO - '_': '/tools/buildbot/bin/python'} 09:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:45 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 09:48:45 INFO - Cleaning up... 09:48:45 INFO - Return code: 0 09:48:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:48:45 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')]} 09:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:45 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')]} 09:48:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:45 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 0x7fac087a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bad8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3c8b0>, '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 0x1c3d7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3dc60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1459174066.371837-1748513583', '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 09:48:45 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 09:48:45 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 09:48:45 INFO - Using env: {'DISPLAY': ':0', 09:48:45 INFO - 'HOME': '/home/cltbld', 09:48:45 INFO - 'LANG': 'en_US.UTF-8', 09:48:45 INFO - 'LANGUAGE': 'en_US:en', 09:48:45 INFO - 'LOGNAME': 'cltbld', 09:48:45 INFO - 'MAIL': '/var/mail/cltbld', 09:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:45 INFO - 'MOZ_NO_REMOTE': '1', 09:48:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:45 INFO - 'NO_EM_RESTART': '1', 09:48:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:48:45 INFO - 'PWD': '/builds/slave/test-pgo', 09:48:45 INFO - 'SHELL': '/bin/bash', 09:48:45 INFO - 'SHLVL': '1', 09:48:45 INFO - 'TERM': 'linux', 09:48:45 INFO - 'TMOUT': '86400', 09:48:45 INFO - 'USER': 'cltbld', 09:48:45 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1459174066.371837-1748513583', 09:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:45 INFO - '_': '/tools/buildbot/bin/python'} 09:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:45 INFO - Downloading/unpacking psutil>=0.7.1 09:48:45 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 09:48:45 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 09:48:45 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 09:48:45 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 09:48:45 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 09:48:45 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 09:48:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:48:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:48:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:48:47 INFO - Installing collected packages: psutil 09:48:47 INFO - Running setup.py install for psutil 09:48:47 INFO - building 'psutil._psutil_linux' extension 09:48:47 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 09:48:47 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 09:48:47 INFO - building 'psutil._psutil_posix' extension 09:48:47 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 09:48:47 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 09:48:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:48:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:48:47 INFO - Successfully installed psutil 09:48:47 INFO - Cleaning up... 09:48:47 INFO - Return code: 0 09:48:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:48: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')]} 09:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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')]} 09:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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', '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 0x7fac087a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bad8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3c8b0>, '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 0x1c3d7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3dc60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1459174066.371837-1748513583', '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 09:48: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 09:48: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 mozsystemmonitor==0.0.0 09:48:47 INFO - Using env: {'DISPLAY': ':0', 09:48:47 INFO - 'HOME': '/home/cltbld', 09:48:47 INFO - 'LANG': 'en_US.UTF-8', 09:48:47 INFO - 'LANGUAGE': 'en_US:en', 09:48:47 INFO - 'LOGNAME': 'cltbld', 09:48:47 INFO - 'MAIL': '/var/mail/cltbld', 09:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:47 INFO - 'MOZ_NO_REMOTE': '1', 09:48:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:47 INFO - 'NO_EM_RESTART': '1', 09:48:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:48:47 INFO - 'PWD': '/builds/slave/test-pgo', 09:48:47 INFO - 'SHELL': '/bin/bash', 09:48:47 INFO - 'SHLVL': '1', 09:48:47 INFO - 'TERM': 'linux', 09:48:47 INFO - 'TMOUT': '86400', 09:48:47 INFO - 'USER': 'cltbld', 09:48:47 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1459174066.371837-1748513583', 09:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:47 INFO - '_': '/tools/buildbot/bin/python'} 09:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:48:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:48:49 INFO - Installing collected packages: mozsystemmonitor 09:48:49 INFO - Running setup.py install for mozsystemmonitor 09:48:50 INFO - Successfully installed mozsystemmonitor 09:48:50 INFO - Cleaning up... 09:48:50 INFO - Return code: 0 09:48:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:48: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')]} 09:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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')]} 09:48:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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', '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 0x7fac087a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bad8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3c8b0>, '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 0x1c3d7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3dc60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1459174066.371837-1748513583', '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 09:48: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 09:48: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 blobuploader==1.2.4 09:48:50 INFO - Using env: {'DISPLAY': ':0', 09:48:50 INFO - 'HOME': '/home/cltbld', 09:48:50 INFO - 'LANG': 'en_US.UTF-8', 09:48:50 INFO - 'LANGUAGE': 'en_US:en', 09:48:50 INFO - 'LOGNAME': 'cltbld', 09:48:50 INFO - 'MAIL': '/var/mail/cltbld', 09:48:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:50 INFO - 'MOZ_NO_REMOTE': '1', 09:48:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:50 INFO - 'NO_EM_RESTART': '1', 09:48:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:48:50 INFO - 'PWD': '/builds/slave/test-pgo', 09:48:50 INFO - 'SHELL': '/bin/bash', 09:48:50 INFO - 'SHLVL': '1', 09:48:50 INFO - 'TERM': 'linux', 09:48:50 INFO - 'TMOUT': '86400', 09:48:50 INFO - 'USER': 'cltbld', 09:48:50 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1459174066.371837-1748513583', 09:48:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:50 INFO - '_': '/tools/buildbot/bin/python'} 09:48:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:50 INFO - Downloading/unpacking blobuploader==1.2.4 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48:52 INFO - Downloading blobuploader-1.2.4.tar.gz 09:48:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:48:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:48:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48:52 INFO - Downloading docopt-0.6.1.tar.gz 09:48:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:48:52 INFO - Installing collected packages: blobuploader, requests, docopt 09:48:52 INFO - Running setup.py install for blobuploader 09:48:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:48:53 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:48:53 INFO - Running setup.py install for requests 09:48:53 INFO - Running setup.py install for docopt 09:48:53 INFO - Successfully installed blobuploader requests docopt 09:48:53 INFO - Cleaning up... 09:48:53 INFO - Return code: 0 09:48:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:53 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 0x7fac087a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bad8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3c8b0>, '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 0x1c3d7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3dc60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1459174066.371837-1748513583', '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 09:48:53 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 09:48:53 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 09:48:53 INFO - Using env: {'DISPLAY': ':0', 09:48:53 INFO - 'HOME': '/home/cltbld', 09:48:53 INFO - 'LANG': 'en_US.UTF-8', 09:48:53 INFO - 'LANGUAGE': 'en_US:en', 09:48:53 INFO - 'LOGNAME': 'cltbld', 09:48:53 INFO - 'MAIL': '/var/mail/cltbld', 09:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:53 INFO - 'MOZ_NO_REMOTE': '1', 09:48:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:53 INFO - 'NO_EM_RESTART': '1', 09:48:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:48:53 INFO - 'PWD': '/builds/slave/test-pgo', 09:48:53 INFO - 'SHELL': '/bin/bash', 09:48:53 INFO - 'SHLVL': '1', 09:48:53 INFO - 'TERM': 'linux', 09:48:53 INFO - 'TMOUT': '86400', 09:48:53 INFO - 'USER': 'cltbld', 09:48:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1459174066.371837-1748513583', 09:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:53 INFO - '_': '/tools/buildbot/bin/python'} 09:48:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:48:53 INFO - Running setup.py (path:/tmp/pip-HyakVH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:48:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:48:53 INFO - Running setup.py (path:/tmp/pip-TcUvwW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:48:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:48:53 INFO - Running setup.py (path:/tmp/pip-uWsAUY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:48:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:48:53 INFO - Running setup.py (path:/tmp/pip-jD4S78-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:48:54 INFO - Running setup.py (path:/tmp/pip-Zkzgnc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:48:54 INFO - Running setup.py (path:/tmp/pip-HGKI6v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:48:54 INFO - Running setup.py (path:/tmp/pip-2GSnla-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:48:54 INFO - Running setup.py (path:/tmp/pip-7AkbPG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:48:54 INFO - Running setup.py (path:/tmp/pip-_qdkwp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:48:54 INFO - Running setup.py (path:/tmp/pip-pRJwd0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:48:54 INFO - Running setup.py (path:/tmp/pip-bg4IdS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:48:54 INFO - Running setup.py (path:/tmp/pip-TmppvB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:48:54 INFO - Running setup.py (path:/tmp/pip-hUKL90-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:48:54 INFO - Running setup.py (path:/tmp/pip-ogqbA7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:48:54 INFO - Running setup.py (path:/tmp/pip-XGhhas-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:48:54 INFO - Running setup.py (path:/tmp/pip-ipRbgd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:48:54 INFO - Running setup.py (path:/tmp/pip-e4afnU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:48:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:48:54 INFO - Running setup.py install for manifestparser 09:48:55 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:48:55 INFO - Running setup.py install for mozcrash 09:48:55 INFO - Running setup.py install for mozdebug 09:48:55 INFO - Running setup.py install for mozdevice 09:48:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:48:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:48:55 INFO - Running setup.py install for mozfile 09:48:55 INFO - Running setup.py install for mozhttpd 09:48:55 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:48:55 INFO - Running setup.py install for mozinfo 09:48:55 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:48:55 INFO - Running setup.py install for mozInstall 09:48:55 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:48:55 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:48:55 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:48:55 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:48:55 INFO - Running setup.py install for mozleak 09:48:55 INFO - Running setup.py install for mozlog 09:48:55 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:48:55 INFO - Running setup.py install for moznetwork 09:48:56 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:48:56 INFO - Running setup.py install for mozprocess 09:48:56 INFO - Running setup.py install for mozprofile 09:48:56 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:48:56 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:48:56 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:48:56 INFO - Running setup.py install for mozrunner 09:48:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:48:56 INFO - Running setup.py install for mozscreenshot 09:48:56 INFO - Running setup.py install for moztest 09:48:56 INFO - Running setup.py install for mozversion 09:48:56 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:48:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:48:56 INFO - Cleaning up... 09:48:56 INFO - Return code: 0 09:48:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:56 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 0x7fac087a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bad8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3c8b0>, '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 0x1c3d7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3dc60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1459174066.371837-1748513583', '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 09:48:56 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 09:48:56 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 09:48:56 INFO - Using env: {'DISPLAY': ':0', 09:48:56 INFO - 'HOME': '/home/cltbld', 09:48:56 INFO - 'LANG': 'en_US.UTF-8', 09:48:56 INFO - 'LANGUAGE': 'en_US:en', 09:48:56 INFO - 'LOGNAME': 'cltbld', 09:48:56 INFO - 'MAIL': '/var/mail/cltbld', 09:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:56 INFO - 'MOZ_NO_REMOTE': '1', 09:48:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:56 INFO - 'NO_EM_RESTART': '1', 09:48:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:48:56 INFO - 'PWD': '/builds/slave/test-pgo', 09:48:56 INFO - 'SHELL': '/bin/bash', 09:48:56 INFO - 'SHLVL': '1', 09:48:56 INFO - 'TERM': 'linux', 09:48:56 INFO - 'TMOUT': '86400', 09:48:56 INFO - 'USER': 'cltbld', 09:48:56 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1459174066.371837-1748513583', 09:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:56 INFO - '_': '/tools/buildbot/bin/python'} 09:48:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:48:56 INFO - Running setup.py (path:/tmp/pip-RqkVUU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:48:57 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)) 09:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:48:57 INFO - Running setup.py (path:/tmp/pip-SWpMc2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:48:57 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)) 09:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:48:57 INFO - Running setup.py (path:/tmp/pip-uCxQ1j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:48:57 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)) 09:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:48:57 INFO - Running setup.py (path:/tmp/pip-u47YKL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:48:57 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)) 09:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:48:57 INFO - Running setup.py (path:/tmp/pip-gLGdl8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:48:57 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)) 09:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:48:57 INFO - Running setup.py (path:/tmp/pip-oEFGaD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:48:57 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)) 09:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:48:57 INFO - Running setup.py (path:/tmp/pip-0cR5nu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:48:57 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)) 09:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:48:57 INFO - Running setup.py (path:/tmp/pip-zIsjqH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:48:57 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)) 09:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:48:57 INFO - Running setup.py (path:/tmp/pip-0bctGg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:48:57 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)) 09:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:48:57 INFO - Running setup.py (path:/tmp/pip-rbMhpt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:48:57 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)) 09:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:48:57 INFO - Running setup.py (path:/tmp/pip-59PVpv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:48:57 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)) 09:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:48:57 INFO - Running setup.py (path:/tmp/pip-3oBRO5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:48:57 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)) 09:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:48:57 INFO - Running setup.py (path:/tmp/pip-W7NnlH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:48:57 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)) 09:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:48:57 INFO - Running setup.py (path:/tmp/pip-heN6LI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:48:57 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)) 09:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:48:57 INFO - Running setup.py (path:/tmp/pip-x181YX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:48:58 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)) 09:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:48:58 INFO - Running setup.py (path:/tmp/pip-ZhjtSK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:48:58 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)) 09:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:48:58 INFO - Running setup.py (path:/tmp/pip-cD84AF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:48:58 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)) 09:48:58 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)) 09:48:58 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)) 09:48:58 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)) 09:48:58 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)) 09:48:58 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)) 09:48:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:48:58 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 09:48:58 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 09:48:58 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 09:48:58 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 09:48:58 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 09:48:58 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 09:49:00 INFO - Downloading blessings-1.6.tar.gz 09:49:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:49:00 INFO - Installing collected packages: blessings 09:49:00 INFO - Running setup.py install for blessings 09:49:00 INFO - Successfully installed blessings 09:49:00 INFO - Cleaning up... 09:49:00 INFO - Return code: 0 09:49:00 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:49:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:49:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:49:00 INFO - Reading from file tmpfile_stdout 09:49:00 INFO - Current package versions: 09:49:00 INFO - argparse == 1.2.1 09:49:00 INFO - blessings == 1.6 09:49:00 INFO - blobuploader == 1.2.4 09:49:00 INFO - docopt == 0.6.1 09:49:00 INFO - manifestparser == 1.1 09:49:00 INFO - mozInstall == 1.12 09:49:00 INFO - mozcrash == 0.17 09:49:00 INFO - mozdebug == 0.1 09:49:00 INFO - mozdevice == 0.48 09:49:00 INFO - mozfile == 1.2 09:49:00 INFO - mozhttpd == 0.7 09:49:00 INFO - mozinfo == 0.9 09:49:00 INFO - mozleak == 0.1 09:49:00 INFO - mozlog == 3.1 09:49:00 INFO - moznetwork == 0.27 09:49:00 INFO - mozprocess == 0.22 09:49:00 INFO - mozprofile == 0.28 09:49:00 INFO - mozrunner == 6.11 09:49:00 INFO - mozscreenshot == 0.1 09:49:00 INFO - mozsystemmonitor == 0.0 09:49:00 INFO - moztest == 0.7 09:49:00 INFO - mozversion == 1.4 09:49:00 INFO - psutil == 3.1.1 09:49:00 INFO - requests == 1.2.3 09:49:00 INFO - wsgiref == 0.1.2 09:49:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fac087a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bad8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3c8b0>, '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 0x1c3d7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3dc60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1459174066.371837-1748513583', '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 09:49:00 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 09:49:00 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 09:49:00 INFO - Using env: {'DISPLAY': ':0', 09:49:00 INFO - 'HOME': '/home/cltbld', 09:49:00 INFO - 'LANG': 'en_US.UTF-8', 09:49:00 INFO - 'LANGUAGE': 'en_US:en', 09:49:00 INFO - 'LOGNAME': 'cltbld', 09:49:00 INFO - 'MAIL': '/var/mail/cltbld', 09:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:00 INFO - 'MOZ_NO_REMOTE': '1', 09:49:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:00 INFO - 'NO_EM_RESTART': '1', 09:49:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:00 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:00 INFO - 'SHELL': '/bin/bash', 09:49:00 INFO - 'SHLVL': '1', 09:49:00 INFO - 'TERM': 'linux', 09:49:00 INFO - 'TMOUT': '86400', 09:49:00 INFO - 'USER': 'cltbld', 09:49:00 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1459174066.371837-1748513583', 09:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:00 INFO - '_': '/tools/buildbot/bin/python'} 09:49:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:00 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)) 09:49:00 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)) 09:49:00 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)) 09:49:00 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)) 09:49:00 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)) 09:49:00 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)) 09:49:00 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)) 09:49:00 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)) 09:49:00 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)) 09:49:00 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)) 09:49: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 mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 09:49:00 INFO - Cleaning up... 09:49:00 INFO - Return code: 0 09:49:00 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:00 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 0x7fac087a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bad8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3c8b0>, '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 0x1c3d7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3dc60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1459174066.371837-1748513583', '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 09:49:00 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 09:49:00 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 09:49:00 INFO - Using env: {'DISPLAY': ':0', 09:49:00 INFO - 'HOME': '/home/cltbld', 09:49:00 INFO - 'LANG': 'en_US.UTF-8', 09:49:00 INFO - 'LANGUAGE': 'en_US:en', 09:49:00 INFO - 'LOGNAME': 'cltbld', 09:49:00 INFO - 'MAIL': '/var/mail/cltbld', 09:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:00 INFO - 'MOZ_NO_REMOTE': '1', 09:49:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:00 INFO - 'NO_EM_RESTART': '1', 09:49:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:00 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:00 INFO - 'SHELL': '/bin/bash', 09:49:00 INFO - 'SHLVL': '1', 09:49:00 INFO - 'TERM': 'linux', 09:49:00 INFO - 'TMOUT': '86400', 09:49:00 INFO - 'USER': 'cltbld', 09:49:00 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1459174066.371837-1748513583', 09:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:00 INFO - '_': '/tools/buildbot/bin/python'} 09:49:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:00 INFO - Downloading/unpacking jsonschema 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:49:03 INFO - Downloading/unpacking functools32 (from jsonschema) 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49:03 INFO - Downloading functools32-3.2.3-2.tar.gz 09:49:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:49:03 INFO - warning: no files found matching '*.txt' 09:49:03 INFO - no previously-included directories found matching 'build' 09:49:03 INFO - no previously-included directories found matching 'dist' 09:49:03 INFO - no previously-included directories found matching '.git*' 09:49:03 INFO - Installing collected packages: jsonschema, functools32 09:49:03 INFO - Running setup.py install for functools32 09:49:03 INFO - warning: no files found matching '*.txt' 09:49:03 INFO - no previously-included directories found matching 'build' 09:49:03 INFO - no previously-included directories found matching 'dist' 09:49:03 INFO - no previously-included directories found matching '.git*' 09:49:03 INFO - Successfully installed jsonschema functools32 09:49:03 INFO - Cleaning up... 09:49:03 INFO - Return code: 0 09:49:03 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:49: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')]} 09:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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')]} 09:49:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac087a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bad8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3c8b0>, '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 0x1c3d7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3dc60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1459174066.371837-1748513583', '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 09:49: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', 'flake8'] in /builds/slave/test-pgo/build 09:49: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 flake8 09:49:03 INFO - Using env: {'DISPLAY': ':0', 09:49:03 INFO - 'HOME': '/home/cltbld', 09:49:03 INFO - 'LANG': 'en_US.UTF-8', 09:49:03 INFO - 'LANGUAGE': 'en_US:en', 09:49:03 INFO - 'LOGNAME': 'cltbld', 09:49:03 INFO - 'MAIL': '/var/mail/cltbld', 09:49:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:03 INFO - 'MOZ_NO_REMOTE': '1', 09:49:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:03 INFO - 'NO_EM_RESTART': '1', 09:49:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:03 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:03 INFO - 'SHELL': '/bin/bash', 09:49:03 INFO - 'SHLVL': '1', 09:49:03 INFO - 'TERM': 'linux', 09:49:03 INFO - 'TMOUT': '86400', 09:49:03 INFO - 'USER': 'cltbld', 09:49:03 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1459174066.371837-1748513583', 09:49:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:03 INFO - '_': '/tools/buildbot/bin/python'} 09:49:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:03 INFO - Downloading/unpacking flake8 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:49:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:49:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:49:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:49:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:49:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:49:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:49:06 INFO - no previously-included directories found matching 'docs/_build' 09:49:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:49:06 INFO - Running setup.py install for pep8 09:49:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:49:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:49:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:49:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:49:06 INFO - no previously-included directories found matching 'docs/_build' 09:49:06 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:49:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:49:06 INFO - Cleaning up... 09:49:06 INFO - Return code: 0 09:49:06 INFO - Running post-action listener: _resource_record_post_action 09:49:06 INFO - Running post-action listener: _start_resource_monitoring 09:49:06 INFO - Starting resource monitoring. 09:49:06 INFO - ##### 09:49:06 INFO - ##### Running install step. 09:49:06 INFO - ##### 09:49:06 INFO - Running pre-action listener: _resource_record_pre_action 09:49:06 INFO - Running main action method: install 09:49:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:49:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:49:06 INFO - Reading from file tmpfile_stdout 09:49:06 INFO - Detecting whether we're running mozinstall >=1.0... 09:49:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:49:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:49:06 INFO - Reading from file tmpfile_stdout 09:49:06 INFO - Output received: 09:49:06 INFO - Usage: mozinstall [options] installer 09:49:06 INFO - Options: 09:49:06 INFO - -h, --help show this help message and exit 09:49:06 INFO - -d DEST, --destination=DEST 09:49:06 INFO - Directory to install application into. [default: 09:49:06 INFO - "/builds/slave/test-pgo"] 09:49:06 INFO - --app=APP Application being installed. [default: firefox] 09:49:06 INFO - mkdir: /builds/slave/test-pgo/build/application 09:49:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 09:49:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 09:49:23 INFO - Reading from file tmpfile_stdout 09:49:23 INFO - Output received: 09:49:23 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:49:23 INFO - Running post-action listener: _resource_record_post_action 09:49:23 INFO - ##### 09:49:23 INFO - ##### Running run-tests step. 09:49:23 INFO - ##### 09:49:23 INFO - Running pre-action listener: _resource_record_pre_action 09:49:23 INFO - Running main action method: run_tests 09:49:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:49:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:49:23 INFO - Python 2.7.3 09:49:23 INFO - Return code: 0 09:49:23 INFO - grabbing minidump binary from tooltool 09:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:23 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 0x1c3c8b0>, '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 0x1c3d7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3dc60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:49:23 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 09:49:23 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 09:49:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:49:23 INFO - Return code: 0 09:49:23 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:49:23 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:49:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:49:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:49:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:49:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:49:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:49:24 INFO - Return code: 0 09:49:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 09:49:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 09:49:24 INFO - Using env: {'DISPLAY': ':0', 09:49:24 INFO - 'HOME': '/home/cltbld', 09:49:24 INFO - 'LANG': 'en_US.UTF-8', 09:49:24 INFO - 'LANGUAGE': 'en_US:en', 09:49:24 INFO - 'LOGNAME': 'cltbld', 09:49:24 INFO - 'MAIL': '/var/mail/cltbld', 09:49:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:49:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:49:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:24 INFO - 'MOZ_NO_REMOTE': '1', 09:49:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:49:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:24 INFO - 'NO_EM_RESTART': '1', 09:49:24 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:24 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:24 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:49:24 INFO - 'SHELL': '/bin/bash', 09:49:24 INFO - 'SHLVL': '1', 09:49:24 INFO - 'TERM': 'linux', 09:49:24 INFO - 'TMOUT': '86400', 09:49:24 INFO - 'USER': 'cltbld', 09:49:24 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1459174066.371837-1748513583', 09:49:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:24 INFO - '_': '/tools/buildbot/bin/python'} 09:49:24 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:49:24 INFO - mozversion application_buildid: 20160328073141 09:49:24 INFO - mozversion application_changeset: 073bbd96f75766ec2843bb905da2f7d1f0eaa0d2 09:49:24 INFO - mozversion application_display_name: Nightly 09:49:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:49:24 INFO - mozversion application_name: Firefox 09:49:24 INFO - mozversion application_remotingname: firefox 09:49:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:49:24 INFO - mozversion application_vendor: Mozilla 09:49:24 INFO - mozversion application_version: 48.0a1 09:49:24 INFO - mozversion platform_buildid: 20160328073141 09:49:24 INFO - mozversion platform_changeset: 073bbd96f75766ec2843bb905da2f7d1f0eaa0d2 09:49:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:49:24 INFO - mozversion platform_version: 48.0a1 09:49:24 INFO - using testdate: 1459183764 09:49:24 INFO - actual date: 1459183764 09:49:24 INFO - starting webserver on 'localhost:46389' 09:49:24 INFO - SUITE-START | Running 2 tests 09:49:24 INFO - TEST-START | dromaeo_css 09:49:24 INFO - operating with platform_type : linux_ 09:49:24 INFO - Initialising browser for dromaeo_css test... 09:49:24 INFO - TEST-INFO | started process 20914 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppK2XfT/profile http://localhost:46389/getInfo.html) 09:49:28 INFO - PROCESS | 20914 | __metrics Screen width/height:1600/1200 09:49:28 INFO - PROCESS | 20914 | colorDepth:24 09:49:28 INFO - PROCESS | 20914 | Browser inner width/height: 1024/697 09:49:28 INFO - PROCESS | 20914 | __metrics 09:49:28 ERROR - PROCESS | 20914 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:49:29 INFO - PROCESS | 20914 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 09:49:29 INFO - TEST-INFO | 20914: exit 0 09:49:29 INFO - Browser initialized. 09:49:29 INFO - Running cycle 1/1 for dromaeo_css test... 09:49:29 INFO - TEST-INFO | started process 21007 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppK2XfT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:49:41 INFO - PROCESS | 21007 | RSS: Main: 153436160 09:49:41 INFO - PROCESS | 21007 | 09:50:32 INFO - PROCESS | 21007 | 1459183832263 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] 09:52:39 INFO - PROCESS | 21007 | Cycle 1(1): loaded http://localhost:46389/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46389/tests/dromaeo/cssquery-ext.html) 09:52:40 INFO - PROCESS | 21007 | RSS: Main: 252674048 09:52:40 INFO - PROCESS | 21007 | 09:55:42 INFO - PROCESS | 21007 | Cycle 1(1): loaded http://localhost:46389/tests/dromaeo/cssquery-ext.html (next: http://localhost:46389/tests/dromaeo/cssquery-jquery.html) 09:55:43 INFO - PROCESS | 21007 | RSS: Main: 239161344 09:55:43 INFO - PROCESS | 21007 | 09:58:45 INFO - PROCESS | 21007 | Cycle 1(1): loaded http://localhost:46389/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46389/tests/dromaeo/cssquery-mootools.html) 09:58:45 INFO - PROCESS | 21007 | RSS: Main: 242913280 09:58:45 INFO - PROCESS | 21007 | 10:01:47 INFO - PROCESS | 21007 | Cycle 1(1): loaded http://localhost:46389/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46389/tests/dromaeo/cssquery-prototype.html) 10:01:48 INFO - PROCESS | 21007 | RSS: Main: 219234304 10:01:48 INFO - PROCESS | 21007 | 10:04:50 INFO - PROCESS | 21007 | Cycle 1(1): loaded http://localhost:46389/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46389/tests/dromaeo/cssquery-yui.html) 10:04:51 INFO - PROCESS | 21007 | RSS: Main: 219709440 10:04:51 INFO - PROCESS | 21007 | 10:07:53 INFO - PROCESS | 21007 | Cycle 1(1): loaded http://localhost:46389/tests/dromaeo/cssquery-yui.html (next: http://localhost:46389/tests/dromaeo/cssquery-dojo.html) 10:07:53 INFO - PROCESS | 21007 | RSS: Main: 270041088 10:07:53 INFO - PROCESS | 21007 | 10:07:53 INFO - PROCESS | 21007 | __start_tp_report 10:07:53 INFO - PROCESS | 21007 | _x_x_mozilla_page_load 10:07:53 INFO - PROCESS | 21007 | _x_x_mozilla_page_load_details 10:07:53 INFO - PROCESS | 21007 | |i|pagename|runs| 10:07:53 INFO - PROCESS | 21007 | |0;dojo.html;3133.780635355525;3173.8571764270605;3212.7108560229576;3212.8393580320994;3244.237604163022;5177.4045984711765;5291.2327712481665;5360.24956506089;5380.192971054339;5470.2615146955195;5333.066713325172;5353.839384818452;5356.3572371315395;5368.516833484986;5379.919301210485;4726.432828060638;4774.9045019099685;4852.975735121319;4863.975680121612;4900.681455705386;4701.412323459567;4834.709917404949;4865.586425153866;4882.707037577739;4900.436449808264;4763.476017638057;4823.372961515016;4850.466448690677;4869.050535145648;4889.975550122244;4830.347903033081;4842.685225460334;4853.053654537367;4854.17479028566;4885.828995985159;4766.213574760161;4797.832075877328;4840.540148685869;4842.055799119174;4873.610111191097;5280.656757310762;5290.418054014094;5294.047071527124;5303.787848486056;5318.760655770461;5703.600747947646;5724.427557244284;5726.427357264281;5728.140778883159;5731.369549349568;5609.354924183689;5700.429957004308;5735.942640573582;5753.510951569122;5759.539236861041;5406.053940560386;5406.297181366476;5407.215953686693;5407.405185429599;5407.945920540784;5855.648661080264;5871.970640146772;5872.383399743051;5873.676947767914;5875.148103525051;5497.312835895513;5519.751611177507;5566.970110529565;5605.075162598126;5625.859353516113;5628.409017053233;5640.576956728261;5645.520130788929;5645.576581756384;5647;5629.437056294338;5630.40880707528;5632.52123569493;5635.464630860061;5644.491995720323;5459.972700136554;5682.232898558725;5741.971290143606;5744.224529688522;5792.391798861059;4285.935710964338;4287.185434767384;4287.828486860553;4288.871333859989;4314.956850431518;3801.676857467091;3825.3305671507933;3844.5490850568854;3885.300645883768;3890.0469385000856;5294.364676238799;5328.333958255218;5337.119375303031;5375.354957405137;5386.542143917811;5682.801101961411;5720.742566584514;5746.224259724967;5749.13762935563;5750.856228594319;5151.768170432265;5284.682919024794;5343;5391.649542779707;5433.646812957224;4851.029794041206;4877.902441951142;4879.048585525859;4906.0433215522635;4914.041761856475;5789.073748200268;5813.418658134237;5818.418158184148;5818.679972601463;5875.089361149029;5550.222968784293;5635.633683810704;5653.3781284057895;5672.2058911751565;5713.085906254979;5815.127730840408;5816.941830581809;5829.213056237523;5842;5866.67733274674;5555.833325000256;5560.694161821139;5578.2748242728185;5580.330360356783;5588.050031494737;5536.446355364593;5602.803901863415;5646.06839871433;5656.632318899258;5671.971640141773;5521.944780552143;5548.639338442988;5549.500544950974;5556.083246264321;5605.747741351731;5443.4284400138995;5484.835454936198;5492.752826122754;5496.31296087989;5498.5876059296515;5336.919946200887;5441;5451.454854514517;5471.425500322409;5518.91721624184;5494.36814766291;5524.4199359068325;5530.446955304437;5538.501534861882;5572.721363931868;5429.158480435539;5429.945700543102;5431.864203394946;5431.972840135774;5445.482679145475 10:07:53 INFO - PROCESS | 21007 | |1;ext.html;550.0997173886333;562.836777334573;572.2274928846058;575.7380391921674;592.6740292838939;29577.40845183095;29901;29910.700892991063;30055.098347049596;38246;42036.57963420365;42493;42531.36202956958;42550.78724606372;42666.57333426665;8698.260647844925;8900.821983560325;8905.020447750741;8913.821723565525;8924.643014279454;8725;8824.073472285414;8844.867326990101;8846.867296990551;8852;8861.955690221539;8949.194572488475;8949.865752013726;8957.865632015524;9126.726198214064;8991.550422478882;9083.81832363349;9099.226565741887;9100.453972761588;9104.817903641922;8929.955350223272;9049.321300902458;9054.230390416822;9056.094390560957;9059.773505662346;41423.1715365691;41559.58440415618;41575.79212103951;41715;41798;1762.9118544072744;3436.518887355772;3574.6425357464304;3624.039629498185;4096.897577560555;31641;31788;32156;32210;32219.194520137185;4319.740815551046;4324.286492728727;4327.935080973788;4444.333349997494;4460.754658493782;338845;341565;343683;345018;345797.27101364586;54863;62938.68530657318;63126.368736312965;63514.36485635177;63537.36462635407;69341;69716.30283697098;70078;70458.64770676114;70517.29482705107;16517.504474865775;16712.164391780363;16744.91627541879;16746.83253167453;16756.832431675528;11908.702282443008;12139.332336721565;12509.437075331633;12620.873791262153;12627.11610187278;20893.791062089487;21191.364259072252;21200.893995530234;21290.148394064374;21375;6895.827709289433;7112.6443677815905;7185.784426467214;7218.242084581148;7365.189829118793;973.1533565797802;1096.9304927695594;1105.3478447715886;1188.9346085965183;1230.9199902006342;32228.35543289121;32474;33175;33207.3358532828;33310.83344583261;1027.1577306608658;1052.5263631365915;1085.6742977106837;1097.7145942054963;1101.6694991502518;16548.917255413646;16946.322147114224;17023.574410639834;17046.403375881786;17205.655886882192;411090;411680;416419;416930;418067;58006;58292.417075829544;58417.41582584205;58434;58456.4154358451;1303.2831942431624;1340.5107135895328;1363.3319673360181;1410.3935307817533;1433.5412667946157;29559.704402955696;32059;33045.83477082599;33400;33761.493577595866;41611;41857.581424185366;41905;41970.790146049076;42019.58794326552;262693;265255;265328;265353;265913;35545.64454355527;37008.444873326385;37070;37121.6287837129;37152.25695486021;45609.54390456053;45960;46561.87819339802;46577;46832.53167468282;38851.417228741026;39239.07609239053;39564;39706.80146599249;40144;37608.623913760515;37875.621243788315;38967.6103238964;39183.2163356737;39580.80209598933;40030.799846000584;40294.59705402909;40431.1913761729;41302.1739565201;41343;33283.66716332806;34077.48883766696;34089.82955085209;34668.47997280093;34876.65123348734;24595.631065533675;25032.117258996695;27591;27917.581236281065;27936.797356152103 10:07:53 INFO - PROCESS | 21007 | |2;jquery.html;361.9059044648391;363.6708778555408;368.43445311446936;369.0920335973505;376.1311370733604;17176.570585735346;18047.909760451195;19507.804921950777;19668;19703.50741231468;18003.90998045008;18520.722189167172;18707.90646046768;18713;18730.62538749224;5400.621956463049;5614.29821272341;5641.52047075997;5653.886922261552;5659.547236221113;4020.8793736187963;5535.474129957647;5948.256467941507;6186.072089186613;6219.657918814463;6112;6147.047207682816;6171.537134714892;6174.8147555573405;6179.876402471948;5798.884022319551;6142.201513803222;6144.692765361714;6145.938540614581;6154;3628.074840915576;5225.242339860699;5388.784448622089;5433.293671822677;5441.483059109379;21409.78590214109;21552.89223553888;21653;21971.780282197295;22099.226527071634;2295.1966811615966;2565.3586603349163;2633.499635069331;2636.446346267286;3121.750259979196;13487.865121348857;13689.726205475934;13789;14033.508827190999;14083.577492675133;1885.4060970794155;1924.8652594318403;1940.1754254441805;1950.0737149853705;2070.513429344103;65959;67237;68776.65611671959;68947.65526172337;69567.30432695658;9615.423074615546;9667.226621870233;9818.901810981799;10052.195824334036;10100.646477373404;13469.663258418617;13533.593992180251;13556.322183890767;13588.59234222975;13588.728225435634;7995.920040799518;8051;8076.55578943152;8096.473729207582;8111.432199746079;8014.519128852287;8043.919560804434;8108;8166.305864001508;8237.50574965504;6001.3098493672915;6064.659087506391;6132.724027418777;6161.476274516716;6162.630242185483;1636.2636813433764;1717.7595136680875;1746.8602511799027;1792.103948025987;1803.125484140191;977.6236149082655;1037.8287582548946;1125.3023125662141;1146.1232157399595;1170.607846371458;16811.243494042796;17099.059551724527;17374.565635859206;18608.44174674762;19017.33439329617;1054.0776820282254;1083.7778255457613;1088.357868857362;1088.472091035847;1101.6529793115144;10559.841602375971;10910.454477276104;10937.4531273436;10972.945135274433;11047.613333533287;460087;477196;479994;483938;494116;53269.93460130776;68508.6574567124;69533.65233173902;72148.63925680338;72644;1061.1139698351808;1072;1077.6336045744486;1080.0981180714034;1084.788466249074;16421.91789041095;16509.257083431035;16532.586685332964;16606.584835379213;16624;32007;32948.83525582357;33829;34342.313153736286;34569.82715086408;44622;46749.53250467452;46804;47000;47008;8017.759467215993;8098.959505202436;8162.10216876155;8272.04871439768;8431.494110353398;8444.704435344733;13024.739505210033;13046.478140874258;13120.934395328344;13277.468901243841;10396.324238924446;10504;10742.355458672504;10895.346279223271;10988.120950323795;7960.681572737026;11622.593209237637;11652.883471165518;11690.70773230676;11871.287722736663;11629.941850290694;11900.702482438008;11901.82147267809;11932.403379830801;12142.575009874612;8322.08457069734;8358.247757701836;8371.874421883798;8377.49735015901;8377.83244335122;11824.138997217084;11829;11855.466504007169;11905.880941190477;12076 10:07:53 INFO - PROCESS | 21007 | |3;mootools.html;1258.7230809221967;1439.7912302716106;1451.7749748788935;1647.308130585154;1858.0895361272972;7696.422768292379;7917;7918.881216781746;7920.089189743181;7923.168067352932;7912.485688430248;8130.959345203266;8135.511869287847;8145.226203510657;8150.75547733569;2022.6055919095782;2293.9770602294016;2343.027643527934;2346.7887890089887;2358.646203069536;2362.3857796972825;2366.4557151855083;2372.122314743547;2376.370261880603;2379.1078345620394;2219.4340443186966;2275.7724227577273;2276.1350686739015;2286.9542609147807;2286.9771302287013;2312.560613483441;2338.8479748816358;2373.133806160756;2374.82188835838;2377.084822343393;2345.1674655497395;2348.823838212141;2356.988215058931;2357.858528488296;2359.2332491940188;8204.83590328196;8291.502509849428;8293.33653307734;8296.294814940737;8296.917030829734;5054.772535235923;5199.584033277329;5210.973945130288;5212.139996900545;5213.244079608436;3275.164832967578;3347.6652334766327;3404.914877128067;3447.844846981867;3470.583529976394;1083.7778255457613;1122.550979608155;1142.2917790969568;1143.8856114388577;1161.2335858333545;11619.6514104577;11679;11686.76626467466;11701.473433695504;11749.29504229749;4443.311286750494;4457.866264012085;4540.954590454053;4574.519675434098;4578.771061446914;9780.119789219005;9862.852057219148;9866.703998880044;9884.209263258923;9887.456189909624;4561.908761824745;5134.589232861362;5145.176771716508;5163.302954101224;5171.663841850268;4543.568361005699;4586.4266966629175;4617.815287388534;4632.698874573142;4643.210654188796;3847.5382954045135;3917.275304068756;3952.644262016375;3982.163745613396;3983.780892050965;1218.7075101975463;1268.1440027981075;1269.7397033608088;1274.5539061328461;1278.5908509276942;1400.5868268860506;1411.5553600615774;1429.0425414971994;1429.942802287897;1452.6005348529238;8030.07654119772;8066.878996815052;8108.716194933149;8117.472364296302;8117.79705507367;452.9637628989673;455.64687367290617;457.53560136461516;462.3180808307719;465.20450030447637;6049.304330002018;6057.727402266909;6060.484858787053;6100.23747031621;6122.142899994004;9683.806323873623;10237.436940968319;10291.639792607373;10296.742581435525;10337.276390652582;9982.201423886072;10049.24630652704;10150.796984060426;10179.03299186576;10218.642347517802;7627.809304767315;7963.84072318562;8007.159248278964;8018.438709290411;8020.879686804703;7617.69529218825;7641.961790191013;7653.387728981779;7686.615669216405;7794.493357931717;8965.282777377925;9105.317101217302;9215.907840921773;9284.907150928675;9345.859812102688;8630.741077767425;8800.603972821367;9352.158305752242;9512.524373781145;9523.57143928511;6740.2248741393405;7142.142942846892;7303.342699157101;7385.852282954418;7516;7928.801779955316;7938.245866642891;7943;7950.960245198969;7957.124716281089;7099.716011359487;7228.855422891618;7306.488545801955;7376.4836461447185;7415.073115860518;6951.270116637883;6986.895196571953;7095.3968912643;7159.60622165765;7299.781006569811;7208.315210055036;7234.312740289664;7248.383887369632;7253.419726421979;7259.9274007259255;6718.596884186964;6766.966165169143;6767;6775.864482710417;6790.966045169743;6804.353586409283;6911.75808846688;6968.721251149897;7003.824904377431;7004.0544526488275 10:07:53 INFO - PROCESS | 21007 | |4;prototype.html;321.3027729826277;321.88894831283204;322.65153634075193;330.5306464819955;335.7045799696268;6054.152418661385;6119.602225855317;6130.662813545253;6140.570160088796;6174.969125154379;6027.75888964442;6040.818775436733;6062.42406971337;6062.514998800097;6069.271687397519;4360.454943132108;4503.639708823286;4550.294704320819;4614.630829533629;4676.3920690310215;4589.990202155521;4597.402337696095;4602.539746025404;4602.884927876797;4608.640451066926;4516.683832131752;4521.683482156251;4524.954750452503;4569.063342014879;4571.61141302988;4378.737275763448;4457.442819647544;4551.5676010778925;4568.725876447424;4593.402857628487;3999.900002499932;4002.7398219115667;4013.237484877864;4017.196560687874;4017.4576432181575;5785.47930686236;5788.97105514474;5796.971015144897;5804.187413762034;5806.680632565207;5297.337832770903;5301.655392399482;5318.069337865897;5319.946800532022;5324.387695414999;6316.62100273985;6353.8411539711415;6358.109864618957;6358.936410635881;6366.331535188785;4347.152305300468;4438.023634800339;4439.977800110979;4444.288913773813;4450.46594408673;6546.214454265519;6572.14562106923;6629.0387893755615;6640.302768209317;6641.070250164981;4520.050789334211;4521.977390113028;4524.2082635538645;4528.909421811545;4531.546845315442;4569.885752856138;4578.519255478193;4584.014436896016;4586.541345865387;4588.931166032446;5290.523852853262;5293.020791153649;5302.70835104073;5308.548773354231;5314.548263397654;6251.093241642658;6366.395192456709;6380.3619638035825;6398.392152745481;6420.486361091102;1613.4191690991233;1627.967440651204;1635.4521235386278;1640.4996476074673;1644.8190699023098;976.1897624971257;1058.4496062047692;1059.427908929185;1062.792755412687;1092.6285063078592;5914.142449344821;5951.5238780897425;5956.195913551615;5962.284525856925;5971.641701497924;6379.936200637934;6492;6513.576617519846;6517.771877984248;6522.804315870531;6053.606515576474;6061.969690151521;6070.453659170696;6071.483923866521;6072.726727297282;3487.215376540309;3517.419625761772;3523.295340931824;3525.876594319238;3528.1653540159487;6538.738450461929;6699.095622091053;6706.798796036127;6726.3946244837225;6733.158355205599;6609.867802644017;6612.404883560503;6644.435223006002;6644.800655980328;6652.567583107082;6683.4987375947;6684.4318232950745;6685.130932978682;6701.061851340816;6704.430123439464;6478.481721462366;6491.156149700509;6492.805215843532;6503.934960650333;6504.414602685781;6297.874042519215;6431.678416079084;6440.130582371507;6458.61248325102;6467.288598254282;6657.53397262187;6671.166104236971;6675.699593518206;6677.966610166918;6678.866422671616;4571.6799824012;4571.954280457153;4573.588377046081;4579;4579.931301030554;6466.32103629131;6478.352164783484;6486.513511486563;6490.48076153916;6491.123698300669;6197.628142311476;6305.779297724557;6316.431521163117;6322.3045464997895;6336.588121772254;6280.183576135073;6293.276273228637;6294.527910406646;6298;6304.401081897213;6141.938580614136;6159.199304090619;6165.5375846810775;6167.938320616737;6192.349803270592;6307.653079080695;6316.526260530387;6325.841853953504;6340.397662222082;6348.904766428415;5988.550858685703;6175.505959523317;6206.503479721701;6214.751409943552;6215.720292586935 10:07:53 INFO - PROCESS | 21007 | |5;yui.html;785.760343095356;860.393422637041;867.0895559662353;878.8549889268266;886.849235629943;14232.43070277189;14437.927810360947;14644.707105857877;14790.260486975634;16445.25996330165;15245.618859528517;15428.305726242317;15481.69036619267;15489;15506.922465387686;666.2305037681485;824.1017291152642;831.0567505880808;842.6166094427051;849.2144766091371;831.9251267385933;836.6778790165799;836.861917783565;839.0518713853337;839.3998291221775;883.483162350026;889.1153302464057;889.9110088991114;889.977750556238;890.7327801659509;690.6788343420309;859.1966511311944;873.5239294584467;877.3814460805149;878.6968495868915;645.4965127200791;645.7513857164978;646.056757134584;647.4464332995316;648.6367634124905;14168.220747858864;14181.220032898187;14224.644383890382;14243.501477448239;14251.501197458143;11936.462859171359;12268.938655306756;12367.675822562398;12805.23168609877;12858.292793896331;10877.945610271978;10960.246360582349;10982.450877456095;11055.11559075272;11312.981831635192;3789.696824254053;3811.714121440903;3811.9809400953095;3855.8843234703004;3870.283997460451;55822;56086.15870761942;56144.43855561433;56353.154702679494;56981.71509142428;10395.324303920372;10612.985416439487;10692.251542392114;10693;10729.678109656723;19002.42992710221;19015.1443185057;19094.71357929632;19095.331663391993;19127.426177214707;8319.084900660922;8463;8502.65989360431;8532.488050716976;8710.82578348442;4838.854834354905;4968.105740966588;4976.701397916137;4978.651494395358;4981.178105612534;3349.1627093226693;3412.6246112927556;3529.1177205698577;3571.6606922342335;3580.606133325332;648.7405037984844;650.8242774450872;653.7515744017243;656.9146011018632;657.9210494740662;649.8919342520991;704.4857254204358;708.189123453653;718.6776331549974;727.450774665135;8370.455920365157;8531.786705332417;8585;8587;8719.171678690514;610.3286384976491;643.201715204579;674.6727836999052;678.3352314731492;703.697410113656;3997.420374045805;4218.704690671623;4228.682848786292;4290.099079193342;4293.849715259951;64842;66031;66479.66760166168;66679.66660166669;66782.66608666925;56381.7180914101;57040;57541;58158.7092064537;58561.4143858556;51126.48873511217;51180.48819511757;51681;52562;52766.47233527692;8126.634301456331;8380.12008739098;8399.874001890099;8453.154684531497;8479.279261262862;39482.2103557933;39767.602323977546;40132.398014029226;40961.38557921574;41154;46853.2972005427;50803.23795143002;51302.230466542285;51338;51567.48432515777;9935.145028448871;10221.540030698488;10431.68704938853;10463.110635595755;10471;11831.954827421514;11978.940105299418;12055.51777928873;12114.454849531616;12506.37468126572;10892.61875834342;10958.45207739594;10992.446987010166;11222.989930906258;11760.647180584596;10926.726831829268;11041.503132358903;11054.613088542184;11138.37021640179;11219.943900280447;11071.834051392852;11110.500027498943;11315.321080734853;11441.313521188755;11625.476853541442;9163.496007719372;9191.586378612845;9342.906570934476;9429.52852357393;9457.574409151743;9297.116773906468;9862.309638325249;9886.209103271865;9934.602615895283;9945.104940555384 10:07:53 INFO - PROCESS | 21007 | __end_tp_report 10:07:53 INFO - PROCESS | 21007 | __start_cc_report 10:07:53 INFO - PROCESS | 21007 | _x_x_mozilla_cycle_collect,782 10:07:53 INFO - PROCESS | 21007 | __end_cc_report 10:07:53 INFO - PROCESS | 21007 | __startTimestamp1459184873740__endTimestamp 10:07:53 INFO - PROCESS | 21007 | 10:07:53 INFO - PROCESS | 21007 | ------- Summary: start ------- 10:07:53 INFO - PROCESS | 21007 | Number of tests: 6 10:07:53 INFO - PROCESS | 21007 | 10:07:53 INFO - PROCESS | 21007 | [#0] dojo.html Cycles:165 Average:5271.78 Median:5451.45 stddev:584.63 (10.7%) stddev-sans-first:561.85 10:07:53 INFO - PROCESS | 21007 | Values: 3133.8 3173.9 3212.7 3212.8 3244.2 5177.4 5291.2 5360.2 5380.2 5470.3 5333.1 5353.8 5356.4 5368.5 5379.9 4726.4 4774.9 4853.0 4864.0 4900.7 4701.4 4834.7 4865.6 4882.7 4900.4 4763.5 4823.4 4850.5 4869.1 4890.0 4830.3 4842.7 4853.1 4854.2 4885.8 4766.2 4797.8 4840.5 4842.1 4873.6 5280.7 5290.4 5294.0 5303.8 5318.8 5703.6 5724.4 5726.4 5728.1 5731.4 5609.4 5700.4 5735.9 5753.5 5759.5 5406.1 5406.3 5407.2 5407.4 5407.9 5855.6 5872.0 5872.4 5873.7 5875.1 5497.3 5519.8 5567.0 5605.1 5625.9 5628.4 5640.6 5645.5 5645.6 5647.0 5629.4 5630.4 5632.5 5635.5 5644.5 5460.0 5682.2 5742.0 5744.2 5792.4 4285.9 4287.2 4287.8 4288.9 4315.0 3801.7 3825.3 3844.5 3885.3 3890.0 5294.4 5328.3 5337.1 5375.4 5386.5 5682.8 5720.7 5746.2 5749.1 5750.9 5151.8 5284.7 5343.0 5391.6 5433.6 4851.0 4877.9 4879.0 4906.0 4914.0 5789.1 5813.4 5818.4 5818.7 5875.1 5550.2 5635.6 5653.4 5672.2 5713.1 5815.1 5816.9 5829.2 5842.0 5866.7 5555.8 5560.7 5578.3 5580.3 5588.1 5536.4 5602.8 5646.1 5656.6 5672.0 5521.9 5548.6 5549.5 5556.1 5605.7 5443.4 5484.8 5492.8 5496.3 5498.6 5336.9 5441.0 5451.5 5471.4 5518.9 5494.4 5524.4 5530.4 5538.5 5572.7 5429.2 5429.9 5431.9 5432.0 5445.5 10:07:53 INFO - PROCESS | 21007 | 10:07:53 INFO - PROCESS | 21007 | [#1] ext.html Cycles:180 Average:51695.75 Median:39643.80 stddev:91084.82 (229.8%) stddev-sans-first:91259.39 10:07:53 INFO - PROCESS | 21007 | Values: 550.1 562.8 572.2 575.7 592.7 29577.4 29901.0 29910.7 30055.1 38246.0 42036.6 42493.0 42531.4 42550.8 42666.6 8698.3 8900.8 8905.0 8913.8 8924.6 8725.0 8824.1 8844.9 8846.9 8852.0 8862.0 8949.2 8949.9 8957.9 9126.7 8991.6 9083.8 9099.2 9100.5 9104.8 8930.0 9049.3 9054.2 9056.1 9059.8 41423.2 41559.6 41575.8 41715.0 41798.0 1762.9 3436.5 3574.6 3624.0 4096.9 31641.0 31788.0 32156.0 32210.0 32219.2 4319.7 4324.3 4327.9 4444.3 4460.8 338845.0 341565.0 343683.0 345018.0 345797.3 54863.0 62938.7 63126.4 63514.4 63537.4 69341.0 69716.3 70078.0 70458.6 70517.3 16517.5 16712.2 16744.9 16746.8 16756.8 11908.7 12139.3 12509.4 12620.9 12627.1 20893.8 21191.4 21200.9 21290.1 21375.0 6895.8 7112.6 7185.8 7218.2 7365.2 973.2 1096.9 1105.3 1188.9 1230.9 32228.4 32474.0 33175.0 33207.3 33310.8 1027.2 1052.5 1085.7 1097.7 1101.7 16548.9 16946.3 17023.6 17046.4 17205.7 411090.0 411680.0 416419.0 416930.0 418067.0 58006.0 58292.4 58417.4 58434.0 58456.4 1303.3 1340.5 1363.3 1410.4 1433.5 29559.7 32059.0 33045.8 33400.0 33761.5 41611.0 41857.6 41905.0 41970.8 42019.6 262693.0 265255.0 265328.0 265353.0 265913.0 35545.6 37008.4 37070.0 37121.6 37152.3 45609.5 45960.0 46561.9 46577.0 46832.5 38851.4 39239.1 39564.0 39706.8 40144.0 37608.6 37875.6 38967.6 39183.2 39580.8 40030.8 40294.6 40431.2 41302.2 41343.0 33283.7 34077.5 34089.8 34668.5 34876.7 24595.6 25032.1 27591.0 27917.6 27936.8 10:07:53 INFO - PROCESS | 21007 | 10:07:53 INFO - PROCESS | 21007 | [#2] jquery.html Cycles:180 Average:26965.59 Median:2599.43 stddev:78294.11 (3012.0%) stddev-sans-first:78488.26 10:07:53 INFO - PROCESS | 21007 | Values: 361.9 363.7 368.4 369.1 376.1 17176.6 18047.9 19507.8 19668.0 19703.5 18003.9 18520.7 18707.9 18713.0 18730.6 5400.6 5614.3 5641.5 5653.9 5659.5 4020.9 5535.5 5948.3 6186.1 6219.7 6112.0 6147.0 6171.5 6174.8 6179.9 5798.9 6142.2 6144.7 6145.9 6154.0 3628.1 5225.2 5388.8 5433.3 5441.5 21409.8 21552.9 21653.0 21971.8 22099.2 2295.2 2565.4 2633.5 2636.4 3121.8 13487.9 13689.7 13789.0 14033.5 14083.6 1885.4 1924.9 1940.2 1950.1 2070.5 65959.0 67237.0 68776.7 68947.7 69567.3 9615.4 9667.2 9818.9 10052.2 10100.6 13469.7 13533.6 13556.3 13588.6 13588.7 7995.9 8051.0 8076.6 8096.5 8111.4 8014.5 8043.9 8108.0 8166.3 8237.5 6001.3 6064.7 6132.7 6161.5 6162.6 1636.3 1717.8 1746.9 1792.1 1803.1 977.6 1037.8 1125.3 1146.1 1170.6 16811.2 17099.1 17374.6 18608.4 19017.3 1054.1 1083.8 1088.4 1088.5 1101.7 10559.8 10910.5 10937.5 10972.9 11047.6 460087.0 477196.0 479994.0 483938.0 494116.0 53269.9 68508.7 69533.7 72148.6 72644.0 1061.1 1072.0 1077.6 1080.1 1084.8 16421.9 16509.3 16532.6 16606.6 16624.0 32007.0 32948.8 33829.0 34342.3 34569.8 44622.0 46749.5 46804.0 47000.0 47008.0 8017.8 8099.0 8162.1 8272.0 8431.5 8444.7 13024.7 13046.5 13120.9 13277.5 10396.3 10504.0 10742.4 10895.3 10988.1 7960.7 11622.6 11652.9 11690.7 11871.3 11629.9 11900.7 11901.8 11932.4 12142.6 8322.1 8358.2 8371.9 8377.5 8377.8 11824.1 11829.0 11855.5 11905.9 12076.0 10:07:53 INFO - PROCESS | 21007 | 10:07:53 INFO - PROCESS | 21007 | [#3] mootools.html Cycles:180 Average:5799.35 Median:5211.56 stddev:3072.72 (59.0%) stddev-sans-first:3062.38 10:07:53 INFO - PROCESS | 21007 | Values: 1258.7 1439.8 1451.8 1647.3 1858.1 7696.4 7917.0 7918.9 7920.1 7923.2 7912.5 8131.0 8135.5 8145.2 8150.8 2022.6 2294.0 2343.0 2346.8 2358.6 2362.4 2366.5 2372.1 2376.4 2379.1 2219.4 2275.8 2276.1 2287.0 2287.0 2312.6 2338.8 2373.1 2374.8 2377.1 2345.2 2348.8 2357.0 2357.9 2359.2 8204.8 8291.5 8293.3 8296.3 8296.9 5054.8 5199.6 5211.0 5212.1 5213.2 3275.2 3347.7 3404.9 3447.8 3470.6 1083.8 1122.6 1142.3 1143.9 1161.2 11619.7 11679.0 11686.8 11701.5 11749.3 4443.3 4457.9 4541.0 4574.5 4578.8 9780.1 9862.9 9866.7 9884.2 9887.5 4561.9 5134.6 5145.2 5163.3 5171.7 4543.6 4586.4 4617.8 4632.7 4643.2 3847.5 3917.3 3952.6 3982.2 3983.8 1218.7 1268.1 1269.7 1274.6 1278.6 1400.6 1411.6 1429.0 1429.9 1452.6 8030.1 8066.9 8108.7 8117.5 8117.8 453.0 455.6 457.5 462.3 465.2 6049.3 6057.7 6060.5 6100.2 6122.1 9683.8 10237.4 10291.6 10296.7 10337.3 9982.2 10049.2 10150.8 10179.0 10218.6 7627.8 7963.8 8007.2 8018.4 8020.9 7617.7 7642.0 7653.4 7686.6 7794.5 8965.3 9105.3 9215.9 9284.9 9345.9 8630.7 8800.6 9352.2 9512.5 9523.6 6740.2 7142.1 7303.3 7385.9 7516.0 7928.8 7938.2 7943.0 7951.0 7957.1 7099.7 7228.9 7306.5 7376.5 7415.1 6951.3 6986.9 7095.4 7159.6 7299.8 7208.3 7234.3 7248.4 7253.4 7259.9 6718.6 6767.0 6767.0 6775.9 6791.0 6804.4 6911.8 6968.7 7003.8 7004.1 10:07:53 INFO - PROCESS | 21007 | 10:07:53 INFO - PROCESS | 21007 | [#4] prototype.html Cycles:180 Average:5293.33 Median:6062.47 stddev:1583.57 (26.1%) stddev-sans-first:1543.41 10:07:53 INFO - PROCESS | 21007 | Values: 321.3 321.9 322.7 330.5 335.7 6054.2 6119.6 6130.7 6140.6 6175.0 6027.8 6040.8 6062.4 6062.5 6069.3 4360.5 4503.6 4550.3 4614.6 4676.4 4590.0 4597.4 4602.5 4602.9 4608.6 4516.7 4521.7 4525.0 4569.1 4571.6 4378.7 4457.4 4551.6 4568.7 4593.4 3999.9 4002.7 4013.2 4017.2 4017.5 5785.5 5789.0 5797.0 5804.2 5806.7 5297.3 5301.7 5318.1 5319.9 5324.4 6316.6 6353.8 6358.1 6358.9 6366.3 4347.2 4438.0 4440.0 4444.3 4450.5 6546.2 6572.1 6629.0 6640.3 6641.1 4520.1 4522.0 4524.2 4528.9 4531.5 4569.9 4578.5 4584.0 4586.5 4588.9 5290.5 5293.0 5302.7 5308.5 5314.5 6251.1 6366.4 6380.4 6398.4 6420.5 1613.4 1628.0 1635.5 1640.5 1644.8 976.2 1058.4 1059.4 1062.8 1092.6 5914.1 5951.5 5956.2 5962.3 5971.6 6379.9 6492.0 6513.6 6517.8 6522.8 6053.6 6062.0 6070.5 6071.5 6072.7 3487.2 3517.4 3523.3 3525.9 3528.2 6538.7 6699.1 6706.8 6726.4 6733.2 6609.9 6612.4 6644.4 6644.8 6652.6 6683.5 6684.4 6685.1 6701.1 6704.4 6478.5 6491.2 6492.8 6503.9 6504.4 6297.9 6431.7 6440.1 6458.6 6467.3 6657.5 6671.2 6675.7 6678.0 6678.9 4571.7 4572.0 4573.6 4579.0 4579.9 6466.3 6478.4 6486.5 6490.5 6491.1 6197.6 6305.8 6316.4 6322.3 6336.6 6280.2 6293.3 6294.5 6298.0 6304.4 6141.9 6159.2 6165.5 6167.9 6192.3 6307.7 6316.5 6325.8 6340.4 6348.9 5988.6 6175.5 6206.5 6214.8 6215.7 10:07:53 INFO - PROCESS | 21007 | 10:07:53 INFO - PROCESS | 21007 | [#5] yui.html Cycles:180 Average:15113.59 Median:51624.24 stddev:18312.79 (35.5%) stddev-sans-first:18332.55 10:07:53 INFO - PROCESS | 21007 | Values: 785.8 860.4 867.1 878.9 886.8 14232.4 14437.9 14644.7 14790.3 16445.3 15245.6 15428.3 15481.7 15489.0 15506.9 666.2 824.1 831.1 842.6 849.2 831.9 836.7 836.9 839.1 839.4 883.5 889.1 889.9 890.0 890.7 690.7 859.2 873.5 877.4 878.7 645.5 645.8 646.1 647.4 648.6 14168.2 14181.2 14224.6 14243.5 14251.5 11936.5 12268.9 12367.7 12805.2 12858.3 10877.9 10960.2 10982.5 11055.1 11313.0 3789.7 3811.7 3812.0 3855.9 3870.3 55822.0 56086.2 56144.4 56353.2 56981.7 10395.3 10613.0 10692.3 10693.0 10729.7 19002.4 19015.1 19094.7 19095.3 19127.4 8319.1 8463.0 8502.7 8532.5 8710.8 4838.9 4968.1 4976.7 4978.7 4981.2 3349.2 3412.6 3529.1 3571.7 3580.6 648.7 650.8 653.8 656.9 657.9 649.9 704.5 708.2 718.7 727.5 8370.5 8531.8 8585.0 8587.0 8719.2 610.3 643.2 674.7 678.3 703.7 3997.4 4218.7 4228.7 4290.1 4293.8 64842.0 66031.0 66479.7 66679.7 66782.7 56381.7 57040.0 57541.0 58158.7 58561.4 51126.5 51180.5 51681.0 52562.0 52766.5 8126.6 8380.1 8399.9 8453.2 8479.3 39482.2 39767.6 40132.4 40961.4 41154.0 46853.3 50803.2 51302.2 51338.0 51567.5 9935.1 10221.5 10431.7 10463.1 10471.0 11832.0 11978.9 12055.5 12114.5 12506.4 10892.6 10958.5 10992.4 11223.0 11760.6 10926.7 11041.5 11054.6 11138.4 11219.9 11071.8 11110.5 11315.3 11441.3 11625.5 9163.5 9191.6 9342.9 9429.5 9457.6 9297.1 9862.3 9886.2 9934.6 9945.1 10:07:53 INFO - PROCESS | 21007 | -------- Summary: end -------- 10:07:53 INFO - PROCESS | 21007 | 10:07:54 INFO - TEST-INFO | 21007: exit 0 10:07:54 INFO - TEST-OK | dromaeo_css | took 1109869ms 10:07:54 INFO - TEST-START | kraken 10:07:54 INFO - operating with platform_type : linux_ 10:07:54 INFO - Initialising browser for kraken test... 10:07:54 INFO - TEST-INFO | started process 21195 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpV5B2LD/profile http://localhost:46389/getInfo.html) 10:07:58 INFO - PROCESS | 21195 | __metrics Screen width/height:1600/1200 10:07:58 INFO - PROCESS | 21195 | colorDepth:24 10:07:58 INFO - PROCESS | 21195 | Browser inner width/height: 1024/697 10:07:58 INFO - PROCESS | 21195 | __metrics 10:07:58 ERROR - PROCESS | 21195 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:07:59 INFO - TEST-INFO | 21195: exit 0 10:07:59 INFO - Browser initialized. 10:07:59 INFO - Running cycle 1/1 for kraken test... 10:07:59 INFO - TEST-INFO | started process 21284 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpV5B2LD/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:08:11 INFO - PROCESS | 21284 | RSS: Main: 153726976 10:08:11 INFO - PROCESS | 21284 | 10:08:13 INFO - PROCESS | 21284 | Cycle 1(1): loaded http://localhost:46389/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46389/tests/kraken/driver.html?testName=audio-beat-detection) 10:08:14 INFO - PROCESS | 21284 | RSS: Main: 194932736 10:08:14 INFO - PROCESS | 21284 | 10:08:16 INFO - PROCESS | 21284 | Cycle 1(1): loaded http://localhost:46389/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46389/tests/kraken/driver.html?testName=audio-dft) 10:08:17 INFO - PROCESS | 21284 | RSS: Main: 184754176 10:08:17 INFO - PROCESS | 21284 | 10:08:20 INFO - PROCESS | 21284 | Cycle 1(1): loaded http://localhost:46389/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46389/tests/kraken/driver.html?testName=audio-fft) 10:08:21 INFO - PROCESS | 21284 | RSS: Main: 168570880 10:08:21 INFO - PROCESS | 21284 | 10:08:23 INFO - PROCESS | 21284 | Cycle 1(1): loaded http://localhost:46389/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46389/tests/kraken/driver.html?testName=audio-oscillator) 10:08:23 INFO - PROCESS | 21284 | RSS: Main: 171384832 10:08:23 INFO - PROCESS | 21284 | 10:08:25 INFO - PROCESS | 21284 | Cycle 1(1): loaded http://localhost:46389/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46389/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:08:26 INFO - PROCESS | 21284 | RSS: Main: 172490752 10:08:26 INFO - PROCESS | 21284 | 10:08:29 INFO - PROCESS | 21284 | Cycle 1(1): loaded http://localhost:46389/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46389/tests/kraken/driver.html?testName=imaging-darkroom) 10:08:30 INFO - PROCESS | 21284 | RSS: Main: 173682688 10:08:30 INFO - PROCESS | 21284 | 10:08:33 INFO - PROCESS | 21284 | Cycle 1(1): loaded http://localhost:46389/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46389/tests/kraken/driver.html?testName=imaging-desaturate) 10:08:34 INFO - PROCESS | 21284 | RSS: Main: 174440448 10:08:34 INFO - PROCESS | 21284 | 10:08:36 INFO - PROCESS | 21284 | Cycle 1(1): loaded http://localhost:46389/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46389/tests/kraken/driver.html?testName=json-parse-financial) 10:08:37 INFO - PROCESS | 21284 | RSS: Main: 174305280 10:08:37 INFO - PROCESS | 21284 | 10:08:38 INFO - PROCESS | 21284 | Cycle 1(1): loaded http://localhost:46389/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46389/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:08:39 INFO - PROCESS | 21284 | RSS: Main: 185307136 10:08:39 INFO - PROCESS | 21284 | 10:08:41 INFO - PROCESS | 21284 | Cycle 1(1): loaded http://localhost:46389/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46389/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:08:41 INFO - PROCESS | 21284 | RSS: Main: 183697408 10:08:41 INFO - PROCESS | 21284 | 10:08:43 INFO - PROCESS | 21284 | Cycle 1(1): loaded http://localhost:46389/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46389/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:08:44 INFO - PROCESS | 21284 | RSS: Main: 192266240 10:08:44 INFO - PROCESS | 21284 | 10:08:46 INFO - PROCESS | 21284 | Cycle 1(1): loaded http://localhost:46389/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:08:47 INFO - PROCESS | 21284 | RSS: Main: 199077888 10:08:47 INFO - PROCESS | 21284 | 10:08:49 INFO - PROCESS | 21284 | Cycle 1(1): loaded http://localhost:46389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:08:50 INFO - PROCESS | 21284 | RSS: Main: 198041600 10:08:50 INFO - PROCESS | 21284 | 10:08:51 INFO - PROCESS | 21284 | Cycle 1(1): loaded http://localhost:46389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46389/tests/kraken/driver.html?testName=ai-astar) 10:08:52 INFO - PROCESS | 21284 | RSS: Main: 260624384 10:08:52 INFO - PROCESS | 21284 | 10:08:52 INFO - PROCESS | 21284 | __start_tp_report 10:08:52 INFO - PROCESS | 21284 | _x_x_mozilla_page_load 10:08:52 INFO - PROCESS | 21284 | _x_x_mozilla_page_load_details 10:08:52 INFO - PROCESS | 21284 | |i|pagename|runs| 10:08:52 INFO - PROCESS | 21284 | |0;ai-astar;110;111;104;109;111;109;99;109;109;109 10:08:52 INFO - PROCESS | 21284 | |1;audio-beat-detection;151;128;155;182;128;155;157;128;166;129 10:08:52 INFO - PROCESS | 21284 | |2;audio-dft;164;163;162;161;160;160;160;163;161;162 10:08:52 INFO - PROCESS | 21284 | |3;audio-fft;72;76;107;101;76;76;73;144;97;75 10:08:52 INFO - PROCESS | 21284 | |4;audio-oscillator;94;94;138;93;93;93;152;94;92;148 10:08:52 INFO - PROCESS | 21284 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;116;117 10:08:52 INFO - PROCESS | 21284 | |6;imaging-darkroom;146;145;145;145;145;144;146;145;145;145 10:08:52 INFO - PROCESS | 21284 | |7;imaging-desaturate;95;95;95;96;95;96;95;95;95;95 10:08:52 INFO - PROCESS | 21284 | |8;json-parse-financial;54;56;55;55;56;58;57;63;53;53 10:08:52 INFO - PROCESS | 21284 | |9;json-stringify-tinderbox;62;61;61;61;63;62;61;61;62;62 10:08:52 INFO - PROCESS | 21284 | |10;stanford-crypto-aes;79;78;79;79;79;77;76;76;78;77 10:08:52 INFO - PROCESS | 21284 | |11;stanford-crypto-ccm;127;111;120;109;108;113;119;114;111;116 10:08:52 INFO - PROCESS | 21284 | |12;stanford-crypto-pbkdf2;141;144;144;144;143;134;141;141;141;142 10:08:52 INFO - PROCESS | 21284 | |13;stanford-crypto-sha256-iterative;63;62;67;65;62;63;64;61;63;62 10:08:52 INFO - PROCESS | 21284 | __end_tp_report 10:08:52 INFO - PROCESS | 21284 | __start_cc_report 10:08:52 INFO - PROCESS | 21284 | _x_x_mozilla_cycle_collect,1057 10:08:52 INFO - PROCESS | 21284 | __end_cc_report 10:08:52 INFO - PROCESS | 21284 | __startTimestamp1459184932244__endTimestamp 10:08:52 INFO - PROCESS | 21284 | 10:08:52 INFO - PROCESS | 21284 | ------- Summary: start ------- 10:08:52 INFO - PROCESS | 21284 | Number of tests: 14 10:08:52 INFO - PROCESS | 21284 | 10:08:52 INFO - PROCESS | 21284 | [#0] ai-astar Cycles:10 Average:108.00 Median:109.50 stddev:3.71 (3.4%) stddev-sans-first:3.87 10:08:52 INFO - PROCESS | 21284 | Values: 110.0 111.0 104.0 109.0 111.0 109.0 99.0 109.0 109.0 109.0 10:08:52 INFO - PROCESS | 21284 | 10:08:52 INFO - PROCESS | 21284 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:155.00 stddev:18.94 (12.2%) stddev-sans-first:20.06 10:08:52 INFO - PROCESS | 21284 | Values: 151.0 128.0 155.0 182.0 128.0 155.0 157.0 128.0 166.0 129.0 10:08:52 INFO - PROCESS | 21284 | 10:08:52 INFO - PROCESS | 21284 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.43 (0.9%) stddev-sans-first:1.22 10:08:52 INFO - PROCESS | 21284 | Values: 164.0 163.0 162.0 161.0 160.0 160.0 160.0 163.0 161.0 162.0 10:08:52 INFO - PROCESS | 21284 | 10:08:52 INFO - PROCESS | 21284 | [#3] audio-fft Cycles:10 Average:89.70 Median:75.50 stddev:23.09 (30.6%) stddev-sans-first:23.59 10:08:52 INFO - PROCESS | 21284 | Values: 72.0 76.0 107.0 101.0 76.0 76.0 73.0 144.0 97.0 75.0 10:08:52 INFO - PROCESS | 21284 | 10:08:52 INFO - PROCESS | 21284 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:93.00 stddev:25.70 (27.6%) stddev-sans-first:26.67 10:08:52 INFO - PROCESS | 21284 | Values: 94.0 94.0 138.0 93.0 93.0 93.0 152.0 94.0 92.0 148.0 10:08:52 INFO - PROCESS | 21284 | 10:08:52 INFO - PROCESS | 21284 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 10:08:52 INFO - PROCESS | 21284 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 10:08:52 INFO - PROCESS | 21284 | 10:08:52 INFO - PROCESS | 21284 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 10:08:52 INFO - PROCESS | 21284 | Values: 146.0 145.0 145.0 145.0 145.0 144.0 146.0 145.0 145.0 145.0 10:08:52 INFO - PROCESS | 21284 | 10:08:52 INFO - PROCESS | 21284 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:08:52 INFO - PROCESS | 21284 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 10:08:52 INFO - PROCESS | 21284 | 10:08:52 INFO - PROCESS | 21284 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:2.94 (5.3%) stddev-sans-first:3.03 10:08:52 INFO - PROCESS | 21284 | Values: 54.0 56.0 55.0 55.0 56.0 58.0 57.0 63.0 53.0 53.0 10:08:52 INFO - PROCESS | 21284 | 10:08:52 INFO - PROCESS | 21284 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 10:08:52 INFO - PROCESS | 21284 | Values: 62.0 61.0 61.0 61.0 63.0 62.0 61.0 61.0 62.0 62.0 10:08:52 INFO - PROCESS | 21284 | 10:08:52 INFO - PROCESS | 21284 | [#10] stanford-crypto-aes Cycles:10 Average:77.80 Median:78.50 stddev:1.23 (1.6%) stddev-sans-first:1.22 10:08:52 INFO - PROCESS | 21284 | Values: 79.0 78.0 79.0 79.0 79.0 77.0 76.0 76.0 78.0 77.0 10:08:52 INFO - PROCESS | 21284 | 10:08:52 INFO - PROCESS | 21284 | [#11] stanford-crypto-ccm Cycles:10 Average:114.80 Median:115.00 stddev:5.85 (5.1%) stddev-sans-first:4.22 10:08:52 INFO - PROCESS | 21284 | Values: 127.0 111.0 120.0 109.0 108.0 113.0 119.0 114.0 111.0 116.0 10:08:52 INFO - PROCESS | 21284 | 10:08:52 INFO - PROCESS | 21284 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.50 Median:142.50 stddev:2.95 (2.1%) stddev-sans-first:3.13 10:08:52 INFO - PROCESS | 21284 | Values: 141.0 144.0 144.0 144.0 143.0 134.0 141.0 141.0 141.0 142.0 10:08:52 INFO - PROCESS | 21284 | 10:08:52 INFO - PROCESS | 21284 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:1.75 (2.8%) stddev-sans-first:1.86 10:08:52 INFO - PROCESS | 21284 | Values: 63.0 62.0 67.0 65.0 62.0 63.0 64.0 61.0 63.0 62.0 10:08:52 INFO - PROCESS | 21284 | -------- Summary: end -------- 10:08:52 INFO - PROCESS | 21284 | 10:08:53 INFO - TEST-INFO | 21284: exit 0 10:08:53 INFO - TEST-OK | kraken | took 58686ms 10:08:53 INFO - SUITE-END | took 1168s 10:08:53 INFO - Completed test suite (00:19:28) 10:08:53 INFO - javascript benchmark 10:08:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3133.780635355525, 3173.8571764270605, 3212.7108560229576, 3212.8393580320994, 3244.237604163022, 5177.4045984711765, 5291.2327712481665, 5360.24956506089, 5380.192971054339, 5470.2615146955195, 5333.066713325172, 5353.839384818452, 5356.3572371315395, 5368.516833484986, 5379.919301210485, 4726.432828060638, 4774.9045019099685, 4852.975735121319, 4863.975680121612, 4900.681455705386, 4701.412323459567, 4834.709917404949, 4865.586425153866, 4882.707037577739, 4900.436449808264, 4763.476017638057, 4823.372961515016, 4850.466448690677, 4869.050535145648, 4889.975550122244, 4830.347903033081, 4842.685225460334, 4853.053654537367, 4854.17479028566, 4885.828995985159, 4766.213574760161, 4797.832075877328, 4840.540148685869, 4842.055799119174, 4873.610111191097, 5280.656757310762, 5290.418054014094, 5294.047071527124, 5303.787848486056, 5318.760655770461, 5703.600747947646, 5724.427557244284, 5726.427357264281, 5728.140778883159, 5731.369549349568, 5609.354924183689, 5700.429957004308, 5735.942640573582, 5753.510951569122, 5759.539236861041, 5406.053940560386, 5406.297181366476, 5407.215953686693, 5407.405185429599, 5407.945920540784, 5855.648661080264, 5871.970640146772, 5872.383399743051, 5873.676947767914, 5875.148103525051, 5497.312835895513, 5519.751611177507, 5566.970110529565, 5605.075162598126, 5625.859353516113, 5628.409017053233, 5640.576956728261, 5645.520130788929, 5645.576581756384, 5647.0, 5629.437056294338, 5630.40880707528, 5632.52123569493, 5635.464630860061, 5644.491995720323, 5459.972700136554, 5682.232898558725, 5741.971290143606, 5744.224529688522, 5792.391798861059, 4285.935710964338, 4287.185434767384, 4287.828486860553, 4288.871333859989, 4314.956850431518, 3801.676857467091, 3825.3305671507933, 3844.5490850568854, 3885.300645883768, 3890.0469385000856, 5294.364676238799, 5328.333958255218, 5337.119375303031, 5375.354957405137, 5386.542143917811, 5682.801101961411, 5720.742566584514, 5746.224259724967, 5749.13762935563, 5750.856228594319, 5151.768170432265, 5284.682919024794, 5343.0, 5391.649542779707, 5433.646812957224, 4851.029794041206, 4877.902441951142, 4879.048585525859, 4906.0433215522635, 4914.041761856475, 5789.073748200268, 5813.418658134237, 5818.418158184148, 5818.679972601463, 5875.089361149029, 5550.222968784293, 5635.633683810704, 5653.3781284057895, 5672.2058911751565, 5713.085906254979, 5815.127730840408, 5816.941830581809, 5829.213056237523, 5842.0, 5866.67733274674, 5555.833325000256, 5560.694161821139, 5578.2748242728185, 5580.330360356783, 5588.050031494737, 5536.446355364593, 5602.803901863415, 5646.06839871433, 5656.632318899258, 5671.971640141773, 5521.944780552143, 5548.639338442988, 5549.500544950974, 5556.083246264321, 5605.747741351731, 5443.4284400138995, 5484.835454936198, 5492.752826122754, 5496.31296087989, 5498.5876059296515, 5336.919946200887, 5441.0, 5451.454854514517, 5471.425500322409, 5518.91721624184, 5494.36814766291, 5524.4199359068325, 5530.446955304437, 5538.501534861882, 5572.721363931868, 5429.158480435539, 5429.945700543102, 5431.864203394946, 5431.972840135774, 5445.482679145475], "unit": "score", "name": "dojo.html", "value": 5233.747933456217}, {"lowerIsBetter": false, "replicates": [550.0997173886333, 562.836777334573, 572.2274928846058, 575.7380391921674, 592.6740292838939, 29577.40845183095, 29901.0, 29910.700892991063, 30055.098347049596, 38246.0, 42036.57963420365, 42493.0, 42531.36202956958, 42550.78724606372, 42666.57333426665, 8698.260647844925, 8900.821983560325, 8905.020447750741, 8913.821723565525, 8924.643014279454, 8725.0, 8824.073472285414, 8844.867326990101, 8846.867296990551, 8852.0, 8861.955690221539, 8949.194572488475, 8949.865752013726, 8957.865632015524, 9126.726198214064, 8991.550422478882, 9083.81832363349, 9099.226565741887, 9100.453972761588, 9104.817903641922, 8929.955350223272, 9049.321300902458, 9054.230390416822, 9056.094390560957, 9059.773505662346, 41423.1715365691, 41559.58440415618, 41575.79212103951, 41715.0, 41798.0, 1762.9118544072744, 3436.518887355772, 3574.6425357464304, 3624.039629498185, 4096.897577560555, 31641.0, 31788.0, 32156.0, 32210.0, 32219.194520137185, 4319.740815551046, 4324.286492728727, 4327.935080973788, 4444.333349997494, 4460.754658493782, 338845.0, 341565.0, 343683.0, 345018.0, 345797.27101364586, 54863.0, 62938.68530657318, 63126.368736312965, 63514.36485635177, 63537.36462635407, 69341.0, 69716.30283697098, 70078.0, 70458.64770676114, 70517.29482705107, 16517.504474865775, 16712.164391780363, 16744.91627541879, 16746.83253167453, 16756.832431675528, 11908.702282443008, 12139.332336721565, 12509.437075331633, 12620.873791262153, 12627.11610187278, 20893.791062089487, 21191.364259072252, 21200.893995530234, 21290.148394064374, 21375.0, 6895.827709289433, 7112.6443677815905, 7185.784426467214, 7218.242084581148, 7365.189829118793, 973.1533565797802, 1096.9304927695594, 1105.3478447715886, 1188.9346085965183, 1230.9199902006342, 32228.35543289121, 32474.0, 33175.0, 33207.3358532828, 33310.83344583261, 1027.1577306608658, 1052.5263631365915, 1085.6742977106837, 1097.7145942054963, 1101.6694991502518, 16548.917255413646, 16946.322147114224, 17023.574410639834, 17046.403375881786, 17205.655886882192, 411090.0, 411680.0, 416419.0, 416930.0, 418067.0, 58006.0, 58292.417075829544, 58417.41582584205, 58434.0, 58456.4154358451, 1303.2831942431624, 1340.5107135895328, 1363.3319673360181, 1410.3935307817533, 1433.5412667946157, 29559.704402955696, 32059.0, 33045.83477082599, 33400.0, 33761.493577595866, 41611.0, 41857.581424185366, 41905.0, 41970.790146049076, 42019.58794326552, 262693.0, 265255.0, 265328.0, 265353.0, 265913.0, 35545.64454355527, 37008.444873326385, 37070.0, 37121.6287837129, 37152.25695486021, 45609.54390456053, 45960.0, 46561.87819339802, 46577.0, 46832.53167468282, 38851.417228741026, 39239.07609239053, 39564.0, 39706.80146599249, 40144.0, 37608.623913760515, 37875.621243788315, 38967.6103238964, 39183.2163356737, 39580.80209598933, 40030.799846000584, 40294.59705402909, 40431.1913761729, 41302.1739565201, 41343.0, 33283.66716332806, 34077.48883766696, 34089.82955085209, 34668.47997280093, 34876.65123348734, 24595.631065533675, 25032.117258996695, 27591.0, 27917.581236281065, 27936.797356152103], "unit": "score", "name": "ext.html", "value": 19546.758598703356}, {"lowerIsBetter": false, "replicates": [361.9059044648391, 363.6708778555408, 368.43445311446936, 369.0920335973505, 376.1311370733604, 17176.570585735346, 18047.909760451195, 19507.804921950777, 19668.0, 19703.50741231468, 18003.90998045008, 18520.722189167172, 18707.90646046768, 18713.0, 18730.62538749224, 5400.621956463049, 5614.29821272341, 5641.52047075997, 5653.886922261552, 5659.547236221113, 4020.8793736187963, 5535.474129957647, 5948.256467941507, 6186.072089186613, 6219.657918814463, 6112.0, 6147.047207682816, 6171.537134714892, 6174.8147555573405, 6179.876402471948, 5798.884022319551, 6142.201513803222, 6144.692765361714, 6145.938540614581, 6154.0, 3628.074840915576, 5225.242339860699, 5388.784448622089, 5433.293671822677, 5441.483059109379, 21409.78590214109, 21552.89223553888, 21653.0, 21971.780282197295, 22099.226527071634, 2295.1966811615966, 2565.3586603349163, 2633.499635069331, 2636.446346267286, 3121.750259979196, 13487.865121348857, 13689.726205475934, 13789.0, 14033.508827190999, 14083.577492675133, 1885.4060970794155, 1924.8652594318403, 1940.1754254441805, 1950.0737149853705, 2070.513429344103, 65959.0, 67237.0, 68776.65611671959, 68947.65526172337, 69567.30432695658, 9615.423074615546, 9667.226621870233, 9818.901810981799, 10052.195824334036, 10100.646477373404, 13469.663258418617, 13533.593992180251, 13556.322183890767, 13588.59234222975, 13588.728225435634, 7995.920040799518, 8051.0, 8076.55578943152, 8096.473729207582, 8111.432199746079, 8014.519128852287, 8043.919560804434, 8108.0, 8166.305864001508, 8237.50574965504, 6001.3098493672915, 6064.659087506391, 6132.724027418777, 6161.476274516716, 6162.630242185483, 1636.2636813433764, 1717.7595136680875, 1746.8602511799027, 1792.103948025987, 1803.125484140191, 977.6236149082655, 1037.8287582548946, 1125.3023125662141, 1146.1232157399595, 1170.607846371458, 16811.243494042796, 17099.059551724527, 17374.565635859206, 18608.44174674762, 19017.33439329617, 1054.0776820282254, 1083.7778255457613, 1088.357868857362, 1088.472091035847, 1101.6529793115144, 10559.841602375971, 10910.454477276104, 10937.4531273436, 10972.945135274433, 11047.613333533287, 460087.0, 477196.0, 479994.0, 483938.0, 494116.0, 53269.93460130776, 68508.6574567124, 69533.65233173902, 72148.63925680338, 72644.0, 1061.1139698351808, 1072.0, 1077.6336045744486, 1080.0981180714034, 1084.788466249074, 16421.91789041095, 16509.257083431035, 16532.586685332964, 16606.584835379213, 16624.0, 32007.0, 32948.83525582357, 33829.0, 34342.313153736286, 34569.82715086408, 44622.0, 46749.53250467452, 46804.0, 47000.0, 47008.0, 8017.759467215993, 8098.959505202436, 8162.10216876155, 8272.04871439768, 8431.494110353398, 8444.704435344733, 13024.739505210033, 13046.478140874258, 13120.934395328344, 13277.468901243841, 10396.324238924446, 10504.0, 10742.355458672504, 10895.346279223271, 10988.120950323795, 7960.681572737026, 11622.593209237637, 11652.883471165518, 11690.70773230676, 11871.287722736663, 11629.941850290694, 11900.702482438008, 11901.82147267809, 11932.403379830801, 12142.575009874612, 8322.08457069734, 8358.247757701836, 8371.874421883798, 8377.49735015901, 8377.83244335122, 11824.138997217084, 11829.0, 11855.466504007169, 11905.880941190477, 12076.0], "unit": "score", "name": "jquery.html", "value": 8983.25515032444}, {"lowerIsBetter": false, "replicates": [1258.7230809221967, 1439.7912302716106, 1451.7749748788935, 1647.308130585154, 1858.0895361272972, 7696.422768292379, 7917.0, 7918.881216781746, 7920.089189743181, 7923.168067352932, 7912.485688430248, 8130.959345203266, 8135.511869287847, 8145.226203510657, 8150.75547733569, 2022.6055919095782, 2293.9770602294016, 2343.027643527934, 2346.7887890089887, 2358.646203069536, 2362.3857796972825, 2366.4557151855083, 2372.122314743547, 2376.370261880603, 2379.1078345620394, 2219.4340443186966, 2275.7724227577273, 2276.1350686739015, 2286.9542609147807, 2286.9771302287013, 2312.560613483441, 2338.8479748816358, 2373.133806160756, 2374.82188835838, 2377.084822343393, 2345.1674655497395, 2348.823838212141, 2356.988215058931, 2357.858528488296, 2359.2332491940188, 8204.83590328196, 8291.502509849428, 8293.33653307734, 8296.294814940737, 8296.917030829734, 5054.772535235923, 5199.584033277329, 5210.973945130288, 5212.139996900545, 5213.244079608436, 3275.164832967578, 3347.6652334766327, 3404.914877128067, 3447.844846981867, 3470.583529976394, 1083.7778255457613, 1122.550979608155, 1142.2917790969568, 1143.8856114388577, 1161.2335858333545, 11619.6514104577, 11679.0, 11686.76626467466, 11701.473433695504, 11749.29504229749, 4443.311286750494, 4457.866264012085, 4540.954590454053, 4574.519675434098, 4578.771061446914, 9780.119789219005, 9862.852057219148, 9866.703998880044, 9884.209263258923, 9887.456189909624, 4561.908761824745, 5134.589232861362, 5145.176771716508, 5163.302954101224, 5171.663841850268, 4543.568361005699, 4586.4266966629175, 4617.815287388534, 4632.698874573142, 4643.210654188796, 3847.5382954045135, 3917.275304068756, 3952.644262016375, 3982.163745613396, 3983.780892050965, 1218.7075101975463, 1268.1440027981075, 1269.7397033608088, 1274.5539061328461, 1278.5908509276942, 1400.5868268860506, 1411.5553600615774, 1429.0425414971994, 1429.942802287897, 1452.6005348529238, 8030.07654119772, 8066.878996815052, 8108.716194933149, 8117.472364296302, 8117.79705507367, 452.9637628989673, 455.64687367290617, 457.53560136461516, 462.3180808307719, 465.20450030447637, 6049.304330002018, 6057.727402266909, 6060.484858787053, 6100.23747031621, 6122.142899994004, 9683.806323873623, 10237.436940968319, 10291.639792607373, 10296.742581435525, 10337.276390652582, 9982.201423886072, 10049.24630652704, 10150.796984060426, 10179.03299186576, 10218.642347517802, 7627.809304767315, 7963.84072318562, 8007.159248278964, 8018.438709290411, 8020.879686804703, 7617.69529218825, 7641.961790191013, 7653.387728981779, 7686.615669216405, 7794.493357931717, 8965.282777377925, 9105.317101217302, 9215.907840921773, 9284.907150928675, 9345.859812102688, 8630.741077767425, 8800.603972821367, 9352.158305752242, 9512.524373781145, 9523.57143928511, 6740.2248741393405, 7142.142942846892, 7303.342699157101, 7385.852282954418, 7516.0, 7928.801779955316, 7938.245866642891, 7943.0, 7950.960245198969, 7957.124716281089, 7099.716011359487, 7228.855422891618, 7306.488545801955, 7376.4836461447185, 7415.073115860518, 6951.270116637883, 6986.895196571953, 7095.3968912643, 7159.60622165765, 7299.781006569811, 7208.315210055036, 7234.312740289664, 7248.383887369632, 7253.419726421979, 7259.9274007259255, 6718.596884186964, 6766.966165169143, 6767.0, 6775.864482710417, 6790.966045169743, 6804.353586409283, 6911.75808846688, 6968.721251149897, 7003.824904377431, 7004.0544526488275], "unit": "score", "name": "mootools.html", "value": 4655.743880201487}, {"lowerIsBetter": false, "replicates": [321.3027729826277, 321.88894831283204, 322.65153634075193, 330.5306464819955, 335.7045799696268, 6054.152418661385, 6119.602225855317, 6130.662813545253, 6140.570160088796, 6174.969125154379, 6027.75888964442, 6040.818775436733, 6062.42406971337, 6062.514998800097, 6069.271687397519, 4360.454943132108, 4503.639708823286, 4550.294704320819, 4614.630829533629, 4676.3920690310215, 4589.990202155521, 4597.402337696095, 4602.539746025404, 4602.884927876797, 4608.640451066926, 4516.683832131752, 4521.683482156251, 4524.954750452503, 4569.063342014879, 4571.61141302988, 4378.737275763448, 4457.442819647544, 4551.5676010778925, 4568.725876447424, 4593.402857628487, 3999.900002499932, 4002.7398219115667, 4013.237484877864, 4017.196560687874, 4017.4576432181575, 5785.47930686236, 5788.97105514474, 5796.971015144897, 5804.187413762034, 5806.680632565207, 5297.337832770903, 5301.655392399482, 5318.069337865897, 5319.946800532022, 5324.387695414999, 6316.62100273985, 6353.8411539711415, 6358.109864618957, 6358.936410635881, 6366.331535188785, 4347.152305300468, 4438.023634800339, 4439.977800110979, 4444.288913773813, 4450.46594408673, 6546.214454265519, 6572.14562106923, 6629.0387893755615, 6640.302768209317, 6641.070250164981, 4520.050789334211, 4521.977390113028, 4524.2082635538645, 4528.909421811545, 4531.546845315442, 4569.885752856138, 4578.519255478193, 4584.014436896016, 4586.541345865387, 4588.931166032446, 5290.523852853262, 5293.020791153649, 5302.70835104073, 5308.548773354231, 5314.548263397654, 6251.093241642658, 6366.395192456709, 6380.3619638035825, 6398.392152745481, 6420.486361091102, 1613.4191690991233, 1627.967440651204, 1635.4521235386278, 1640.4996476074673, 1644.8190699023098, 976.1897624971257, 1058.4496062047692, 1059.427908929185, 1062.792755412687, 1092.6285063078592, 5914.142449344821, 5951.5238780897425, 5956.195913551615, 5962.284525856925, 5971.641701497924, 6379.936200637934, 6492.0, 6513.576617519846, 6517.771877984248, 6522.804315870531, 6053.606515576474, 6061.969690151521, 6070.453659170696, 6071.483923866521, 6072.726727297282, 3487.215376540309, 3517.419625761772, 3523.295340931824, 3525.876594319238, 3528.1653540159487, 6538.738450461929, 6699.095622091053, 6706.798796036127, 6726.3946244837225, 6733.158355205599, 6609.867802644017, 6612.404883560503, 6644.435223006002, 6644.800655980328, 6652.567583107082, 6683.4987375947, 6684.4318232950745, 6685.130932978682, 6701.061851340816, 6704.430123439464, 6478.481721462366, 6491.156149700509, 6492.805215843532, 6503.934960650333, 6504.414602685781, 6297.874042519215, 6431.678416079084, 6440.130582371507, 6458.61248325102, 6467.288598254282, 6657.53397262187, 6671.166104236971, 6675.699593518206, 6677.966610166918, 6678.866422671616, 4571.6799824012, 4571.954280457153, 4573.588377046081, 4579.0, 4579.931301030554, 6466.32103629131, 6478.352164783484, 6486.513511486563, 6490.48076153916, 6491.123698300669, 6197.628142311476, 6305.779297724557, 6316.431521163117, 6322.3045464997895, 6336.588121772254, 6280.183576135073, 6293.276273228637, 6294.527910406646, 6298.0, 6304.401081897213, 6141.938580614136, 6159.199304090619, 6165.5375846810775, 6167.938320616737, 6192.349803270592, 6307.653079080695, 6316.526260530387, 6325.841853953504, 6340.397662222082, 6348.904766428415, 5988.550858685703, 6175.505959523317, 6206.503479721701, 6214.751409943552, 6215.720292586935], "unit": "score", "name": "prototype.html", "value": 4773.177307274111}, {"lowerIsBetter": false, "replicates": [785.760343095356, 860.393422637041, 867.0895559662353, 878.8549889268266, 886.849235629943, 14232.43070277189, 14437.927810360947, 14644.707105857877, 14790.260486975634, 16445.25996330165, 15245.618859528517, 15428.305726242317, 15481.69036619267, 15489.0, 15506.922465387686, 666.2305037681485, 824.1017291152642, 831.0567505880808, 842.6166094427051, 849.2144766091371, 831.9251267385933, 836.6778790165799, 836.861917783565, 839.0518713853337, 839.3998291221775, 883.483162350026, 889.1153302464057, 889.9110088991114, 889.977750556238, 890.7327801659509, 690.6788343420309, 859.1966511311944, 873.5239294584467, 877.3814460805149, 878.6968495868915, 645.4965127200791, 645.7513857164978, 646.056757134584, 647.4464332995316, 648.6367634124905, 14168.220747858864, 14181.220032898187, 14224.644383890382, 14243.501477448239, 14251.501197458143, 11936.462859171359, 12268.938655306756, 12367.675822562398, 12805.23168609877, 12858.292793896331, 10877.945610271978, 10960.246360582349, 10982.450877456095, 11055.11559075272, 11312.981831635192, 3789.696824254053, 3811.714121440903, 3811.9809400953095, 3855.8843234703004, 3870.283997460451, 55822.0, 56086.15870761942, 56144.43855561433, 56353.154702679494, 56981.71509142428, 10395.324303920372, 10612.985416439487, 10692.251542392114, 10693.0, 10729.678109656723, 19002.42992710221, 19015.1443185057, 19094.71357929632, 19095.331663391993, 19127.426177214707, 8319.084900660922, 8463.0, 8502.65989360431, 8532.488050716976, 8710.82578348442, 4838.854834354905, 4968.105740966588, 4976.701397916137, 4978.651494395358, 4981.178105612534, 3349.1627093226693, 3412.6246112927556, 3529.1177205698577, 3571.6606922342335, 3580.606133325332, 648.7405037984844, 650.8242774450872, 653.7515744017243, 656.9146011018632, 657.9210494740662, 649.8919342520991, 704.4857254204358, 708.189123453653, 718.6776331549974, 727.450774665135, 8370.455920365157, 8531.786705332417, 8585.0, 8587.0, 8719.171678690514, 610.3286384976491, 643.201715204579, 674.6727836999052, 678.3352314731492, 703.697410113656, 3997.420374045805, 4218.704690671623, 4228.682848786292, 4290.099079193342, 4293.849715259951, 64842.0, 66031.0, 66479.66760166168, 66679.66660166669, 66782.66608666925, 56381.7180914101, 57040.0, 57541.0, 58158.7092064537, 58561.4143858556, 51126.48873511217, 51180.48819511757, 51681.0, 52562.0, 52766.47233527692, 8126.634301456331, 8380.12008739098, 8399.874001890099, 8453.154684531497, 8479.279261262862, 39482.2103557933, 39767.602323977546, 40132.398014029226, 40961.38557921574, 41154.0, 46853.2972005427, 50803.23795143002, 51302.230466542285, 51338.0, 51567.48432515777, 9935.145028448871, 10221.540030698488, 10431.68704938853, 10463.110635595755, 10471.0, 11831.954827421514, 11978.940105299418, 12055.51777928873, 12114.454849531616, 12506.37468126572, 10892.61875834342, 10958.45207739594, 10992.446987010166, 11222.989930906258, 11760.647180584596, 10926.726831829268, 11041.503132358903, 11054.613088542184, 11138.37021640179, 11219.943900280447, 11071.834051392852, 11110.500027498943, 11315.321080734853, 11441.313521188755, 11625.476853541442, 9163.496007719372, 9191.586378612845, 9342.906570934476, 9429.52852357393, 9457.574409151743, 9297.116773906468, 9862.309638325249, 9886.209103271865, 9934.602615895283, 9945.104940555384], "unit": "score", "name": "yui.html", "value": 6670.584233816443}], "name": "dromaeo_css", "value": 7173.320621833257}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 104.0, 109.0, 111.0, 109.0, 99.0, 109.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.0}, {"lowerIsBetter": true, "replicates": [151.0, 128.0, 155.0, 182.0, 128.0, 155.0, 157.0, 128.0, 166.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 147.9}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 162.0, 161.0, 160.0, 160.0, 160.0, 163.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [72.0, 76.0, 107.0, 101.0, 76.0, 76.0, 73.0, 144.0, 97.0, 75.0], "unit": "score", "name": "audio-fft", "value": 89.7}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 138.0, 93.0, 93.0, 93.0, 152.0, 94.0, 92.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 144.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [54.0, 56.0, 55.0, 55.0, 56.0, 58.0, 57.0, 63.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [62.0, 61.0, 61.0, 61.0, 63.0, 62.0, 61.0, 61.0, 62.0, 62.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 61.6}, {"lowerIsBetter": true, "replicates": [79.0, 78.0, 79.0, 79.0, 79.0, 77.0, 76.0, 76.0, 78.0, 77.0], "unit": "score", "name": "stanford-crypto-aes", "value": 77.8}, {"lowerIsBetter": true, "replicates": [127.0, 111.0, 120.0, 109.0, 108.0, 113.0, 119.0, 114.0, 111.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.8}, {"lowerIsBetter": true, "replicates": [141.0, 144.0, 144.0, 144.0, 143.0, 134.0, 141.0, 141.0, 141.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.5}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 67.0, 65.0, 62.0, 63.0, 64.0, 61.0, 63.0, 62.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 63.2}], "name": "kraken", "value": 1488.3}]} 10:08:53 INFO - Return code: 0 10:08:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:08:53 ERROR - # TBPL SUCCESS # 10:08:53 INFO - Running post-action listener: _resource_record_post_action 10:08:53 INFO - Running post-run listener: _resource_record_post_run 10:08:54 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 20480; Write bytes: 529199104; Read time: 216; Write time: 411072 10:08:54 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 243142656; Read time: 40; Write time: 253704 10:08:54 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 16384; Write bytes: 286056448; Read time: 176; Write time: 157368 10:08:54 INFO - Running post-run listener: _upload_blobber_files 10:08:54 INFO - Blob upload gear active. 10:08:54 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 10:08:54 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 10:08:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 10:08:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 10:08:55 INFO - (blobuploader) - INFO - Open directory for files ... 10:08:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:08:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:08:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:55 INFO - (blobuploader) - INFO - Done attempting. 10:08:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 10:08:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:08:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:56 INFO - (blobuploader) - INFO - Done attempting. 10:08:56 INFO - (blobuploader) - INFO - Iteration through files over. 10:08:56 INFO - Return code: 0 10:08:56 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 10:08:56 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 10:08:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cd2fd889847350177e5fc36051171d2f67bdf937f64ca014f64db1569244393ece3b57f7e9c95dc3070ba466422e1f7c14330293cf00d9b6b7c0bb3003f9d0e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aa6e66c96e1ab3d16b5e6ebbf3da7ee5f22b29481b618224b54751e6646e7dec8ffd25c93d0920a7e0707575e52448364049c804529f25e67e8833b6d52921d0"} 10:08:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 10:08:56 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 10:08:56 INFO - Contents: 10:08:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cd2fd889847350177e5fc36051171d2f67bdf937f64ca014f64db1569244393ece3b57f7e9c95dc3070ba466422e1f7c14330293cf00d9b6b7c0bb3003f9d0e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aa6e66c96e1ab3d16b5e6ebbf3da7ee5f22b29481b618224b54751e6646e7dec8ffd25c93d0920a7e0707575e52448364049c804529f25e67e8833b6d52921d0"} 10:08:56 INFO - Running post-run listener: copy_logs_to_upload_dir 10:08:56 INFO - Copying logs to upload dir... 10:08:56 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 10:08:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.876927 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-03-28 10:08:56.195944) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-28 10:08:56.199650) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1459174066.371837-1748513583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cd2fd889847350177e5fc36051171d2f67bdf937f64ca014f64db1569244393ece3b57f7e9c95dc3070ba466422e1f7c14330293cf00d9b6b7c0bb3003f9d0e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aa6e66c96e1ab3d16b5e6ebbf3da7ee5f22b29481b618224b54751e6646e7dec8ffd25c93d0920a7e0707575e52448364049c804529f25e67e8833b6d52921d0"} build_url:https://queue.taskcluster.net/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011340 build_url: 'https://queue.taskcluster.net/v1/task/Y1Fbd6-XRAC1OuEKsJv73w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cd2fd889847350177e5fc36051171d2f67bdf937f64ca014f64db1569244393ece3b57f7e9c95dc3070ba466422e1f7c14330293cf00d9b6b7c0bb3003f9d0e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aa6e66c96e1ab3d16b5e6ebbf3da7ee5f22b29481b618224b54751e6646e7dec8ffd25c93d0920a7e0707575e52448364049c804529f25e67e8833b6d52921d0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-28 10:08:56.228568) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 10:08:56.228899) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1459174066.371837-1748513583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 10:08:56.316605) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-28 10:08:56.317489) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-28 10:08:56.318231) ========= ========= Total master_lag: 0.35 =========