builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-003 starttime: 1458170579.48 results: success (0) buildid: 20160316133021 builduid: 86497265e06f49f3aae80e8989f29b9c revision: f3d0a675497675ea4907f49f423fd803dd655923 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 16:22:59.480638) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 16:22:59.481212) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 16:22:59.481574) ========= 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=7de08804244eb36560b44971000001c3-1458170579.39929-1302790124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006250 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 16:22:59.505016) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 16:22:59.505366) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 16:22:59.519227) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 16:22:59.519667) ========= 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=7de08804244eb36560b44971000001c3-1458170579.39929-1302790124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 16:22:59.568748) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 16:22:59.569103) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 16:22:59.569535) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 16:22:59.569873) ========= 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=7de08804244eb36560b44971000001c3-1458170579.39929-1302790124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-16 16:22:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.7M=0s 2016-03-16 16:22:59 (33.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090342 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 16:22:59.673027) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 16:22:59.673382) ========= 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=7de08804244eb36560b44971000001c3-1458170579.39929-1302790124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022505 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 16:22:59.725419) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 16:22:59.725897) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f3d0a675497675ea4907f49f423fd803dd655923 --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 f3d0a675497675ea4907f49f423fd803dd655923 --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=7de08804244eb36560b44971000001c3-1458170579.39929-1302790124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-16 16:23:00,022 truncating revision to first 12 chars 2016-03-16 16:23:00,022 Setting DEBUG logging. 2016-03-16 16:23:00,022 attempt 1/10 2016-03-16 16:23:00,022 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/f3d0a6754976?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-16 16:23:00,283 unpacking tar archive at: mozilla-inbound-f3d0a6754976/testing/mozharness/ program finished with exit code 0 elapsedTime=0.549921 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 16:23:00.289921) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 16:23:00.290334) ========= echo f3d0a675497675ea4907f49f423fd803dd655923 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f3d0a675497675ea4907f49f423fd803dd655923'] 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=7de08804244eb36560b44971000001c3-1458170579.39929-1302790124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False f3d0a675497675ea4907f49f423fd803dd655923 program finished with exit code 0 elapsedTime=0.003947 script_repo_revision: 'f3d0a675497675ea4907f49f423fd803dd655923' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 16:23:00.339735) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 16:23:00.340092) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 16:23:00.350112) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-03-16 16:23:00.350456) ========= /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=7de08804244eb36560b44971000001c3-1458170579.39929-1302790124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:23:00 INFO - MultiFileLogger online at 20160316 16:23:00 in /builds/slave/test-pgo 16:23:00 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 16:23:00 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:23:00 INFO - {'append_to_log': False, 16:23:00 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:23:00 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:23:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:23:00 INFO - 'branch': 'Mozilla-Inbound', 16:23:00 INFO - 'buildbot_json_path': 'buildprops.json', 16:23:00 INFO - 'config_files': ('talos/linux_config.py',), 16:23:00 INFO - 'default_actions': ('clobber', 16:23:00 INFO - 'read-buildbot-config', 16:23:00 INFO - 'download-and-extract', 16:23:00 INFO - 'populate-webroot', 16:23:00 INFO - 'create-virtualenv', 16:23:00 INFO - 'install', 16:23:00 INFO - 'run-tests'), 16:23:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:23:00 INFO - 'download_minidump_stackwalk': True, 16:23:00 INFO - 'download_symbols': 'ondemand', 16:23:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:23:00 INFO - 'tooltool.py': '/tools/tooltool.py', 16:23:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:23:00 INFO - '/tools/misc-python/virtualenv.py')}, 16:23:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:23:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:23:00 INFO - 'installer_path': 'installer.exe', 16:23:00 INFO - 'log_level': 'info', 16:23:00 INFO - 'log_name': 'talos', 16:23:00 INFO - 'log_to_console': True, 16:23:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:23:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:23:00 INFO - 'opt_config_files': (), 16:23:00 INFO - 'pip_index': False, 16:23:00 INFO - 'sps_profile': False, 16:23:00 INFO - 'sps_profile_interval': 0, 16:23:00 INFO - 'suite': 'dromaeojs', 16:23:00 INFO - 'system_bits': '32', 16:23:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:23:00 INFO - 'title': 'talos-linux64-ix-003', 16:23:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:23:00 INFO - 'use_talos_json': True, 16:23:00 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:23:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:23:00 INFO - 'work_dir': 'build'} 16:23:00 INFO - ##### 16:23:00 INFO - ##### Running clobber step. 16:23:00 INFO - ##### 16:23:00 INFO - Running pre-action listener: _resource_record_pre_action 16:23:00 INFO - Running main action method: clobber 16:23:00 INFO - rmtree: /builds/slave/test-pgo/build 16:23:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:23:01 INFO - Running post-action listener: _resource_record_post_action 16:23:01 INFO - ##### 16:23:01 INFO - ##### Running read-buildbot-config step. 16:23:01 INFO - ##### 16:23:01 INFO - Running pre-action listener: _resource_record_pre_action 16:23:01 INFO - Running main action method: read_buildbot_config 16:23:01 INFO - Using buildbot properties: 16:23:01 INFO - { 16:23:01 INFO - "project": "", 16:23:01 INFO - "product": "firefox", 16:23:01 INFO - "script_repo_revision": "production", 16:23:01 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 16:23:01 INFO - "repository": "", 16:23:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 16:23:01 INFO - "buildid": "20160316133021", 16:23:01 INFO - "pgo_build": "True", 16:23:01 INFO - "basedir": "/builds/slave/test-pgo", 16:23:01 INFO - "buildnumber": 1590, 16:23:01 INFO - "slavename": "talos-linux64-ix-003", 16:23:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:23:01 INFO - "platform": "ubuntu64_hw", 16:23:01 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:23:01 INFO - "branch": "mozilla-inbound", 16:23:01 INFO - "repo_path": "integration/mozilla-inbound", 16:23:01 INFO - "revision": "f3d0a675497675ea4907f49f423fd803dd655923", 16:23:01 INFO - "stage_platform": "linux64-pgo", 16:23:01 INFO - "builduid": "86497265e06f49f3aae80e8989f29b9c", 16:23:01 INFO - "slavebuilddir": "test" 16:23:01 INFO - } 16:23:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/X3bcZRccQUO6XPAAsqH8cA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 16:23:01 INFO - Running post-action listener: _resource_record_post_action 16:23:01 INFO - ##### 16:23:01 INFO - ##### Running download-and-extract step. 16:23:01 INFO - ##### 16:23:01 INFO - Running pre-action listener: _resource_record_pre_action 16:23:01 INFO - Running main action method: download_and_extract 16:23:01 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:23:01 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')]} 16:23:01 INFO - https://queue.taskcluster.net/v1/task/X3bcZRccQUO6XPAAsqH8cA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:23:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3bcZRccQUO6XPAAsqH8cA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:23:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3bcZRccQUO6XPAAsqH8cA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:23:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3bcZRccQUO6XPAAsqH8cA/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 16:23:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3bcZRccQUO6XPAAsqH8cA/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 16:23:01 INFO - Downloaded 1361 bytes. 16:23:01 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:23:01 INFO - Using the following test package requirements: 16:23:01 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:23:01 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:01 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:23:01 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:01 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:23:01 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:01 INFO - u'jsshell-linux-x86_64.zip'], 16:23:01 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:01 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:23:01 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:23:01 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:01 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:23:01 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:01 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:23:01 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:01 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:23:01 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:01 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:23:01 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:23:01 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')]} 16:23:01 INFO - https://queue.taskcluster.net/v1/task/X3bcZRccQUO6XPAAsqH8cA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:23:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3bcZRccQUO6XPAAsqH8cA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:23:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3bcZRccQUO6XPAAsqH8cA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:23:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3bcZRccQUO6XPAAsqH8cA/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 16:23:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3bcZRccQUO6XPAAsqH8cA/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 16:23:03 INFO - Downloaded 23563086 bytes. 16:23:03 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'] 16:23:03 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 16:23:04 INFO - Return code: 0 16:23:04 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 16:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:23:04 INFO - https://queue.taskcluster.net/v1/task/X3bcZRccQUO6XPAAsqH8cA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:23:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3bcZRccQUO6XPAAsqH8cA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:23:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3bcZRccQUO6XPAAsqH8cA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:23:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3bcZRccQUO6XPAAsqH8cA/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 16:23:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3bcZRccQUO6XPAAsqH8cA/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 16:23:05 INFO - Downloaded 23563086 bytes. 16:23:05 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'] 16:23:05 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 16:23:07 INFO - Return code: 0 16:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:23:07 INFO - https://queue.taskcluster.net/v1/task/X3bcZRccQUO6XPAAsqH8cA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:23:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3bcZRccQUO6XPAAsqH8cA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:23:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3bcZRccQUO6XPAAsqH8cA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:23:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3bcZRccQUO6XPAAsqH8cA/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 16:23:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3bcZRccQUO6XPAAsqH8cA/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 16:23:08 INFO - Downloaded 10846565 bytes. 16:23:08 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'] 16:23:08 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 16:23:08 INFO - Return code: 0 16:23:08 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')]} 16:23:08 INFO - https://queue.taskcluster.net/v1/task/X3bcZRccQUO6XPAAsqH8cA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:23:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3bcZRccQUO6XPAAsqH8cA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:23:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3bcZRccQUO6XPAAsqH8cA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:23:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3bcZRccQUO6XPAAsqH8cA/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 16:23:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3bcZRccQUO6XPAAsqH8cA/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 16:23:10 INFO - Downloaded 57639865 bytes. 16:23:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X3bcZRccQUO6XPAAsqH8cA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:23:10 INFO - mkdir: /builds/slave/test-pgo/properties 16:23:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:23:10 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:23:10 INFO - Contents: 16:23:10 INFO - build_url:https://queue.taskcluster.net/v1/task/X3bcZRccQUO6XPAAsqH8cA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:23:11 INFO - Running post-action listener: _resource_record_post_action 16:23:11 INFO - Running post-action listener: set_extra_try_arguments 16:23:11 INFO - ##### 16:23:11 INFO - ##### Running populate-webroot step. 16:23:11 INFO - ##### 16:23:11 INFO - Running pre-action listener: _resource_record_pre_action 16:23:11 INFO - Running main action method: populate_webroot 16:23:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:23:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:23:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:23:11 INFO - '--tppagecycles', 16:23:11 INFO - '7'], 16:23:11 INFO - 'tests': ['tsvgm']}}, 16:23:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:23:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:23:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:23:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:23:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:23:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:23:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:23:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:11 INFO - 'talos_options': ['--e10s'], 16:23:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:23:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:11 INFO - 'tests': ['damp', 'tps']}, 16:23:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:11 INFO - 'talos_options': ['--e10s'], 16:23:11 INFO - 'tests': ['damp', 'tps']}, 16:23:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:23:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:23:11 INFO - 'other': {'tests': ['a11yr', 16:23:11 INFO - 'ts_paint', 16:23:11 INFO - 'tpaint', 16:23:11 INFO - 'sessionrestore', 16:23:11 INFO - 'sessionrestore_no_auto_restore', 16:23:11 INFO - 'tabpaint']}, 16:23:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:23:11 INFO - 'tests': ['a11yr', 16:23:11 INFO - 'ts_paint', 16:23:11 INFO - 'tpaint', 16:23:11 INFO - 'sessionrestore', 16:23:11 INFO - 'sessionrestore_no_auto_restore', 16:23:11 INFO - 'tabpaint']}, 16:23:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:23:11 INFO - 'tests': ['a11yr', 16:23:11 INFO - 'ts_paint', 16:23:11 INFO - 'tpaint', 16:23:11 INFO - 'sessionrestore', 16:23:11 INFO - 'sessionrestore_no_auto_restore', 16:23:11 INFO - 'tabpaint']}, 16:23:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:23:11 INFO - 'tests': ['a11yr', 16:23:11 INFO - 'ts_paint', 16:23:11 INFO - 'tpaint', 16:23:11 INFO - 'sessionrestore', 16:23:11 INFO - 'sessionrestore_no_auto_restore', 16:23:11 INFO - 'tabpaint']}, 16:23:11 INFO - 'other_l64': {'tests': ['a11yr', 16:23:11 INFO - 'ts_paint', 16:23:11 INFO - 'tpaint', 16:23:11 INFO - 'sessionrestore', 16:23:11 INFO - 'sessionrestore_no_auto_restore', 16:23:11 INFO - 'tabpaint']}, 16:23:11 INFO - 'other_nol64': {'tests': ['a11yr', 16:23:11 INFO - 'ts_paint', 16:23:11 INFO - 'tpaint', 16:23:11 INFO - 'sessionrestore', 16:23:11 INFO - 'sessionrestore_no_auto_restore', 16:23:11 INFO - 'tabpaint']}, 16:23:11 INFO - 'svgr': {'tests': ['tsvgx', 16:23:11 INFO - 'tsvgr_opacity', 16:23:11 INFO - 'tart', 16:23:11 INFO - 'tscrollx', 16:23:11 INFO - 'cart']}, 16:23:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:23:11 INFO - 'tests': ['tsvgx', 16:23:11 INFO - 'tsvgr_opacity', 16:23:11 INFO - 'tart', 16:23:11 INFO - 'tscrollx', 16:23:11 INFO - 'cart']}, 16:23:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:11 INFO - 'tests': ['tp5o']}, 16:23:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:11 INFO - 'talos_options': ['--e10s'], 16:23:11 INFO - 'tests': ['tp5o']}, 16:23:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:11 INFO - 'talos_options': ['--xperf_path', 16:23:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:23:11 INFO - 'tests': ['tp5n']}, 16:23:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:11 INFO - 'talos_options': ['--e10s', 16:23:11 INFO - '--xperf_path', 16:23:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:23:11 INFO - 'tests': ['tp5n']}}, 16:23:11 INFO - 'talos.zip': {'path': '', 16:23:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:23:11 INFO - Running post-action listener: _resource_record_post_action 16:23:11 INFO - ##### 16:23:11 INFO - ##### Running create-virtualenv step. 16:23:11 INFO - ##### 16:23:11 INFO - Running pre-action listener: _resource_record_pre_action 16:23:11 INFO - Running main action method: create_virtualenv 16:23:11 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:23:11 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 16:23:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:23:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:23:11 INFO - Using real prefix '/usr' 16:23:11 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:23:11 INFO - Installing distribute.............................................................................................................................................................................................done. 16:23:13 INFO - Installing pip.................done. 16:23:13 INFO - Return code: 0 16:23:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:23:13 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')]} 16:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:13 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')]} 16:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:13 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 0x7fea1fbebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b558d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be48b0>, '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 0x2be57b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5c60>, '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': '7de08804244eb36560b44971000001c3-1458170579.39929-1302790124', '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 16:23:13 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 16:23:13 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 16:23:13 INFO - Using env: {'DISPLAY': ':0', 16:23:13 INFO - 'HOME': '/home/cltbld', 16:23:13 INFO - 'LANG': 'en_US.UTF-8', 16:23:13 INFO - 'LANGUAGE': 'en_US:en', 16:23:13 INFO - 'LOGNAME': 'cltbld', 16:23:13 INFO - 'MAIL': '/var/mail/cltbld', 16:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:13 INFO - 'MOZ_NO_REMOTE': '1', 16:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:13 INFO - 'NO_EM_RESTART': '1', 16:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:23:13 INFO - 'PWD': '/builds/slave/test-pgo', 16:23:13 INFO - 'SHELL': '/bin/bash', 16:23:13 INFO - 'SHLVL': '1', 16:23:13 INFO - 'TERM': 'linux', 16:23:13 INFO - 'TMOUT': '86400', 16:23:13 INFO - 'USER': 'cltbld', 16:23:13 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1458170579.39929-1302790124', 16:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:13 INFO - '_': '/tools/buildbot/bin/python'} 16:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:14 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 16:23:14 INFO - Cleaning up... 16:23:14 INFO - Return code: 0 16:23:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:23:14 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')]} 16:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:14 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')]} 16:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:14 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 0x7fea1fbebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b558d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be48b0>, '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 0x2be57b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5c60>, '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': '7de08804244eb36560b44971000001c3-1458170579.39929-1302790124', '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 16:23:14 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 16:23:14 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 16:23:14 INFO - Using env: {'DISPLAY': ':0', 16:23:14 INFO - 'HOME': '/home/cltbld', 16:23:14 INFO - 'LANG': 'en_US.UTF-8', 16:23:14 INFO - 'LANGUAGE': 'en_US:en', 16:23:14 INFO - 'LOGNAME': 'cltbld', 16:23:14 INFO - 'MAIL': '/var/mail/cltbld', 16:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:14 INFO - 'MOZ_NO_REMOTE': '1', 16:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:14 INFO - 'NO_EM_RESTART': '1', 16:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:23:14 INFO - 'PWD': '/builds/slave/test-pgo', 16:23:14 INFO - 'SHELL': '/bin/bash', 16:23:14 INFO - 'SHLVL': '1', 16:23:14 INFO - 'TERM': 'linux', 16:23:14 INFO - 'TMOUT': '86400', 16:23:14 INFO - 'USER': 'cltbld', 16:23:14 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1458170579.39929-1302790124', 16:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:14 INFO - '_': '/tools/buildbot/bin/python'} 16:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:14 INFO - Downloading/unpacking psutil>=0.7.1 16:23:14 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 16:23:14 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 16:23:14 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 16:23:14 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 16:23:14 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 16:23:14 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 16:23:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:23:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:23:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:23:16 INFO - Installing collected packages: psutil 16:23:16 INFO - Running setup.py install for psutil 16:23:16 INFO - building 'psutil._psutil_linux' extension 16:23:16 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 16:23:16 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 16:23:16 INFO - building 'psutil._psutil_posix' extension 16:23:16 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 16:23:16 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 16:23:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:23:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:23:16 INFO - Successfully installed psutil 16:23:16 INFO - Cleaning up... 16:23:16 INFO - Return code: 0 16:23:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:16 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 0x7fea1fbebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b558d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be48b0>, '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 0x2be57b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5c60>, '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': '7de08804244eb36560b44971000001c3-1458170579.39929-1302790124', '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 16:23:16 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 16:23:16 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 16:23:16 INFO - Using env: {'DISPLAY': ':0', 16:23:16 INFO - 'HOME': '/home/cltbld', 16:23:16 INFO - 'LANG': 'en_US.UTF-8', 16:23:16 INFO - 'LANGUAGE': 'en_US:en', 16:23:16 INFO - 'LOGNAME': 'cltbld', 16:23:16 INFO - 'MAIL': '/var/mail/cltbld', 16:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:16 INFO - 'MOZ_NO_REMOTE': '1', 16:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:16 INFO - 'NO_EM_RESTART': '1', 16:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:23:16 INFO - 'PWD': '/builds/slave/test-pgo', 16:23:16 INFO - 'SHELL': '/bin/bash', 16:23:16 INFO - 'SHLVL': '1', 16:23:16 INFO - 'TERM': 'linux', 16:23:16 INFO - 'TMOUT': '86400', 16:23:16 INFO - 'USER': 'cltbld', 16:23:16 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1458170579.39929-1302790124', 16:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:16 INFO - '_': '/tools/buildbot/bin/python'} 16:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:23:16 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 16:23:16 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 16:23:16 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 16:23:16 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 16:23:16 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 16:23:16 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 16:23:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:23:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:23:18 INFO - Installing collected packages: mozsystemmonitor 16:23:18 INFO - Running setup.py install for mozsystemmonitor 16:23:18 INFO - Successfully installed mozsystemmonitor 16:23:18 INFO - Cleaning up... 16:23:18 INFO - Return code: 0 16:23:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:23:18 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')]} 16:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:18 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')]} 16:23:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:18 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 0x7fea1fbebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b558d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be48b0>, '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 0x2be57b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5c60>, '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': '7de08804244eb36560b44971000001c3-1458170579.39929-1302790124', '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 16:23:18 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 16:23:18 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 16:23:18 INFO - Using env: {'DISPLAY': ':0', 16:23:18 INFO - 'HOME': '/home/cltbld', 16:23:18 INFO - 'LANG': 'en_US.UTF-8', 16:23:18 INFO - 'LANGUAGE': 'en_US:en', 16:23:18 INFO - 'LOGNAME': 'cltbld', 16:23:18 INFO - 'MAIL': '/var/mail/cltbld', 16:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:18 INFO - 'MOZ_NO_REMOTE': '1', 16:23:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:18 INFO - 'NO_EM_RESTART': '1', 16:23:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:23:18 INFO - 'PWD': '/builds/slave/test-pgo', 16:23:18 INFO - 'SHELL': '/bin/bash', 16:23:18 INFO - 'SHLVL': '1', 16:23:18 INFO - 'TERM': 'linux', 16:23:18 INFO - 'TMOUT': '86400', 16:23:18 INFO - 'USER': 'cltbld', 16:23:18 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1458170579.39929-1302790124', 16:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:18 INFO - '_': '/tools/buildbot/bin/python'} 16:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:19 INFO - Downloading/unpacking blobuploader==1.2.4 16:23:19 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 16:23:19 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 16:23:19 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 16:23:19 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 16:23:19 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 16:23:19 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 16:23:21 INFO - Downloading blobuploader-1.2.4.tar.gz 16:23:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:23:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:23:21 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 16:23:21 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 16:23:21 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 16:23:21 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 16:23:21 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 16:23:21 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 16:23:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:23:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:23:21 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 16:23:21 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 16:23:21 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 16:23:21 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 16:23:21 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 16:23:21 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 16:23:21 INFO - Downloading docopt-0.6.1.tar.gz 16:23:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:23:21 INFO - Installing collected packages: blobuploader, requests, docopt 16:23:21 INFO - Running setup.py install for blobuploader 16:23:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:23:21 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:23:21 INFO - Running setup.py install for requests 16:23:22 INFO - Running setup.py install for docopt 16:23:22 INFO - Successfully installed blobuploader requests docopt 16:23:22 INFO - Cleaning up... 16:23:22 INFO - Return code: 0 16:23:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:23: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')]} 16:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23: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')]} 16:23:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:22 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 0x7fea1fbebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b558d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be48b0>, '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 0x2be57b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5c60>, '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': '7de08804244eb36560b44971000001c3-1458170579.39929-1302790124', '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 16:23:22 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 16:23:22 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 16:23:22 INFO - Using env: {'DISPLAY': ':0', 16:23:22 INFO - 'HOME': '/home/cltbld', 16:23:22 INFO - 'LANG': 'en_US.UTF-8', 16:23:22 INFO - 'LANGUAGE': 'en_US:en', 16:23:22 INFO - 'LOGNAME': 'cltbld', 16:23:22 INFO - 'MAIL': '/var/mail/cltbld', 16:23:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:22 INFO - 'MOZ_NO_REMOTE': '1', 16:23:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:22 INFO - 'NO_EM_RESTART': '1', 16:23:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:23:22 INFO - 'PWD': '/builds/slave/test-pgo', 16:23:22 INFO - 'SHELL': '/bin/bash', 16:23:22 INFO - 'SHLVL': '1', 16:23:22 INFO - 'TERM': 'linux', 16:23:22 INFO - 'TMOUT': '86400', 16:23:22 INFO - 'USER': 'cltbld', 16:23:22 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1458170579.39929-1302790124', 16:23:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:22 INFO - '_': '/tools/buildbot/bin/python'} 16:23:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:23:22 INFO - Running setup.py (path:/tmp/pip-zFWbEH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:23:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:23:22 INFO - Running setup.py (path:/tmp/pip-xoSeVh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:23:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:23:22 INFO - Running setup.py (path:/tmp/pip-9ZXmFQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:23:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:23:22 INFO - Running setup.py (path:/tmp/pip-OrPEst-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:23:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:23:22 INFO - Running setup.py (path:/tmp/pip-YQZYtU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:23:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:23:22 INFO - Running setup.py (path:/tmp/pip-Fs0hQO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:23:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:23:23 INFO - Running setup.py (path:/tmp/pip-uNCeVr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:23:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:23:23 INFO - Running setup.py (path:/tmp/pip-P0Axxa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:23:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:23:23 INFO - Running setup.py (path:/tmp/pip-E8LXbP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:23:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:23:23 INFO - Running setup.py (path:/tmp/pip-IVnFju-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:23:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:23:23 INFO - Running setup.py (path:/tmp/pip-2ivV5l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:23:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:23:23 INFO - Running setup.py (path:/tmp/pip-9lOuV2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:23:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:23:23 INFO - Running setup.py (path:/tmp/pip-2xhjrx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:23:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:23:23 INFO - Running setup.py (path:/tmp/pip-V1ba1y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:23:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:23:23 INFO - Running setup.py (path:/tmp/pip-mIL9VW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:23:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:23:23 INFO - Running setup.py (path:/tmp/pip-AsQ5JF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:23:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:23:23 INFO - Running setup.py (path:/tmp/pip-Pd5PpE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:23:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:23:23 INFO - Running setup.py install for manifestparser 16:23:23 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:23:23 INFO - Running setup.py install for mozcrash 16:23:24 INFO - Running setup.py install for mozdebug 16:23:24 INFO - Running setup.py install for mozdevice 16:23:24 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:23:24 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:23:24 INFO - Running setup.py install for mozfile 16:23:24 INFO - Running setup.py install for mozhttpd 16:23:24 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:23:24 INFO - Running setup.py install for mozinfo 16:23:24 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:23:24 INFO - Running setup.py install for mozInstall 16:23:24 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:23:24 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:23:24 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:23:24 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:23:24 INFO - Running setup.py install for mozleak 16:23:24 INFO - Running setup.py install for mozlog 16:23:24 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:23:24 INFO - Running setup.py install for moznetwork 16:23:24 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:23:24 INFO - Running setup.py install for mozprocess 16:23:25 INFO - Running setup.py install for mozprofile 16:23:25 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:23:25 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:23:25 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:23:25 INFO - Running setup.py install for mozrunner 16:23:25 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:23:25 INFO - Running setup.py install for mozscreenshot 16:23:25 INFO - Running setup.py install for moztest 16:23:25 INFO - Running setup.py install for mozversion 16:23:25 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:23:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:23:25 INFO - Cleaning up... 16:23:25 INFO - Return code: 0 16:23:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:23:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:25 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 0x7fea1fbebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b558d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be48b0>, '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 0x2be57b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5c60>, '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': '7de08804244eb36560b44971000001c3-1458170579.39929-1302790124', '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 16:23:25 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 16:23:25 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 16:23:25 INFO - Using env: {'DISPLAY': ':0', 16:23:25 INFO - 'HOME': '/home/cltbld', 16:23:25 INFO - 'LANG': 'en_US.UTF-8', 16:23:25 INFO - 'LANGUAGE': 'en_US:en', 16:23:25 INFO - 'LOGNAME': 'cltbld', 16:23:25 INFO - 'MAIL': '/var/mail/cltbld', 16:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:25 INFO - 'MOZ_NO_REMOTE': '1', 16:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:25 INFO - 'NO_EM_RESTART': '1', 16:23:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:23:25 INFO - 'PWD': '/builds/slave/test-pgo', 16:23:25 INFO - 'SHELL': '/bin/bash', 16:23:25 INFO - 'SHLVL': '1', 16:23:25 INFO - 'TERM': 'linux', 16:23:25 INFO - 'TMOUT': '86400', 16:23:25 INFO - 'USER': 'cltbld', 16:23:25 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1458170579.39929-1302790124', 16:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:25 INFO - '_': '/tools/buildbot/bin/python'} 16:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:23:25 INFO - Running setup.py (path:/tmp/pip-Zhi4a2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:23:25 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)) 16:23:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:23:25 INFO - Running setup.py (path:/tmp/pip-7x2GOJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:23:25 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)) 16:23:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:23:25 INFO - Running setup.py (path:/tmp/pip-knxhRy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:23:26 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)) 16:23:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:23:26 INFO - Running setup.py (path:/tmp/pip-NcRtsW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:23:26 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)) 16:23:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:23:26 INFO - Running setup.py (path:/tmp/pip-jOPGiX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:23:26 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)) 16:23:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:23:26 INFO - Running setup.py (path:/tmp/pip-oB0ZuK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:23:26 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)) 16:23:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:23:26 INFO - Running setup.py (path:/tmp/pip-oEnL_A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:23:26 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)) 16:23:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:23:26 INFO - Running setup.py (path:/tmp/pip-JBkZZp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:23:26 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)) 16:23:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:23:26 INFO - Running setup.py (path:/tmp/pip-yV1UVI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:23:26 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)) 16:23:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:23:26 INFO - Running setup.py (path:/tmp/pip-dFJUnM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:23:26 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)) 16:23:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:23:26 INFO - Running setup.py (path:/tmp/pip-z_eAe7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:23:26 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)) 16:23:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:23:26 INFO - Running setup.py (path:/tmp/pip-Nwd7FL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:23:26 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)) 16:23:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:23:26 INFO - Running setup.py (path:/tmp/pip-GdbS6P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:23:26 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)) 16:23:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:23:26 INFO - Running setup.py (path:/tmp/pip-qhXgrW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:23:26 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)) 16:23:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:23:26 INFO - Running setup.py (path:/tmp/pip-mlaasU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:23:26 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)) 16:23:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:23:26 INFO - Running setup.py (path:/tmp/pip-JEEjzq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:23:26 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)) 16:23:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:23:26 INFO - Running setup.py (path:/tmp/pip-ckJw_D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:23:27 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)) 16:23:27 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)) 16:23:27 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)) 16:23:27 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)) 16:23:27 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)) 16:23:27 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)) 16:23:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:23:27 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 16:23:27 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 16:23:27 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 16:23:27 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 16:23:27 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 16:23:27 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 16:23:28 INFO - Downloading blessings-1.6.tar.gz 16:23:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:23:28 INFO - Installing collected packages: blessings 16:23:28 INFO - Running setup.py install for blessings 16:23:29 INFO - Successfully installed blessings 16:23:29 INFO - Cleaning up... 16:23:29 INFO - Return code: 0 16:23:29 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:23:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:23:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:23:29 INFO - Reading from file tmpfile_stdout 16:23:29 INFO - Current package versions: 16:23:29 INFO - argparse == 1.2.1 16:23:29 INFO - blessings == 1.6 16:23:29 INFO - blobuploader == 1.2.4 16:23:29 INFO - docopt == 0.6.1 16:23:29 INFO - manifestparser == 1.1 16:23:29 INFO - mozInstall == 1.12 16:23:29 INFO - mozcrash == 0.17 16:23:29 INFO - mozdebug == 0.1 16:23:29 INFO - mozdevice == 0.48 16:23:29 INFO - mozfile == 1.2 16:23:29 INFO - mozhttpd == 0.7 16:23:29 INFO - mozinfo == 0.9 16:23:29 INFO - mozleak == 0.1 16:23:29 INFO - mozlog == 3.1 16:23:29 INFO - moznetwork == 0.27 16:23:29 INFO - mozprocess == 0.22 16:23:29 INFO - mozprofile == 0.28 16:23:29 INFO - mozrunner == 6.11 16:23:29 INFO - mozscreenshot == 0.1 16:23:29 INFO - mozsystemmonitor == 0.0 16:23:29 INFO - moztest == 0.7 16:23:29 INFO - mozversion == 1.4 16:23:29 INFO - psutil == 3.1.1 16:23:29 INFO - requests == 1.2.3 16:23:29 INFO - wsgiref == 0.1.2 16:23:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:23: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')]} 16:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23: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')]} 16:23:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:29 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 0x7fea1fbebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b558d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be48b0>, '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 0x2be57b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5c60>, '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': '7de08804244eb36560b44971000001c3-1458170579.39929-1302790124', '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 16:23:29 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 16:23:29 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 16:23:29 INFO - Using env: {'DISPLAY': ':0', 16:23:29 INFO - 'HOME': '/home/cltbld', 16:23:29 INFO - 'LANG': 'en_US.UTF-8', 16:23:29 INFO - 'LANGUAGE': 'en_US:en', 16:23:29 INFO - 'LOGNAME': 'cltbld', 16:23:29 INFO - 'MAIL': '/var/mail/cltbld', 16:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:29 INFO - 'MOZ_NO_REMOTE': '1', 16:23:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:29 INFO - 'NO_EM_RESTART': '1', 16:23:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:23:29 INFO - 'PWD': '/builds/slave/test-pgo', 16:23:29 INFO - 'SHELL': '/bin/bash', 16:23:29 INFO - 'SHLVL': '1', 16:23:29 INFO - 'TERM': 'linux', 16:23:29 INFO - 'TMOUT': '86400', 16:23:29 INFO - 'USER': 'cltbld', 16:23:29 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1458170579.39929-1302790124', 16:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:29 INFO - '_': '/tools/buildbot/bin/python'} 16:23:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:29 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)) 16:23:29 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)) 16:23:29 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)) 16:23:29 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)) 16:23:29 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)) 16:23:29 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)) 16:23:29 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)) 16:23:29 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)) 16:23:29 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)) 16:23:29 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)) 16:23:29 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)) 16:23:29 INFO - Cleaning up... 16:23:29 INFO - Return code: 0 16:23:29 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:23: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')]} 16:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23: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')]} 16:23:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:29 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 0x7fea1fbebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b558d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be48b0>, '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 0x2be57b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5c60>, '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': '7de08804244eb36560b44971000001c3-1458170579.39929-1302790124', '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 16:23:29 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 16:23:29 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 16:23:29 INFO - Using env: {'DISPLAY': ':0', 16:23:29 INFO - 'HOME': '/home/cltbld', 16:23:29 INFO - 'LANG': 'en_US.UTF-8', 16:23:29 INFO - 'LANGUAGE': 'en_US:en', 16:23:29 INFO - 'LOGNAME': 'cltbld', 16:23:29 INFO - 'MAIL': '/var/mail/cltbld', 16:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:29 INFO - 'MOZ_NO_REMOTE': '1', 16:23:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:29 INFO - 'NO_EM_RESTART': '1', 16:23:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:23:29 INFO - 'PWD': '/builds/slave/test-pgo', 16:23:29 INFO - 'SHELL': '/bin/bash', 16:23:29 INFO - 'SHLVL': '1', 16:23:29 INFO - 'TERM': 'linux', 16:23:29 INFO - 'TMOUT': '86400', 16:23:29 INFO - 'USER': 'cltbld', 16:23:29 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1458170579.39929-1302790124', 16:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:29 INFO - '_': '/tools/buildbot/bin/python'} 16:23:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:29 INFO - Downloading/unpacking jsonschema 16:23:29 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 16:23:29 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 16:23:29 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 16:23:29 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 16:23:29 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 16:23:29 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 16:23:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:23:31 INFO - Downloading/unpacking functools32 (from jsonschema) 16:23:31 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 16:23:31 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 16:23:31 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 16:23:31 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 16:23:31 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 16:23:31 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 16:23:31 INFO - Downloading functools32-3.2.3-2.tar.gz 16:23:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:23:31 INFO - warning: no files found matching '*.txt' 16:23:31 INFO - no previously-included directories found matching 'build' 16:23:31 INFO - no previously-included directories found matching 'dist' 16:23:31 INFO - no previously-included directories found matching '.git*' 16:23:31 INFO - Installing collected packages: jsonschema, functools32 16:23:31 INFO - Running setup.py install for functools32 16:23:32 INFO - warning: no files found matching '*.txt' 16:23:32 INFO - no previously-included directories found matching 'build' 16:23:32 INFO - no previously-included directories found matching 'dist' 16:23:32 INFO - no previously-included directories found matching '.git*' 16:23:32 INFO - Successfully installed jsonschema functools32 16:23:32 INFO - Cleaning up... 16:23:32 INFO - Return code: 0 16:23:32 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:23:32 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')]} 16:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:32 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')]} 16:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:32 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 0x7fea1fbebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b558d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be48b0>, '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 0x2be57b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5c60>, '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': '7de08804244eb36560b44971000001c3-1458170579.39929-1302790124', '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 16:23:32 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 16:23:32 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 16:23:32 INFO - Using env: {'DISPLAY': ':0', 16:23:32 INFO - 'HOME': '/home/cltbld', 16:23:32 INFO - 'LANG': 'en_US.UTF-8', 16:23:32 INFO - 'LANGUAGE': 'en_US:en', 16:23:32 INFO - 'LOGNAME': 'cltbld', 16:23:32 INFO - 'MAIL': '/var/mail/cltbld', 16:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:32 INFO - 'MOZ_NO_REMOTE': '1', 16:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:32 INFO - 'NO_EM_RESTART': '1', 16:23:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:23:32 INFO - 'PWD': '/builds/slave/test-pgo', 16:23:32 INFO - 'SHELL': '/bin/bash', 16:23:32 INFO - 'SHLVL': '1', 16:23:32 INFO - 'TERM': 'linux', 16:23:32 INFO - 'TMOUT': '86400', 16:23:32 INFO - 'USER': 'cltbld', 16:23:32 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1458170579.39929-1302790124', 16:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:32 INFO - '_': '/tools/buildbot/bin/python'} 16:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:32 INFO - Downloading/unpacking flake8 16:23:32 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 16:23:32 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 16:23:32 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 16:23:32 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 16:23:32 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 16:23:32 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 16:23:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:23:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:23:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:23:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:23:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:23:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:23:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:23:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:23:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:23:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:23:34 INFO - no previously-included directories found matching 'docs/_build' 16:23:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:23:34 INFO - Running setup.py install for pep8 16:23:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:23:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:23:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:23:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:23:35 INFO - no previously-included directories found matching 'docs/_build' 16:23:35 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:23:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:23:35 INFO - Cleaning up... 16:23:35 INFO - Return code: 0 16:23:35 INFO - Running post-action listener: _resource_record_post_action 16:23:35 INFO - Running post-action listener: _start_resource_monitoring 16:23:35 INFO - Starting resource monitoring. 16:23:35 INFO - ##### 16:23:35 INFO - ##### Running install step. 16:23:35 INFO - ##### 16:23:35 INFO - Running pre-action listener: _resource_record_pre_action 16:23:35 INFO - Running main action method: install 16:23:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:23:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:23:35 INFO - Reading from file tmpfile_stdout 16:23:35 INFO - Detecting whether we're running mozinstall >=1.0... 16:23:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:23:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:23:35 INFO - Reading from file tmpfile_stdout 16:23:35 INFO - Output received: 16:23:35 INFO - Usage: mozinstall [options] installer 16:23:35 INFO - Options: 16:23:35 INFO - -h, --help show this help message and exit 16:23:35 INFO - -d DEST, --destination=DEST 16:23:35 INFO - Directory to install application into. [default: 16:23:35 INFO - "/builds/slave/test-pgo"] 16:23:35 INFO - --app=APP Application being installed. [default: firefox] 16:23:35 INFO - mkdir: /builds/slave/test-pgo/build/application 16:23:35 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'] 16:23:35 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 16:23:51 INFO - Reading from file tmpfile_stdout 16:23:51 INFO - Output received: 16:23:51 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:23:51 INFO - Running post-action listener: _resource_record_post_action 16:23:51 INFO - ##### 16:23:51 INFO - ##### Running run-tests step. 16:23:51 INFO - ##### 16:23:51 INFO - Running pre-action listener: _resource_record_pre_action 16:23:51 INFO - Running main action method: run_tests 16:23:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:23:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:23:51 INFO - Python 2.7.3 16:23:51 INFO - Return code: 0 16:23:51 INFO - grabbing minidump binary from tooltool 16:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:23:51 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 0x2be48b0>, '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 0x2be57b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5c60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:23:51 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 16:23:51 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 16:23:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:23:51 INFO - Return code: 0 16:23:51 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:23:51 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:23:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:23:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:23:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:23:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:23:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:23:52 INFO - Return code: 0 16:23:52 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/X3bcZRccQUO6XPAAsqH8cA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 16:23:52 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/X3bcZRccQUO6XPAAsqH8cA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 16:23:52 INFO - Using env: {'DISPLAY': ':0', 16:23:52 INFO - 'HOME': '/home/cltbld', 16:23:52 INFO - 'LANG': 'en_US.UTF-8', 16:23:52 INFO - 'LANGUAGE': 'en_US:en', 16:23:52 INFO - 'LOGNAME': 'cltbld', 16:23:52 INFO - 'MAIL': '/var/mail/cltbld', 16:23:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:23:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:52 INFO - 'MOZ_NO_REMOTE': '1', 16:23:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:23:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:52 INFO - 'NO_EM_RESTART': '1', 16:23:52 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:23:52 INFO - 'PWD': '/builds/slave/test-pgo', 16:23:52 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:23:52 INFO - 'SHELL': '/bin/bash', 16:23:52 INFO - 'SHLVL': '1', 16:23:52 INFO - 'TERM': 'linux', 16:23:52 INFO - 'TMOUT': '86400', 16:23:52 INFO - 'USER': 'cltbld', 16:23:52 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1458170579.39929-1302790124', 16:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:52 INFO - '_': '/tools/buildbot/bin/python'} 16:23:52 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/X3bcZRccQUO6XPAAsqH8cA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 16:23:53 INFO - mozversion application_buildid: 20160316133021 16:23:53 INFO - mozversion application_changeset: f3d0a675497675ea4907f49f423fd803dd655923 16:23:53 INFO - mozversion application_display_name: Nightly 16:23:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:23:53 INFO - mozversion application_name: Firefox 16:23:53 INFO - mozversion application_remotingname: firefox 16:23:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:23:53 INFO - mozversion application_vendor: Mozilla 16:23:53 INFO - mozversion application_version: 48.0a1 16:23:53 INFO - mozversion platform_buildid: 20160316133021 16:23:53 INFO - mozversion platform_changeset: f3d0a675497675ea4907f49f423fd803dd655923 16:23:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:23:53 INFO - mozversion platform_version: 48.0a1 16:23:53 INFO - using testdate: 1458170633 16:23:53 INFO - actual date: 1458170633 16:23:53 INFO - starting webserver on 'localhost:59474' 16:23:53 INFO - SUITE-START | Running 2 tests 16:23:53 INFO - TEST-START | dromaeo_css 16:23:53 INFO - operating with platform_type : linux_ 16:23:53 INFO - Initialising browser for dromaeo_css test... 16:23:53 INFO - TEST-INFO | started process 1687 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpn4zyee/profile http://localhost:59474/getInfo.html) 16:23:57 INFO - PROCESS | 1687 | __metrics Screen width/height:1600/1200 16:23:57 INFO - PROCESS | 1687 | colorDepth:24 16:23:57 INFO - PROCESS | 1687 | Browser inner width/height: 1024/697 16:23:57 INFO - PROCESS | 1687 | __metrics 16:23:58 ERROR - PROCESS | 1687 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:23:59 INFO - TEST-INFO | 1687: exit 0 16:23:59 INFO - Browser initialized. 16:23:59 INFO - Running cycle 1/1 for dromaeo_css test... 16:23:59 INFO - TEST-INFO | started process 1780 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpn4zyee/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:24:11 INFO - PROCESS | 1780 | RSS: Main: 153018368 16:24:11 INFO - PROCESS | 1780 | 16:25:01 INFO - PROCESS | 1780 | 1458170701908 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] 16:27:09 INFO - PROCESS | 1780 | Cycle 1(1): loaded http://localhost:59474/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59474/tests/dromaeo/cssquery-ext.html) 16:27:10 INFO - PROCESS | 1780 | RSS: Main: 256741376 16:27:10 INFO - PROCESS | 1780 | 16:30:12 INFO - PROCESS | 1780 | Cycle 1(1): loaded http://localhost:59474/tests/dromaeo/cssquery-ext.html (next: http://localhost:59474/tests/dromaeo/cssquery-jquery.html) 16:30:13 INFO - PROCESS | 1780 | RSS: Main: 230957056 16:30:13 INFO - PROCESS | 1780 | 16:33:14 INFO - PROCESS | 1780 | Cycle 1(1): loaded http://localhost:59474/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59474/tests/dromaeo/cssquery-mootools.html) 16:33:15 INFO - PROCESS | 1780 | RSS: Main: 238514176 16:33:15 INFO - PROCESS | 1780 | 16:36:17 INFO - PROCESS | 1780 | Cycle 1(1): loaded http://localhost:59474/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59474/tests/dromaeo/cssquery-prototype.html) 16:36:17 INFO - PROCESS | 1780 | RSS: Main: 221650944 16:36:17 INFO - PROCESS | 1780 | 16:39:20 INFO - PROCESS | 1780 | Cycle 1(1): loaded http://localhost:59474/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59474/tests/dromaeo/cssquery-yui.html) 16:39:20 INFO - PROCESS | 1780 | RSS: Main: 216952832 16:39:20 INFO - PROCESS | 1780 | 16:42:23 INFO - PROCESS | 1780 | Cycle 1(1): loaded http://localhost:59474/tests/dromaeo/cssquery-yui.html (next: http://localhost:59474/tests/dromaeo/cssquery-dojo.html) 16:42:23 INFO - PROCESS | 1780 | RSS: Main: 269271040 16:42:23 INFO - PROCESS | 1780 | 16:42:23 INFO - PROCESS | 1780 | __start_tp_report 16:42:23 INFO - PROCESS | 1780 | _x_x_mozilla_page_load 16:42:23 INFO - PROCESS | 1780 | _x_x_mozilla_page_load_details 16:42:23 INFO - PROCESS | 1780 | |i|pagename|runs| 16:42:23 INFO - PROCESS | 1780 | |0;dojo.html;3053.8778448862045;3084.121025507731;3115.4703700370933;3121.781475296729;3155.195425166583;5176.58587313015;5214.791408343662;5255.658382205159;5306.628536002481;5320.707361095138;5153.6392452528335;5214;5299.576033917287;5307.071262529052;5342.732863356836;4711.222648263041;4742.4309082910095;4753.679333825921;4758.714477131383;4930.605551555885;4879.121758083544;4879.658423910328;4915.361003069596;4930.285108659242;4949.901001979958;4708.7645617719145;4797.880052998703;4801.2798080287885;4862.294967229732;4875.9756201219125;4729.456112547033;4737.147313483571;4739.620830333565;4739.881502962419;4766.261229509397;4609.539046095397;4702.976485117587;4711.646626503026;4717.9292310615365;4770.141374552579;5172.508611681884;5210.713410762407;5237.895242095136;5246.501582349671;5248.947510524884;5664.178694089375;5696.316442026983;5700.116481945305;5706.686132262724;5707.942920570783;5540.307461567304;5639.8590035249035;5710.14347847822;5729.5702822288495;5734.655920644775;5266.315379000744;5281.973590132063;5284.392294886099;5296.496832800878;5329.413764485904;5804.82585522435;5808.854778630568;5809.186713860063;5809.738561764731;5810.6513609183585;5460.208269800856;5507.834764957058;5570.6657600544095;5573.27547418833;5584.636998595079;5617.606767526234;5620.213170156099;5625.493705566519;5625.831225063254;5648.689322087324;5588.580856435784;5600.243967064394;5606.55147588192;5610.747516361774;5614.354349249807;5491.752871120809;5595.104783234663;5597.328320601472;5673.0923052312255;5697.945880012211;4296.484421869396;4297.78511074445;4305.892352691145;4306.547812479707;4341.587549182823;3821.980890095532;3821.980890095532;3846.1346197105986;3876.6317199865966;3878.26313000529;5181.4041385240425;5327.893442131136;5335.813246536352;5374.70439125844;5389.0299746046085;5647.661140331593;5649.096144616924;5660.915086273709;5671.574631902541;5673.375928647845;5135.6918584885025;5300.443453437333;5305.65513241638;5306.28365170697;5349.786008559692;4781.665283430196;4802.639802014863;4802.687825291345;4823.421189457287;4836.975815120902;5861.912071318934;5882.264716910387;5891.823245302648;5894.941050589525;5904.321003084614;5452.318460192476;5657.236273103243;5693.0891057431445;5714.513270812058;5764.942350576608;5814.76740930358;5850.824475265749;5855.795047173328;5879.20630714848;5888.617239879394;5557.388687244319;5571.777128914798;5574.804881829116;5575.609707320448;5575.609707320448;5484.808031718871;5608.10270356741;5658.632188907873;5662.8301150965535;5676.631018983753;5509.3664228614225;5523.447655234444;5523.475269849358;5537.584681148849;5554;5493.285872836505;5499.972500137474;5507.944920550904;5510.3938566758425;5551.111822108443;5240.895182096413;5353.544948679406;5396.865078373072;5427.402985671652;5472.699001554953;5578.60949733531;5581.748821303132;5585;5591.356993945748;5595.5803314752375;5428.430014848384;5472.425395333433;5472.425395333433;5473.72631368422;5475.5072043516275 16:42:23 INFO - PROCESS | 1780 | |1;ext.html;550.5184358580927;556.1185520949298;570.076476108704;572.3017918139869;585.9824205273842;38530;39112;39217.4117388239;39298.41052384216;39303.41044884326;42853.14293714124;43424;43492;43516.564834351644;43541;8655.740327790161;8814.955925220365;8839.055407810303;8839.558022098869;8843.938727352694;8672.826543469128;8790.64837406503;8800.295976321911;8884.644614215424;8906.910930890705;8877.46735195887;8984.416012959136;8989.640414383417;8992.910070899305;8993.10068993102;8872.423292485968;8933.731988040368;8936.821263574691;8937.821243575125;8937.865932011026;8795.07651696569;8917.286617070618;8918.063603321687;8928.553572321423;8933.106689331014;42026.57973420257;42766.78616606928;42836.78581607072;42845.57154428447;42924.356134658;3507.158282012324;3678.44823276508;3769.227308401771;4019.4573732546023;4138.379243113527;32639.347213055844;32927;33246.168845778804;33316.50025249623;33356;3975.383815508601;4031.3348297530874;4084.223997440477;4090.2228576570656;4105;303758;305724;305956;306498;306679;62278.68860655668;62857.05714414288;62927;62994.37005629885;63009.68495157495;58297.417025830044;67352;68728.6563567179;68868;68981.65509172421;14852.62868428298;14986.550403487912;14994.62513437151;15005.474808381654;15028.849711502964;10608.628697995533;11536.884631153582;11629.302241865515;11633.825492617618;11640.94179529097;20704.689429658567;21058;21218.151273948868;21251.362459126252;21315;7652.846943061108;7700.191479894643;7727.420443466763;7781.338586220121;7820.17888121739;963.5423173992298;1122.270524159303;1130.1467392119062;1144.0790163918125;1238.3189245914712;32000.679993200236;33075.50386744201;33178.50232246518;33183.170420739676;33565.328693425996;1116.7040734205443;1123.8538989931258;1211.2792888231488;1232.642533665245;1237.8514578250667;16516.926399783977;17051.744223836653;17100;17201.397951071904;17243.913780431016;408947;408989;413326;414946;415407;57907;58564;58631;58672.41327586755;58709.41290587125;1248.9937550312372;1261.3819228577931;1377.3870627570634;1385.1827421821174;1400.4258254115764;28712.712872871005;29829.701702982693;31232.375352493276;31400.842995784875;31726.20684482814;46024.539754602025;46352.30471542862;46371.304430432894;46406;46449;251825;255997;256777;256965;257018;30329.69670303269;34188.31623367569;34958.82520587381;35294.47058294076;36028;41759;41830.372544412465;42422;42919.356209657504;43349;35274.823625881705;37405.251894962494;37508.624913750515;39197.6080239194;39718;37507.46506350307;37742.8112859434;38466;38612;39193.41209881797;39052;39160.412593811685;39693.00767480836;40380.3942940862;40510;31700.207494812814;33540.1614959628;34215.82892085524;34420;34670.30659386748;27071.323216919736;27477.17568472949;27544.449111018068;27708.03630420352;27854 16:42:23 INFO - PROCESS | 1780 | |2;jquery.html;369.30939143801095;372.4320411372656;380.6897378636411;381.7938313310812;383.35787555843956;17829.10854457277;18066.096695165237;18416.079196040213;18435.907820460878;18469.630607387844;17011.82988170118;17442.12789360533;17458.21438035288;17480.650386992253;17499.475015749515;5493.533049690771;5695.401982791809;5762.078067509199;5766.711664416763;5769.538436925057;4055.7566546007333;5650.124230744241;6058.424449677295;6271.996480563088;6288.9056664150075;6172.4444799968;6219.720112594944;6242.1261023456755;6248.781292654758;6249.7187626556915;6050.636961782285;6366.490680745529;6367.713452894608;6369.076483909807;6377.107204991305;3599.8020108894;5198.558122559587;5339.359276886759;5339.6262261641705;5552.3892371839065;20760;20815.791842081537;20869;21240.5751884963;21245.15019399222;2226.4982125365955;2279.988600057006;2380.73811880693;2404.507076049423;2569.961450578243;13599.184048957095;14213.360398782079;14567.70864582713;14807.259637018105;14863.182524961123;1975.9209631614717;1991.1338567723087;2024.726661900654;2041.3161590867078;2068.5759419319;67784.6610766948;69106;73341.63329183373;75194.24805751981;76579;10548.947255263674;10584.153267738717;10782.730431739112;10923.3992130432;10924.289921155258;14042.578722638336;14098.506552270826;14141.575752727435;14159.575212743634;14161.575152745228;7439.888401673979;7765.495242809199;7795;7864.646090925922;7906.407019473562;7670.079590449071;7765.689372425039;7836.059672839296;7945.443818932735;7950.085740139958;4692.718436893797;4765.880852978634;4766.833160839424;4778.95221047792;4788.138135135709;1779.599590092219;1792.8924264544169;1842.9495187742857;1900.8194221548931;1920.1647283431753;432.03871386166156;465.2463009923945;480.7211817146047;965.4738167698621;1116.916231282657;11096.15135286078;11137.498812553455;11182.888171118184;11425.714357140972;11457.656270311903;447.86564030790635;496.5630245384039;499.2062620433528;506.4707380787013;511.66997286749836;6327.525435592349;6376;6389.105525226472;6389.424951754271;6394.9680251599375;531344;535615;537085;553385;554851;87391.56304218438;92235.53882230546;92509.53745231366;92983;94475.52762236145;487.74149700658705;488.94621591625605;489.9681520701143;491.31952246139355;491.8819483324048;10237.539310730886;10335.793284134426;10436.37381757097;10611.2041596879;10655.680329590125;35860;36161.63838361583;36289.637103629684;36575;37102.44346334861;42904.35643465413;45960.54039459563;46023;46320.305195421424;46602.06795863996;8277.503349799032;8406.915930840612;8424.326053915795;8467.407281490483;8516.403851730567;12190.390480476119;12358.258504489759;12360.876391235972;12505.56230531927;12692.365381730691;11452.713682157679;12020.699482513008;12034.939825300817;12102.152849300464;12140.696482587653;5078.138578657563;8123.700207966697;11224.607138750105;11532.135089868125;11533.88466115328;11724.58963936258;11804.350760708243;12265;12385.62843114708;12435.502579896704;8330.875036874331;8406.07533171363;8449.619767110371;8559.700410485602;8561.058283588676;10733.516991735547;11798.587049453228;11919.52321907114;11982;12096.818547721967 16:42:23 INFO - PROCESS | 1780 | |3;mootools.html;1306.203216038216;1481.1705444950828;1508;1651.8348165183475;1804.9278028878846;7856.960715196423;8056.476329038608;8060.879086813702;8074.757757267276;8081;8074.6770129194765;8240.381971352143;8267.669293228264;8275.462094963823;8287.585620718955;2054.794520547948;2107.7681455039933;2285.48576570272;2378.15575470708;2400.0879665726998;2336.1473062332298;2344.167820423742;2345.7888790008897;2347.354477518679;2348.248560460653;2259.638457846745;2281.4296425893526;2293.2317673579287;2323.8838058097112;2329.660445243983;2298.988505057464;2351.071326825903;2352.447174913894;2356.670066190735;2361.515889242701;2316.108298305148;2320.3271051395077;2323.5352929414016;2337.509123084137;2339.6607491913746;8303.335733141334;8348.958255208685;8357.58212089393;8367.079621241659;8369;4893.584045356149;4994.200927851526;5036.269740887551;5039.521245481674;5040.697558146487;3276.3447310537986;3309.851056702454;3364.327134573095;3452.361313157074;3459.930801383983;1091.650671785029;1099.4228030284164;1104.779044191165;1148.9368084755336;1177.6761390617648;11501.5974440895;11505.597304094317;11507.309561426258;11514.19400641947;11518.251313664585;4523.434570678665;4531.750753708512;4616.6537509686905;4618.376519169936;4620.953790462119;9805.754856128511;9811.166050885611;9815.950920245354;9821.165200957856;9829.45937973404;5138.3833939927445;5141.948580514222;5143.17709166539;5144.408393034774;5144.922826157611;4049.2508885855623;4497.482789479186;4607.838725644587;4662.860114196579;4674.275487299474;3811.961880381161;3877.9612203878164;3896.649301562873;3922.097917478996;3937.0354263205127;1168.363242033094;1197.6167626359656;1212.6240865331774;1240.789065858788;1248.375812093953;1116.7152376144031;1122.7586068995206;1128.5542210826677;1321.6960099177243;1401.2293238718664;7869.409794265453;7954.920450795534;7977.760667179994;7999.840003199904;8027.39794515402;482.4933819489522;483.20512756516035;487.48570258377754;490.23278569039337;494.68587446971435;5885.970570147122;5898.616589921728;5918.053111502139;5920.703964801743;5959.106134079922;9518.381305215138;10004.599816007278;10083.546240419199;10155.796884062425;10276.588936442458;10101.747456313651;10107.7473063174;10109.848352274721;10115.494225288854;10150.898491015143;7462.514936529108;7589.8861517077285;7695.422843286664;7702.114256860421;7707.113681926538;7621.275978782007;7633.847323053396;7658.425618078555;7685;7716.112647045437;8558.743237702878;8754.737357879274;8863.069377715246;8907.064758200295;8994.05562415937;8799.252063574668;8807.07525709817;9092.999770025159;9102.908970910472;9347.439153650803;6585.736570537125;6763.425108865605;6804.6257455840405;7287.27127287267;7375.704971801282;7696.268854458817;7839.686412543434;7880.172581879049;7894.368450524059;7903.723369682033;6869.381755642016;7086.645667716697;7091.326323999212;7139.714411423485;7273.927260727325;6944.93055069463;6981.476389270927;7014.508984371045;7091.716331346688;7148.678309475982;7080.256573059754;7185.676644551112;7338.339549440576;7356.006939063158;7361.079865016873;6694.631795251308;6756.831079222862;6786.21958474762;6788.4569234462115;6792.558483698544;6800.93199068003;6844.4182244509775;6881.071055407456;6924.134483189601;6929.237783843874 16:42:23 INFO - PROCESS | 1780 | |4;prototype.html;344.91549570355266;346.7815276375883;347.1667996807663;350.96990333371554;351.37630705497753;5918;5954.4640982311585;5964.284285885695;5973.133895585143;5980.970095149523;5940.821775346736;5950.880982380349;5953.613015154012;5969.3135289441725;5971.492423144038;4353.73877567347;4434.512203657611;4533.455985281771;4557.02024064826;4581.67928245023;4548.408706868103;4550.340200670901;4553.567411095941;4555.088982203556;4560.726356418625;4504.797284122206;4506.414166158411;4509.909801803962;4518;4519.16395466838;4332;4453.799579018936;4547.090581883636;4548.56788605082;4581.923248036709;4010.2981978154;4017.8593749218635;4019;4024.436578878959;4029.717919745619;5736.541076713853;5743.10981797822;5750.654960702372;5751.25233719618;5771.307443106812;5304.6286759926825;5319.5744340452675;5325;5325.4142044375085;5327.920081198785;6203.968980155116;6259.780907668255;6262.405071518198;6276.403741644582;6279;4359.476862776487;4430.180416622903;4445.799939002753;4461.754603496806;4464.6428285737065;6559.672016399209;6571.605703657796;6579.407853293226;6580.670966451707;6584.341565843425;4569.725816450957;4579.633629309647;4587.678862479661;4589.2886602576655;4589.701669391479;4639.466461356919;4643.558861908114;4650.837220697327;4651.069786042805;4651.744154071491;5301.761420736076;5307.203919412119;5312.229726689686;5314.096603577401;5317.750328672759;6150.969245153746;6321.1150438938585;6328.272248691459;6330.493560515148;6336.588121772163;1604.374294025331;1625.7154997875325;1636.2309714434198;1637.2550489527237;1638.6886491566563;1053.8840727519967;1094.5895289266525;1097.868255809308;1128.3230061962756;1145.2326940949583;6024.036154215304;6024.27708674953;6026.668533230714;6029.60807547508;6030.427109424598;6413.262474815456;6438.80683579484;6454.4513716333695;6459.354064593503;6459.709313080829;6016.368281330398;6016.578839481194;6019;6020.969895150496;6023.367546407651;3419.5554577904713;3454.29187016661;3458.602260739997;3475.374432602105;3475.8783442579893;6493.577917435352;6718.49611279156;6720.428763555153;6729.663516824237;6731.764388246388;6601.636909969998;6603.108580341688;6684.532082754161;6687.732490700415;6688.39804417595;6707.832304192337;6709.396154346132;6710.0941372915;6710.798676039727;6716.261211266659;6429.324920883427;6436.806895793134;6437.291897891322;6443.903341449788;6446.258680251831;6223.813285601439;6354.586951848115;6361.045843123568;6372.07604897278;6394.104825324552;6693.397594216543;6708.127943367331;6709.7316107355155;6710.798676039727;6716.966415167893;4533.229351010402;4579.793909274024;4580.404547408815;4593.793279302373;4597.08058388317;6401.263854656774;6403.7118329676205;6412.134361861089;6413.8717225656155;6423.454006409321;6271.686415679289;6274.341194174546;6286.308506064421;6288.654124023223;6293.3391993841815;6128.1726966858905;6335.049742538656;6339.080833279057;6353.269374021862;6354;6199.070139478934;6221.06683997404;6223.190985171898;6223.595466294676;6234.096056071753;6386.425221730066;6387.4570661492435;6388.584741991755;6394.616323020634;6397.4562162216735;5930.229070220844;6054.515638748801;6071.423214794588;6199.814005579839;6225.25296964349 16:42:23 INFO - PROCESS | 1780 | |5;yui.html;689.1970853955143;695.5617960684768;719.5610677486732;771.2634434115421;809.5385630190792;14577.271136443174;14848.777268340984;14914.627134321634;14917.254137293146;14918.17950012749;13116.54092106774;13120.540781072665;13121.015923805706;13129.949604031655;13131.73736525269;678.8811957907371;819.7171975668385;835.3734698975768;843.6498852976008;852.8592782190931;845.3406343052429;845.7800971747359;848.3594885861166;852.3266619370689;853.8121613245077;896.7802888292377;897.4166791585457;899.3344924755667;899.6086702284528;899.757065592293;715.7280233511259;874.8818909447207;891.8662200669886;895.0646574329841;895.2658819767793;644.1272076336543;644.7485480662546;645.4287955159671;645.4900628503476;646.0857886091222;14291.928540357232;14367.928160359235;14374.856251437457;14384.856151438456;14399.064060836117;14049.78925316121;14338.64153396163;14346.784798228035;14372.928135359361;14416.783748243784;11411.714707132305;11578.826317605159;11612.419379031015;11748.412579370997;12019.939900300442;3844.692424606025;3871.361225397806;3893.7079719021185;3972.8410863565423;3978.085040440686;58069.70965145147;58186.709066454394;58223.417765822225;58738.118928216114;58804.70597646984;10413.375197488174;10876.728081798019;10899.1280697544;10982.890171098186;11007.61473348429;19449.222031118596;19509.707354389695;19510.219591216475;19558.70661940072;19581.70627440561;8157.306628936607;8235.094139644634;8247.515447219557;8326.750197494084;8349.123342048997;4660.300954856799;4765.547273009059;4767.523247675274;4858.8299409521205;4865.5864251539015;3300.47192449207;3324.73402127834;3339.298747263102;3341.63242043375;3348.347072320923;594.6907608043794;604.758096761299;613.7851751886803;649.954503184782;672.3612568060264;614.8555089553952;621.9502439804804;673.4343151752552;682.8566001139717;726.1395246632757;8387.161283871565;8595.398322117517;8621.267192288726;8647.308215342757;8833.779155521035;605.4671888737882;691.6403470195571;731.7548621211954;747.4692967992786;747.5253214208908;4045.6763458923215;4326.545712700184;4382.408374869352;4393.538678438782;4568.725876447424;61441.69279153665;61562;61849;62030.37969620246;65321;58329.70835145797;59310.40689593135;59685;59967;60217.69891150516;52701.472985269655;53003.734981324844;53230;53285.934281314156;53704;8641.265492432962;8802.691905783267;8822.823543529223;8885.155910188521;8941;37409.43885841769;38218.235635287696;38590.80704596459;39148;41448.3782743253;50653.74673126611;51338.48661513337;51434.74282628563;52055.47944520506;52858.207126893896;11653.6503904883;11863.34751588671;12040.03679705604;12311.261324320569;12395.18302799599;12430.751384972431;12741.534723506915;13075.869241307846;13442.39509222107;13511.797323039966;12927;13076.150050246704;13316.667083322995;13734.313284335543;13807.378667959765;12856.357182140668;13109.803352949904;13494.595162145151;13528.188308701509;13540.255285959367;12340.321282329558;12882.162659427107;13011.869881301445;13628.65928351799;13650.658733531343;10583.508400753171;10832;10924.945375273073;10946.233763636788;10993.835092473459;10631.468426578485;10941.507632156412;10989.395583242998;10993.450327483753;11022.393768342497 16:42:23 INFO - PROCESS | 1780 | __end_tp_report 16:42:23 INFO - PROCESS | 1780 | __start_cc_report 16:42:23 INFO - PROCESS | 1780 | _x_x_mozilla_cycle_collect,813 16:42:23 INFO - PROCESS | 1780 | __end_cc_report 16:42:23 INFO - PROCESS | 1780 | __startTimestamp1458171743723__endTimestamp 16:42:23 INFO - PROCESS | 1780 | 16:42:23 INFO - PROCESS | 1780 | ------- Summary: start ------- 16:42:23 INFO - PROCESS | 1780 | Number of tests: 6 16:42:23 INFO - PROCESS | 1780 | 16:42:23 INFO - PROCESS | 1780 | [#0] dojo.html Cycles:165 Average:5240.37 Median:5472.43 stddev:595.84 (10.9%) stddev-sans-first:572.45 16:42:23 INFO - PROCESS | 1780 | Values: 3053.9 3084.1 3115.5 3121.8 3155.2 5176.6 5214.8 5255.7 5306.6 5320.7 5153.6 5214.0 5299.6 5307.1 5342.7 4711.2 4742.4 4753.7 4758.7 4930.6 4879.1 4879.7 4915.4 4930.3 4949.9 4708.8 4797.9 4801.3 4862.3 4876.0 4729.5 4737.1 4739.6 4739.9 4766.3 4609.5 4703.0 4711.6 4717.9 4770.1 5172.5 5210.7 5237.9 5246.5 5248.9 5664.2 5696.3 5700.1 5706.7 5707.9 5540.3 5639.9 5710.1 5729.6 5734.7 5266.3 5282.0 5284.4 5296.5 5329.4 5804.8 5808.9 5809.2 5809.7 5810.7 5460.2 5507.8 5570.7 5573.3 5584.6 5617.6 5620.2 5625.5 5625.8 5648.7 5588.6 5600.2 5606.6 5610.7 5614.4 5491.8 5595.1 5597.3 5673.1 5697.9 4296.5 4297.8 4305.9 4306.5 4341.6 3822.0 3822.0 3846.1 3876.6 3878.3 5181.4 5327.9 5335.8 5374.7 5389.0 5647.7 5649.1 5660.9 5671.6 5673.4 5135.7 5300.4 5305.7 5306.3 5349.8 4781.7 4802.6 4802.7 4823.4 4837.0 5861.9 5882.3 5891.8 5894.9 5904.3 5452.3 5657.2 5693.1 5714.5 5764.9 5814.8 5850.8 5855.8 5879.2 5888.6 5557.4 5571.8 5574.8 5575.6 5575.6 5484.8 5608.1 5658.6 5662.8 5676.6 5509.4 5523.4 5523.5 5537.6 5554.0 5493.3 5500.0 5507.9 5510.4 5551.1 5240.9 5353.5 5396.9 5427.4 5472.7 5578.6 5581.7 5585.0 5591.4 5595.6 5428.4 5472.4 5472.4 5473.7 5475.5 16:42:23 INFO - PROCESS | 1780 | 16:42:23 INFO - PROCESS | 1780 | [#1] ext.html Cycles:180 Average:50337.00 Median:39257.91 stddev:86987.35 (221.6%) stddev-sans-first:87151.05 16:42:23 INFO - PROCESS | 1780 | Values: 550.5 556.1 570.1 572.3 586.0 38530.0 39112.0 39217.4 39298.4 39303.4 42853.1 43424.0 43492.0 43516.6 43541.0 8655.7 8815.0 8839.1 8839.6 8843.9 8672.8 8790.6 8800.3 8884.6 8906.9 8877.5 8984.4 8989.6 8992.9 8993.1 8872.4 8933.7 8936.8 8937.8 8937.9 8795.1 8917.3 8918.1 8928.6 8933.1 42026.6 42766.8 42836.8 42845.6 42924.4 3507.2 3678.4 3769.2 4019.5 4138.4 32639.3 32927.0 33246.2 33316.5 33356.0 3975.4 4031.3 4084.2 4090.2 4105.0 303758.0 305724.0 305956.0 306498.0 306679.0 62278.7 62857.1 62927.0 62994.4 63009.7 58297.4 67352.0 68728.7 68868.0 68981.7 14852.6 14986.6 14994.6 15005.5 15028.8 10608.6 11536.9 11629.3 11633.8 11640.9 20704.7 21058.0 21218.2 21251.4 21315.0 7652.8 7700.2 7727.4 7781.3 7820.2 963.5 1122.3 1130.1 1144.1 1238.3 32000.7 33075.5 33178.5 33183.2 33565.3 1116.7 1123.9 1211.3 1232.6 1237.9 16516.9 17051.7 17100.0 17201.4 17243.9 408947.0 408989.0 413326.0 414946.0 415407.0 57907.0 58564.0 58631.0 58672.4 58709.4 1249.0 1261.4 1377.4 1385.2 1400.4 28712.7 29829.7 31232.4 31400.8 31726.2 46024.5 46352.3 46371.3 46406.0 46449.0 251825.0 255997.0 256777.0 256965.0 257018.0 30329.7 34188.3 34958.8 35294.5 36028.0 41759.0 41830.4 42422.0 42919.4 43349.0 35274.8 37405.3 37508.6 39197.6 39718.0 37507.5 37742.8 38466.0 38612.0 39193.4 39052.0 39160.4 39693.0 40380.4 40510.0 31700.2 33540.2 34215.8 34420.0 34670.3 27071.3 27477.2 27544.4 27708.0 27854.0 16:42:23 INFO - PROCESS | 1780 | 16:42:23 INFO - PROCESS | 1780 | [#2] jquery.html Cycles:180 Average:29023.25 Median:23480.06 stddev:89092.77 (379.4%) stddev-sans-first:89316.72 16:42:23 INFO - PROCESS | 1780 | Values: 369.3 372.4 380.7 381.8 383.4 17829.1 18066.1 18416.1 18435.9 18469.6 17011.8 17442.1 17458.2 17480.7 17499.5 5493.5 5695.4 5762.1 5766.7 5769.5 4055.8 5650.1 6058.4 6272.0 6288.9 6172.4 6219.7 6242.1 6248.8 6249.7 6050.6 6366.5 6367.7 6369.1 6377.1 3599.8 5198.6 5339.4 5339.6 5552.4 20760.0 20815.8 20869.0 21240.6 21245.2 2226.5 2280.0 2380.7 2404.5 2570.0 13599.2 14213.4 14567.7 14807.3 14863.2 1975.9 1991.1 2024.7 2041.3 2068.6 67784.7 69106.0 73341.6 75194.2 76579.0 10548.9 10584.2 10782.7 10923.4 10924.3 14042.6 14098.5 14141.6 14159.6 14161.6 7439.9 7765.5 7795.0 7864.6 7906.4 7670.1 7765.7 7836.1 7945.4 7950.1 4692.7 4765.9 4766.8 4779.0 4788.1 1779.6 1792.9 1842.9 1900.8 1920.2 432.0 465.2 480.7 965.5 1116.9 11096.2 11137.5 11182.9 11425.7 11457.7 447.9 496.6 499.2 506.5 511.7 6327.5 6376.0 6389.1 6389.4 6395.0 531344.0 535615.0 537085.0 553385.0 554851.0 87391.6 92235.5 92509.5 92983.0 94475.5 487.7 488.9 490.0 491.3 491.9 10237.5 10335.8 10436.4 10611.2 10655.7 35860.0 36161.6 36289.6 36575.0 37102.4 42904.4 45960.5 46023.0 46320.3 46602.1 8277.5 8406.9 8424.3 8467.4 8516.4 12190.4 12358.3 12360.9 12505.6 12692.4 11452.7 12020.7 12034.9 12102.2 12140.7 5078.1 8123.7 11224.6 11532.1 11533.9 11724.6 11804.4 12265.0 12385.6 12435.5 8330.9 8406.1 8449.6 8559.7 8561.1 10733.5 11798.6 11919.5 11982.0 12096.8 16:42:23 INFO - PROCESS | 1780 | 16:42:23 INFO - PROCESS | 1780 | [#3] mootools.html Cycles:180 Average:5737.64 Median:5142.56 stddev:3043.18 (59.2%) stddev-sans-first:3033.48 16:42:23 INFO - PROCESS | 1780 | Values: 1306.2 1481.2 1508.0 1651.8 1804.9 7857.0 8056.5 8060.9 8074.8 8081.0 8074.7 8240.4 8267.7 8275.5 8287.6 2054.8 2107.8 2285.5 2378.2 2400.1 2336.1 2344.2 2345.8 2347.4 2348.2 2259.6 2281.4 2293.2 2323.9 2329.7 2299.0 2351.1 2352.4 2356.7 2361.5 2316.1 2320.3 2323.5 2337.5 2339.7 8303.3 8349.0 8357.6 8367.1 8369.0 4893.6 4994.2 5036.3 5039.5 5040.7 3276.3 3309.9 3364.3 3452.4 3459.9 1091.7 1099.4 1104.8 1148.9 1177.7 11501.6 11505.6 11507.3 11514.2 11518.3 4523.4 4531.8 4616.7 4618.4 4621.0 9805.8 9811.2 9816.0 9821.2 9829.5 5138.4 5141.9 5143.2 5144.4 5144.9 4049.3 4497.5 4607.8 4662.9 4674.3 3812.0 3878.0 3896.6 3922.1 3937.0 1168.4 1197.6 1212.6 1240.8 1248.4 1116.7 1122.8 1128.6 1321.7 1401.2 7869.4 7954.9 7977.8 7999.8 8027.4 482.5 483.2 487.5 490.2 494.7 5886.0 5898.6 5918.1 5920.7 5959.1 9518.4 10004.6 10083.5 10155.8 10276.6 10101.7 10107.7 10109.8 10115.5 10150.9 7462.5 7589.9 7695.4 7702.1 7707.1 7621.3 7633.8 7658.4 7685.0 7716.1 8558.7 8754.7 8863.1 8907.1 8994.1 8799.3 8807.1 9093.0 9102.9 9347.4 6585.7 6763.4 6804.6 7287.3 7375.7 7696.3 7839.7 7880.2 7894.4 7903.7 6869.4 7086.6 7091.3 7139.7 7273.9 6944.9 6981.5 7014.5 7091.7 7148.7 7080.3 7185.7 7338.3 7356.0 7361.1 6694.6 6756.8 6786.2 6788.5 6792.6 6800.9 6844.4 6881.1 6924.1 6929.2 16:42:23 INFO - PROCESS | 1780 | 16:42:23 INFO - PROCESS | 1780 | [#4] prototype.html Cycles:180 Average:5277.62 Median:5998.67 stddev:1570.46 (26.2%) stddev-sans-first:1530.61 16:42:23 INFO - PROCESS | 1780 | Values: 344.9 346.8 347.2 351.0 351.4 5918.0 5954.5 5964.3 5973.1 5981.0 5940.8 5950.9 5953.6 5969.3 5971.5 4353.7 4434.5 4533.5 4557.0 4581.7 4548.4 4550.3 4553.6 4555.1 4560.7 4504.8 4506.4 4509.9 4518.0 4519.2 4332.0 4453.8 4547.1 4548.6 4581.9 4010.3 4017.9 4019.0 4024.4 4029.7 5736.5 5743.1 5750.7 5751.3 5771.3 5304.6 5319.6 5325.0 5325.4 5327.9 6204.0 6259.8 6262.4 6276.4 6279.0 4359.5 4430.2 4445.8 4461.8 4464.6 6559.7 6571.6 6579.4 6580.7 6584.3 4569.7 4579.6 4587.7 4589.3 4589.7 4639.5 4643.6 4650.8 4651.1 4651.7 5301.8 5307.2 5312.2 5314.1 5317.8 6151.0 6321.1 6328.3 6330.5 6336.6 1604.4 1625.7 1636.2 1637.3 1638.7 1053.9 1094.6 1097.9 1128.3 1145.2 6024.0 6024.3 6026.7 6029.6 6030.4 6413.3 6438.8 6454.5 6459.4 6459.7 6016.4 6016.6 6019.0 6021.0 6023.4 3419.6 3454.3 3458.6 3475.4 3475.9 6493.6 6718.5 6720.4 6729.7 6731.8 6601.6 6603.1 6684.5 6687.7 6688.4 6707.8 6709.4 6710.1 6710.8 6716.3 6429.3 6436.8 6437.3 6443.9 6446.3 6223.8 6354.6 6361.0 6372.1 6394.1 6693.4 6708.1 6709.7 6710.8 6717.0 4533.2 4579.8 4580.4 4593.8 4597.1 6401.3 6403.7 6412.1 6413.9 6423.5 6271.7 6274.3 6286.3 6288.7 6293.3 6128.2 6335.0 6339.1 6353.3 6354.0 6199.1 6221.1 6223.2 6223.6 6234.1 6386.4 6387.5 6388.6 6394.6 6397.5 5930.2 6054.5 6071.4 6199.8 6225.3 16:42:23 INFO - PROCESS | 1780 | 16:42:23 INFO - PROCESS | 1780 | [#5] yui.html Cycles:180 Average:15509.01 Median:4712.92 stddev:18327.75 (388.9%) stddev-sans-first:18345.37 16:42:23 INFO - PROCESS | 1780 | Values: 689.2 695.6 719.6 771.3 809.5 14577.3 14848.8 14914.6 14917.3 14918.2 13116.5 13120.5 13121.0 13129.9 13131.7 678.9 819.7 835.4 843.6 852.9 845.3 845.8 848.4 852.3 853.8 896.8 897.4 899.3 899.6 899.8 715.7 874.9 891.9 895.1 895.3 644.1 644.7 645.4 645.5 646.1 14291.9 14367.9 14374.9 14384.9 14399.1 14049.8 14338.6 14346.8 14372.9 14416.8 11411.7 11578.8 11612.4 11748.4 12019.9 3844.7 3871.4 3893.7 3972.8 3978.1 58069.7 58186.7 58223.4 58738.1 58804.7 10413.4 10876.7 10899.1 10982.9 11007.6 19449.2 19509.7 19510.2 19558.7 19581.7 8157.3 8235.1 8247.5 8326.8 8349.1 4660.3 4765.5 4767.5 4858.8 4865.6 3300.5 3324.7 3339.3 3341.6 3348.3 594.7 604.8 613.8 650.0 672.4 614.9 622.0 673.4 682.9 726.1 8387.2 8595.4 8621.3 8647.3 8833.8 605.5 691.6 731.8 747.5 747.5 4045.7 4326.5 4382.4 4393.5 4568.7 61441.7 61562.0 61849.0 62030.4 65321.0 58329.7 59310.4 59685.0 59967.0 60217.7 52701.5 53003.7 53230.0 53285.9 53704.0 8641.3 8802.7 8822.8 8885.2 8941.0 37409.4 38218.2 38590.8 39148.0 41448.4 50653.7 51338.5 51434.7 52055.5 52858.2 11653.7 11863.3 12040.0 12311.3 12395.2 12430.8 12741.5 13075.9 13442.4 13511.8 12927.0 13076.2 13316.7 13734.3 13807.4 12856.4 13109.8 13494.6 13528.2 13540.3 12340.3 12882.2 13011.9 13628.7 13650.7 10583.5 10832.0 10924.9 10946.2 10993.8 10631.5 10941.5 10989.4 10993.5 11022.4 16:42:23 INFO - PROCESS | 1780 | -------- Summary: end -------- 16:42:23 INFO - PROCESS | 1780 | 16:42:24 INFO - TEST-INFO | 1780: exit 0 16:42:24 INFO - TEST-OK | dromaeo_css | took 1111315ms 16:42:24 INFO - TEST-START | kraken 16:42:24 INFO - operating with platform_type : linux_ 16:42:24 INFO - Initialising browser for kraken test... 16:42:24 INFO - TEST-INFO | started process 1964 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbLiBfO/profile http://localhost:59474/getInfo.html) 16:42:28 INFO - PROCESS | 1964 | __metrics Screen width/height:1600/1200 16:42:28 INFO - PROCESS | 1964 | colorDepth:24 16:42:28 INFO - PROCESS | 1964 | Browser inner width/height: 1024/697 16:42:28 INFO - PROCESS | 1964 | __metrics 16:42:29 ERROR - PROCESS | 1964 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:42:30 INFO - TEST-INFO | 1964: exit 0 16:42:30 INFO - Browser initialized. 16:42:30 INFO - Running cycle 1/1 for kraken test... 16:42:30 INFO - TEST-INFO | started process 2044 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbLiBfO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:42:42 INFO - PROCESS | 2044 | RSS: Main: 153436160 16:42:42 INFO - PROCESS | 2044 | 16:42:44 INFO - PROCESS | 2044 | Cycle 1(1): loaded http://localhost:59474/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59474/tests/kraken/driver.html?testName=audio-beat-detection) 16:42:45 INFO - PROCESS | 2044 | RSS: Main: 195317760 16:42:45 INFO - PROCESS | 2044 | 16:42:47 INFO - PROCESS | 2044 | Cycle 1(1): loaded http://localhost:59474/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59474/tests/kraken/driver.html?testName=audio-dft) 16:42:48 INFO - PROCESS | 2044 | RSS: Main: 185298944 16:42:48 INFO - PROCESS | 2044 | 16:42:51 INFO - PROCESS | 2044 | Cycle 1(1): loaded http://localhost:59474/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59474/tests/kraken/driver.html?testName=audio-fft) 16:42:51 INFO - PROCESS | 2044 | RSS: Main: 170024960 16:42:51 INFO - PROCESS | 2044 | 16:42:53 INFO - PROCESS | 2044 | Cycle 1(1): loaded http://localhost:59474/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59474/tests/kraken/driver.html?testName=audio-oscillator) 16:42:54 INFO - PROCESS | 2044 | RSS: Main: 173223936 16:42:54 INFO - PROCESS | 2044 | 16:42:56 INFO - PROCESS | 2044 | Cycle 1(1): loaded http://localhost:59474/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59474/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:42:57 INFO - PROCESS | 2044 | RSS: Main: 174116864 16:42:57 INFO - PROCESS | 2044 | 16:43:00 INFO - PROCESS | 2044 | Cycle 1(1): loaded http://localhost:59474/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59474/tests/kraken/driver.html?testName=imaging-darkroom) 16:43:00 INFO - PROCESS | 2044 | RSS: Main: 175263744 16:43:00 INFO - PROCESS | 2044 | 16:43:04 INFO - PROCESS | 2044 | Cycle 1(1): loaded http://localhost:59474/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59474/tests/kraken/driver.html?testName=imaging-desaturate) 16:43:04 INFO - PROCESS | 2044 | RSS: Main: 175276032 16:43:04 INFO - PROCESS | 2044 | 16:43:07 INFO - PROCESS | 2044 | Cycle 1(1): loaded http://localhost:59474/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59474/tests/kraken/driver.html?testName=json-parse-financial) 16:43:08 INFO - PROCESS | 2044 | RSS: Main: 173821952 16:43:08 INFO - PROCESS | 2044 | 16:43:09 INFO - PROCESS | 2044 | Cycle 1(1): loaded http://localhost:59474/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59474/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:43:10 INFO - PROCESS | 2044 | RSS: Main: 184365056 16:43:10 INFO - PROCESS | 2044 | 16:43:12 INFO - PROCESS | 2044 | Cycle 1(1): loaded http://localhost:59474/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59474/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:43:12 INFO - PROCESS | 2044 | RSS: Main: 181977088 16:43:12 INFO - PROCESS | 2044 | 16:43:14 INFO - PROCESS | 2044 | Cycle 1(1): loaded http://localhost:59474/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59474/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:43:15 INFO - PROCESS | 2044 | RSS: Main: 191987712 16:43:15 INFO - PROCESS | 2044 | 16:43:17 INFO - PROCESS | 2044 | Cycle 1(1): loaded http://localhost:59474/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59474/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:43:18 INFO - PROCESS | 2044 | RSS: Main: 199462912 16:43:18 INFO - PROCESS | 2044 | 16:43:20 INFO - PROCESS | 2044 | Cycle 1(1): loaded http://localhost:59474/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59474/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:43:21 INFO - PROCESS | 2044 | RSS: Main: 196935680 16:43:21 INFO - PROCESS | 2044 | 16:43:22 INFO - PROCESS | 2044 | Cycle 1(1): loaded http://localhost:59474/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59474/tests/kraken/driver.html?testName=ai-astar) 16:43:23 INFO - PROCESS | 2044 | RSS: Main: 257966080 16:43:23 INFO - PROCESS | 2044 | 16:43:23 INFO - PROCESS | 2044 | __start_tp_report 16:43:23 INFO - PROCESS | 2044 | _x_x_mozilla_page_load 16:43:23 INFO - PROCESS | 2044 | _x_x_mozilla_page_load_details 16:43:23 INFO - PROCESS | 2044 | |i|pagename|runs| 16:43:23 INFO - PROCESS | 2044 | |0;ai-astar;108;109;105;108;109;111;99;110;110;110 16:43:23 INFO - PROCESS | 2044 | |1;audio-beat-detection;146;132;153;167;128;151;160;127;173;124 16:43:23 INFO - PROCESS | 2044 | |2;audio-dft;161;161;160;161;162;159;162;165;160;161 16:43:23 INFO - PROCESS | 2044 | |3;audio-fft;72;76;106;92;75;76;76;111;100;76 16:43:23 INFO - PROCESS | 2044 | |4;audio-oscillator;93;93;144;92;92;92;142;93;101;149 16:43:23 INFO - PROCESS | 2044 | |5;imaging-gaussian-blur;117;116;116;117;117;117;117;116;127;117 16:43:23 INFO - PROCESS | 2044 | |6;imaging-darkroom;145;145;145;146;145;146;145;145;145;146 16:43:23 INFO - PROCESS | 2044 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;94;95 16:43:23 INFO - PROCESS | 2044 | |8;json-parse-financial;57;58;58;56;55;56;58;65;55;56 16:43:23 INFO - PROCESS | 2044 | |9;json-stringify-tinderbox;60;60;60;61;61;61;60;60;61;60 16:43:23 INFO - PROCESS | 2044 | |10;stanford-crypto-aes;78;80;78;87;78;78;77;77;81;79 16:43:23 INFO - PROCESS | 2044 | |11;stanford-crypto-ccm;110;111;109;108;114;120;108;110;113;107 16:43:23 INFO - PROCESS | 2044 | |12;stanford-crypto-pbkdf2;143;134;142;140;143;133;141;144;144;142 16:43:23 INFO - PROCESS | 2044 | |13;stanford-crypto-sha256-iterative;64;65;66;63;65;64;64;64;63;65 16:43:23 INFO - PROCESS | 2044 | __end_tp_report 16:43:23 INFO - PROCESS | 2044 | __start_cc_report 16:43:23 INFO - PROCESS | 2044 | _x_x_mozilla_cycle_collect,1033 16:43:23 INFO - PROCESS | 2044 | __end_cc_report 16:43:23 INFO - PROCESS | 2044 | __startTimestamp1458171803100__endTimestamp 16:43:23 INFO - PROCESS | 2044 | 16:43:23 INFO - PROCESS | 2044 | ------- Summary: start ------- 16:43:23 INFO - PROCESS | 2044 | Number of tests: 14 16:43:23 INFO - PROCESS | 2044 | 16:43:23 INFO - PROCESS | 2044 | [#0] ai-astar Cycles:10 Average:107.90 Median:110.00 stddev:3.54 (3.2%) stddev-sans-first:3.76 16:43:23 INFO - PROCESS | 2044 | Values: 108.0 109.0 105.0 108.0 109.0 111.0 99.0 110.0 110.0 110.0 16:43:23 INFO - PROCESS | 2044 | 16:43:23 INFO - PROCESS | 2044 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:152.00 stddev:17.65 (11.6%) stddev-sans-first:18.72 16:43:23 INFO - PROCESS | 2044 | Values: 146.0 132.0 153.0 167.0 128.0 151.0 160.0 127.0 173.0 124.0 16:43:23 INFO - PROCESS | 2044 | 16:43:23 INFO - PROCESS | 2044 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.62 (1.0%) stddev-sans-first:1.72 16:43:23 INFO - PROCESS | 2044 | Values: 161.0 161.0 160.0 161.0 162.0 159.0 162.0 165.0 160.0 161.0 16:43:23 INFO - PROCESS | 2044 | 16:43:23 INFO - PROCESS | 2044 | [#3] audio-fft Cycles:10 Average:86.00 Median:76.00 stddev:14.81 (19.5%) stddev-sans-first:14.82 16:43:23 INFO - PROCESS | 2044 | Values: 72.0 76.0 106.0 92.0 75.0 76.0 76.0 111.0 100.0 76.0 16:43:23 INFO - PROCESS | 2044 | 16:43:23 INFO - PROCESS | 2044 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:92.00 stddev:24.97 (27.1%) stddev-sans-first:25.80 16:43:23 INFO - PROCESS | 2044 | Values: 93.0 93.0 144.0 92.0 92.0 92.0 142.0 93.0 101.0 149.0 16:43:23 INFO - PROCESS | 2044 | 16:43:23 INFO - PROCESS | 2044 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:117.00 stddev:3.30 (2.8%) stddev-sans-first:3.49 16:43:23 INFO - PROCESS | 2044 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 117.0 116.0 127.0 117.0 16:43:23 INFO - PROCESS | 2044 | 16:43:23 INFO - PROCESS | 2044 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 16:43:23 INFO - PROCESS | 2044 | Values: 145.0 145.0 145.0 146.0 145.0 146.0 145.0 145.0 145.0 146.0 16:43:23 INFO - PROCESS | 2044 | 16:43:23 INFO - PROCESS | 2044 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:43:23 INFO - PROCESS | 2044 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 16:43:23 INFO - PROCESS | 2044 | 16:43:23 INFO - PROCESS | 2044 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:57.50 stddev:2.91 (5.1%) stddev-sans-first:3.09 16:43:23 INFO - PROCESS | 2044 | Values: 57.0 58.0 58.0 56.0 55.0 56.0 58.0 65.0 55.0 56.0 16:43:23 INFO - PROCESS | 2044 | 16:43:23 INFO - PROCESS | 2044 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 16:43:23 INFO - PROCESS | 2044 | Values: 60.0 60.0 60.0 61.0 61.0 61.0 60.0 60.0 61.0 60.0 16:43:23 INFO - PROCESS | 2044 | 16:43:23 INFO - PROCESS | 2044 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:78.50 stddev:2.98 (3.8%) stddev-sans-first:3.13 16:43:23 INFO - PROCESS | 2044 | Values: 78.0 80.0 78.0 87.0 78.0 78.0 77.0 77.0 81.0 79.0 16:43:23 INFO - PROCESS | 2044 | 16:43:23 INFO - PROCESS | 2044 | [#11] stanford-crypto-ccm Cycles:10 Average:111.00 Median:110.50 stddev:3.86 (3.5%) stddev-sans-first:4.08 16:43:23 INFO - PROCESS | 2044 | Values: 110.0 111.0 109.0 108.0 114.0 120.0 108.0 110.0 113.0 107.0 16:43:23 INFO - PROCESS | 2044 | 16:43:23 INFO - PROCESS | 2044 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.60 Median:142.50 stddev:3.95 (2.8%) stddev-sans-first:4.09 16:43:23 INFO - PROCESS | 2044 | Values: 143.0 134.0 142.0 140.0 143.0 133.0 141.0 144.0 144.0 142.0 16:43:23 INFO - PROCESS | 2044 | 16:43:23 INFO - PROCESS | 2044 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.50 stddev:0.95 (1.5%) stddev-sans-first:1.00 16:43:23 INFO - PROCESS | 2044 | Values: 64.0 65.0 66.0 63.0 65.0 64.0 64.0 64.0 63.0 65.0 16:43:23 INFO - PROCESS | 2044 | -------- Summary: end -------- 16:43:23 INFO - PROCESS | 2044 | 16:43:24 INFO - TEST-INFO | 2044: exit 0 16:43:24 INFO - TEST-OK | kraken | took 59637ms 16:43:24 INFO - SUITE-END | took 1170s 16:43:24 INFO - Completed test suite (00:19:31) 16:43:24 INFO - javascript benchmark 16:43:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3053.8778448862045, 3084.121025507731, 3115.4703700370933, 3121.781475296729, 3155.195425166583, 5176.58587313015, 5214.791408343662, 5255.658382205159, 5306.628536002481, 5320.707361095138, 5153.6392452528335, 5214.0, 5299.576033917287, 5307.071262529052, 5342.732863356836, 4711.222648263041, 4742.4309082910095, 4753.679333825921, 4758.714477131383, 4930.605551555885, 4879.121758083544, 4879.658423910328, 4915.361003069596, 4930.285108659242, 4949.901001979958, 4708.7645617719145, 4797.880052998703, 4801.2798080287885, 4862.294967229732, 4875.9756201219125, 4729.456112547033, 4737.147313483571, 4739.620830333565, 4739.881502962419, 4766.261229509397, 4609.539046095397, 4702.976485117587, 4711.646626503026, 4717.9292310615365, 4770.141374552579, 5172.508611681884, 5210.713410762407, 5237.895242095136, 5246.501582349671, 5248.947510524884, 5664.178694089375, 5696.316442026983, 5700.116481945305, 5706.686132262724, 5707.942920570783, 5540.307461567304, 5639.8590035249035, 5710.14347847822, 5729.5702822288495, 5734.655920644775, 5266.315379000744, 5281.973590132063, 5284.392294886099, 5296.496832800878, 5329.413764485904, 5804.82585522435, 5808.854778630568, 5809.186713860063, 5809.738561764731, 5810.6513609183585, 5460.208269800856, 5507.834764957058, 5570.6657600544095, 5573.27547418833, 5584.636998595079, 5617.606767526234, 5620.213170156099, 5625.493705566519, 5625.831225063254, 5648.689322087324, 5588.580856435784, 5600.243967064394, 5606.55147588192, 5610.747516361774, 5614.354349249807, 5491.752871120809, 5595.104783234663, 5597.328320601472, 5673.0923052312255, 5697.945880012211, 4296.484421869396, 4297.78511074445, 4305.892352691145, 4306.547812479707, 4341.587549182823, 3821.980890095532, 3821.980890095532, 3846.1346197105986, 3876.6317199865966, 3878.26313000529, 5181.4041385240425, 5327.893442131136, 5335.813246536352, 5374.70439125844, 5389.0299746046085, 5647.661140331593, 5649.096144616924, 5660.915086273709, 5671.574631902541, 5673.375928647845, 5135.6918584885025, 5300.443453437333, 5305.65513241638, 5306.28365170697, 5349.786008559692, 4781.665283430196, 4802.639802014863, 4802.687825291345, 4823.421189457287, 4836.975815120902, 5861.912071318934, 5882.264716910387, 5891.823245302648, 5894.941050589525, 5904.321003084614, 5452.318460192476, 5657.236273103243, 5693.0891057431445, 5714.513270812058, 5764.942350576608, 5814.76740930358, 5850.824475265749, 5855.795047173328, 5879.20630714848, 5888.617239879394, 5557.388687244319, 5571.777128914798, 5574.804881829116, 5575.609707320448, 5575.609707320448, 5484.808031718871, 5608.10270356741, 5658.632188907873, 5662.8301150965535, 5676.631018983753, 5509.3664228614225, 5523.447655234444, 5523.475269849358, 5537.584681148849, 5554.0, 5493.285872836505, 5499.972500137474, 5507.944920550904, 5510.3938566758425, 5551.111822108443, 5240.895182096413, 5353.544948679406, 5396.865078373072, 5427.402985671652, 5472.699001554953, 5578.60949733531, 5581.748821303132, 5585.0, 5591.356993945748, 5595.5803314752375, 5428.430014848384, 5472.425395333433, 5472.425395333433, 5473.72631368422, 5475.5072043516275], "unit": "score", "name": "dojo.html", "value": 5200.532812726551}, {"lowerIsBetter": false, "replicates": [550.5184358580927, 556.1185520949298, 570.076476108704, 572.3017918139869, 585.9824205273842, 38530.0, 39112.0, 39217.4117388239, 39298.41052384216, 39303.41044884326, 42853.14293714124, 43424.0, 43492.0, 43516.564834351644, 43541.0, 8655.740327790161, 8814.955925220365, 8839.055407810303, 8839.558022098869, 8843.938727352694, 8672.826543469128, 8790.64837406503, 8800.295976321911, 8884.644614215424, 8906.910930890705, 8877.46735195887, 8984.416012959136, 8989.640414383417, 8992.910070899305, 8993.10068993102, 8872.423292485968, 8933.731988040368, 8936.821263574691, 8937.821243575125, 8937.865932011026, 8795.07651696569, 8917.286617070618, 8918.063603321687, 8928.553572321423, 8933.106689331014, 42026.57973420257, 42766.78616606928, 42836.78581607072, 42845.57154428447, 42924.356134658, 3507.158282012324, 3678.44823276508, 3769.227308401771, 4019.4573732546023, 4138.379243113527, 32639.347213055844, 32927.0, 33246.168845778804, 33316.50025249623, 33356.0, 3975.383815508601, 4031.3348297530874, 4084.223997440477, 4090.2228576570656, 4105.0, 303758.0, 305724.0, 305956.0, 306498.0, 306679.0, 62278.68860655668, 62857.05714414288, 62927.0, 62994.37005629885, 63009.68495157495, 58297.417025830044, 67352.0, 68728.6563567179, 68868.0, 68981.65509172421, 14852.62868428298, 14986.550403487912, 14994.62513437151, 15005.474808381654, 15028.849711502964, 10608.628697995533, 11536.884631153582, 11629.302241865515, 11633.825492617618, 11640.94179529097, 20704.689429658567, 21058.0, 21218.151273948868, 21251.362459126252, 21315.0, 7652.846943061108, 7700.191479894643, 7727.420443466763, 7781.338586220121, 7820.17888121739, 963.5423173992298, 1122.270524159303, 1130.1467392119062, 1144.0790163918125, 1238.3189245914712, 32000.679993200236, 33075.50386744201, 33178.50232246518, 33183.170420739676, 33565.328693425996, 1116.7040734205443, 1123.8538989931258, 1211.2792888231488, 1232.642533665245, 1237.8514578250667, 16516.926399783977, 17051.744223836653, 17100.0, 17201.397951071904, 17243.913780431016, 408947.0, 408989.0, 413326.0, 414946.0, 415407.0, 57907.0, 58564.0, 58631.0, 58672.41327586755, 58709.41290587125, 1248.9937550312372, 1261.3819228577931, 1377.3870627570634, 1385.1827421821174, 1400.4258254115764, 28712.712872871005, 29829.701702982693, 31232.375352493276, 31400.842995784875, 31726.20684482814, 46024.539754602025, 46352.30471542862, 46371.304430432894, 46406.0, 46449.0, 251825.0, 255997.0, 256777.0, 256965.0, 257018.0, 30329.69670303269, 34188.31623367569, 34958.82520587381, 35294.47058294076, 36028.0, 41759.0, 41830.372544412465, 42422.0, 42919.356209657504, 43349.0, 35274.823625881705, 37405.251894962494, 37508.624913750515, 39197.6080239194, 39718.0, 37507.46506350307, 37742.8112859434, 38466.0, 38612.0, 39193.41209881797, 39052.0, 39160.412593811685, 39693.00767480836, 40380.3942940862, 40510.0, 31700.207494812814, 33540.1614959628, 34215.82892085524, 34420.0, 34670.30659386748, 27071.323216919736, 27477.17568472949, 27544.449111018068, 27708.03630420352, 27854.0], "unit": "score", "name": "ext.html", "value": 19507.248013840966}, {"lowerIsBetter": false, "replicates": [369.30939143801095, 372.4320411372656, 380.6897378636411, 381.7938313310812, 383.35787555843956, 17829.10854457277, 18066.096695165237, 18416.079196040213, 18435.907820460878, 18469.630607387844, 17011.82988170118, 17442.12789360533, 17458.21438035288, 17480.650386992253, 17499.475015749515, 5493.533049690771, 5695.401982791809, 5762.078067509199, 5766.711664416763, 5769.538436925057, 4055.7566546007333, 5650.124230744241, 6058.424449677295, 6271.996480563088, 6288.9056664150075, 6172.4444799968, 6219.720112594944, 6242.1261023456755, 6248.781292654758, 6249.7187626556915, 6050.636961782285, 6366.490680745529, 6367.713452894608, 6369.076483909807, 6377.107204991305, 3599.8020108894, 5198.558122559587, 5339.359276886759, 5339.6262261641705, 5552.3892371839065, 20760.0, 20815.791842081537, 20869.0, 21240.5751884963, 21245.15019399222, 2226.4982125365955, 2279.988600057006, 2380.73811880693, 2404.507076049423, 2569.961450578243, 13599.184048957095, 14213.360398782079, 14567.70864582713, 14807.259637018105, 14863.182524961123, 1975.9209631614717, 1991.1338567723087, 2024.726661900654, 2041.3161590867078, 2068.5759419319, 67784.6610766948, 69106.0, 73341.63329183373, 75194.24805751981, 76579.0, 10548.947255263674, 10584.153267738717, 10782.730431739112, 10923.3992130432, 10924.289921155258, 14042.578722638336, 14098.506552270826, 14141.575752727435, 14159.575212743634, 14161.575152745228, 7439.888401673979, 7765.495242809199, 7795.0, 7864.646090925922, 7906.407019473562, 7670.079590449071, 7765.689372425039, 7836.059672839296, 7945.443818932735, 7950.085740139958, 4692.718436893797, 4765.880852978634, 4766.833160839424, 4778.95221047792, 4788.138135135709, 1779.599590092219, 1792.8924264544169, 1842.9495187742857, 1900.8194221548931, 1920.1647283431753, 432.03871386166156, 465.2463009923945, 480.7211817146047, 965.4738167698621, 1116.916231282657, 11096.15135286078, 11137.498812553455, 11182.888171118184, 11425.714357140972, 11457.656270311903, 447.86564030790635, 496.5630245384039, 499.2062620433528, 506.4707380787013, 511.66997286749836, 6327.525435592349, 6376.0, 6389.105525226472, 6389.424951754271, 6394.9680251599375, 531344.0, 535615.0, 537085.0, 553385.0, 554851.0, 87391.56304218438, 92235.53882230546, 92509.53745231366, 92983.0, 94475.52762236145, 487.74149700658705, 488.94621591625605, 489.9681520701143, 491.31952246139355, 491.8819483324048, 10237.539310730886, 10335.793284134426, 10436.37381757097, 10611.2041596879, 10655.680329590125, 35860.0, 36161.63838361583, 36289.637103629684, 36575.0, 37102.44346334861, 42904.35643465413, 45960.54039459563, 46023.0, 46320.305195421424, 46602.06795863996, 8277.503349799032, 8406.915930840612, 8424.326053915795, 8467.407281490483, 8516.403851730567, 12190.390480476119, 12358.258504489759, 12360.876391235972, 12505.56230531927, 12692.365381730691, 11452.713682157679, 12020.699482513008, 12034.939825300817, 12102.152849300464, 12140.696482587653, 5078.138578657563, 8123.700207966697, 11224.607138750105, 11532.135089868125, 11533.88466115328, 11724.58963936258, 11804.350760708243, 12265.0, 12385.62843114708, 12435.502579896704, 8330.875036874331, 8406.07533171363, 8449.619767110371, 8559.700410485602, 8561.058283588676, 10733.516991735547, 11798.587049453228, 11919.52321907114, 11982.0, 12096.818547721967], "unit": "score", "name": "jquery.html", "value": 8245.12944014679}, {"lowerIsBetter": false, "replicates": [1306.203216038216, 1481.1705444950828, 1508.0, 1651.8348165183475, 1804.9278028878846, 7856.960715196423, 8056.476329038608, 8060.879086813702, 8074.757757267276, 8081.0, 8074.6770129194765, 8240.381971352143, 8267.669293228264, 8275.462094963823, 8287.585620718955, 2054.794520547948, 2107.7681455039933, 2285.48576570272, 2378.15575470708, 2400.0879665726998, 2336.1473062332298, 2344.167820423742, 2345.7888790008897, 2347.354477518679, 2348.248560460653, 2259.638457846745, 2281.4296425893526, 2293.2317673579287, 2323.8838058097112, 2329.660445243983, 2298.988505057464, 2351.071326825903, 2352.447174913894, 2356.670066190735, 2361.515889242701, 2316.108298305148, 2320.3271051395077, 2323.5352929414016, 2337.509123084137, 2339.6607491913746, 8303.335733141334, 8348.958255208685, 8357.58212089393, 8367.079621241659, 8369.0, 4893.584045356149, 4994.200927851526, 5036.269740887551, 5039.521245481674, 5040.697558146487, 3276.3447310537986, 3309.851056702454, 3364.327134573095, 3452.361313157074, 3459.930801383983, 1091.650671785029, 1099.4228030284164, 1104.779044191165, 1148.9368084755336, 1177.6761390617648, 11501.5974440895, 11505.597304094317, 11507.309561426258, 11514.19400641947, 11518.251313664585, 4523.434570678665, 4531.750753708512, 4616.6537509686905, 4618.376519169936, 4620.953790462119, 9805.754856128511, 9811.166050885611, 9815.950920245354, 9821.165200957856, 9829.45937973404, 5138.3833939927445, 5141.948580514222, 5143.17709166539, 5144.408393034774, 5144.922826157611, 4049.2508885855623, 4497.482789479186, 4607.838725644587, 4662.860114196579, 4674.275487299474, 3811.961880381161, 3877.9612203878164, 3896.649301562873, 3922.097917478996, 3937.0354263205127, 1168.363242033094, 1197.6167626359656, 1212.6240865331774, 1240.789065858788, 1248.375812093953, 1116.7152376144031, 1122.7586068995206, 1128.5542210826677, 1321.6960099177243, 1401.2293238718664, 7869.409794265453, 7954.920450795534, 7977.760667179994, 7999.840003199904, 8027.39794515402, 482.4933819489522, 483.20512756516035, 487.48570258377754, 490.23278569039337, 494.68587446971435, 5885.970570147122, 5898.616589921728, 5918.053111502139, 5920.703964801743, 5959.106134079922, 9518.381305215138, 10004.599816007278, 10083.546240419199, 10155.796884062425, 10276.588936442458, 10101.747456313651, 10107.7473063174, 10109.848352274721, 10115.494225288854, 10150.898491015143, 7462.514936529108, 7589.8861517077285, 7695.422843286664, 7702.114256860421, 7707.113681926538, 7621.275978782007, 7633.847323053396, 7658.425618078555, 7685.0, 7716.112647045437, 8558.743237702878, 8754.737357879274, 8863.069377715246, 8907.064758200295, 8994.05562415937, 8799.252063574668, 8807.07525709817, 9092.999770025159, 9102.908970910472, 9347.439153650803, 6585.736570537125, 6763.425108865605, 6804.6257455840405, 7287.27127287267, 7375.704971801282, 7696.268854458817, 7839.686412543434, 7880.172581879049, 7894.368450524059, 7903.723369682033, 6869.381755642016, 7086.645667716697, 7091.326323999212, 7139.714411423485, 7273.927260727325, 6944.93055069463, 6981.476389270927, 7014.508984371045, 7091.716331346688, 7148.678309475982, 7080.256573059754, 7185.676644551112, 7338.339549440576, 7356.006939063158, 7361.079865016873, 6694.631795251308, 6756.831079222862, 6786.21958474762, 6788.4569234462115, 6792.558483698544, 6800.93199068003, 6844.4182244509775, 6881.071055407456, 6924.134483189601, 6929.237783843874], "unit": "score", "name": "mootools.html", "value": 4602.456116328316}, {"lowerIsBetter": false, "replicates": [344.91549570355266, 346.7815276375883, 347.1667996807663, 350.96990333371554, 351.37630705497753, 5918.0, 5954.4640982311585, 5964.284285885695, 5973.133895585143, 5980.970095149523, 5940.821775346736, 5950.880982380349, 5953.613015154012, 5969.3135289441725, 5971.492423144038, 4353.73877567347, 4434.512203657611, 4533.455985281771, 4557.02024064826, 4581.67928245023, 4548.408706868103, 4550.340200670901, 4553.567411095941, 4555.088982203556, 4560.726356418625, 4504.797284122206, 4506.414166158411, 4509.909801803962, 4518.0, 4519.16395466838, 4332.0, 4453.799579018936, 4547.090581883636, 4548.56788605082, 4581.923248036709, 4010.2981978154, 4017.8593749218635, 4019.0, 4024.436578878959, 4029.717919745619, 5736.541076713853, 5743.10981797822, 5750.654960702372, 5751.25233719618, 5771.307443106812, 5304.6286759926825, 5319.5744340452675, 5325.0, 5325.4142044375085, 5327.920081198785, 6203.968980155116, 6259.780907668255, 6262.405071518198, 6276.403741644582, 6279.0, 4359.476862776487, 4430.180416622903, 4445.799939002753, 4461.754603496806, 4464.6428285737065, 6559.672016399209, 6571.605703657796, 6579.407853293226, 6580.670966451707, 6584.341565843425, 4569.725816450957, 4579.633629309647, 4587.678862479661, 4589.2886602576655, 4589.701669391479, 4639.466461356919, 4643.558861908114, 4650.837220697327, 4651.069786042805, 4651.744154071491, 5301.761420736076, 5307.203919412119, 5312.229726689686, 5314.096603577401, 5317.750328672759, 6150.969245153746, 6321.1150438938585, 6328.272248691459, 6330.493560515148, 6336.588121772163, 1604.374294025331, 1625.7154997875325, 1636.2309714434198, 1637.2550489527237, 1638.6886491566563, 1053.8840727519967, 1094.5895289266525, 1097.868255809308, 1128.3230061962756, 1145.2326940949583, 6024.036154215304, 6024.27708674953, 6026.668533230714, 6029.60807547508, 6030.427109424598, 6413.262474815456, 6438.80683579484, 6454.4513716333695, 6459.354064593503, 6459.709313080829, 6016.368281330398, 6016.578839481194, 6019.0, 6020.969895150496, 6023.367546407651, 3419.5554577904713, 3454.29187016661, 3458.602260739997, 3475.374432602105, 3475.8783442579893, 6493.577917435352, 6718.49611279156, 6720.428763555153, 6729.663516824237, 6731.764388246388, 6601.636909969998, 6603.108580341688, 6684.532082754161, 6687.732490700415, 6688.39804417595, 6707.832304192337, 6709.396154346132, 6710.0941372915, 6710.798676039727, 6716.261211266659, 6429.324920883427, 6436.806895793134, 6437.291897891322, 6443.903341449788, 6446.258680251831, 6223.813285601439, 6354.586951848115, 6361.045843123568, 6372.07604897278, 6394.104825324552, 6693.397594216543, 6708.127943367331, 6709.7316107355155, 6710.798676039727, 6716.966415167893, 4533.229351010402, 4579.793909274024, 4580.404547408815, 4593.793279302373, 4597.08058388317, 6401.263854656774, 6403.7118329676205, 6412.134361861089, 6413.8717225656155, 6423.454006409321, 6271.686415679289, 6274.341194174546, 6286.308506064421, 6288.654124023223, 6293.3391993841815, 6128.1726966858905, 6335.049742538656, 6339.080833279057, 6353.269374021862, 6354.0, 6199.070139478934, 6221.06683997404, 6223.190985171898, 6223.595466294676, 6234.096056071753, 6386.425221730066, 6387.4570661492435, 6388.584741991755, 6394.616323020634, 6397.4562162216735, 5930.229070220844, 6054.515638748801, 6071.423214794588, 6199.814005579839, 6225.25296964349], "unit": "score", "name": "prototype.html", "value": 4773.454966367854}, {"lowerIsBetter": false, "replicates": [689.1970853955143, 695.5617960684768, 719.5610677486732, 771.2634434115421, 809.5385630190792, 14577.271136443174, 14848.777268340984, 14914.627134321634, 14917.254137293146, 14918.17950012749, 13116.54092106774, 13120.540781072665, 13121.015923805706, 13129.949604031655, 13131.73736525269, 678.8811957907371, 819.7171975668385, 835.3734698975768, 843.6498852976008, 852.8592782190931, 845.3406343052429, 845.7800971747359, 848.3594885861166, 852.3266619370689, 853.8121613245077, 896.7802888292377, 897.4166791585457, 899.3344924755667, 899.6086702284528, 899.757065592293, 715.7280233511259, 874.8818909447207, 891.8662200669886, 895.0646574329841, 895.2658819767793, 644.1272076336543, 644.7485480662546, 645.4287955159671, 645.4900628503476, 646.0857886091222, 14291.928540357232, 14367.928160359235, 14374.856251437457, 14384.856151438456, 14399.064060836117, 14049.78925316121, 14338.64153396163, 14346.784798228035, 14372.928135359361, 14416.783748243784, 11411.714707132305, 11578.826317605159, 11612.419379031015, 11748.412579370997, 12019.939900300442, 3844.692424606025, 3871.361225397806, 3893.7079719021185, 3972.8410863565423, 3978.085040440686, 58069.70965145147, 58186.709066454394, 58223.417765822225, 58738.118928216114, 58804.70597646984, 10413.375197488174, 10876.728081798019, 10899.1280697544, 10982.890171098186, 11007.61473348429, 19449.222031118596, 19509.707354389695, 19510.219591216475, 19558.70661940072, 19581.70627440561, 8157.306628936607, 8235.094139644634, 8247.515447219557, 8326.750197494084, 8349.123342048997, 4660.300954856799, 4765.547273009059, 4767.523247675274, 4858.8299409521205, 4865.5864251539015, 3300.47192449207, 3324.73402127834, 3339.298747263102, 3341.63242043375, 3348.347072320923, 594.6907608043794, 604.758096761299, 613.7851751886803, 649.954503184782, 672.3612568060264, 614.8555089553952, 621.9502439804804, 673.4343151752552, 682.8566001139717, 726.1395246632757, 8387.161283871565, 8595.398322117517, 8621.267192288726, 8647.308215342757, 8833.779155521035, 605.4671888737882, 691.6403470195571, 731.7548621211954, 747.4692967992786, 747.5253214208908, 4045.6763458923215, 4326.545712700184, 4382.408374869352, 4393.538678438782, 4568.725876447424, 61441.69279153665, 61562.0, 61849.0, 62030.37969620246, 65321.0, 58329.70835145797, 59310.40689593135, 59685.0, 59967.0, 60217.69891150516, 52701.472985269655, 53003.734981324844, 53230.0, 53285.934281314156, 53704.0, 8641.265492432962, 8802.691905783267, 8822.823543529223, 8885.155910188521, 8941.0, 37409.43885841769, 38218.235635287696, 38590.80704596459, 39148.0, 41448.3782743253, 50653.74673126611, 51338.48661513337, 51434.74282628563, 52055.47944520506, 52858.207126893896, 11653.6503904883, 11863.34751588671, 12040.03679705604, 12311.261324320569, 12395.18302799599, 12430.751384972431, 12741.534723506915, 13075.869241307846, 13442.39509222107, 13511.797323039966, 12927.0, 13076.150050246704, 13316.667083322995, 13734.313284335543, 13807.378667959765, 12856.357182140668, 13109.803352949904, 13494.595162145151, 13528.188308701509, 13540.255285959367, 12340.321282329558, 12882.162659427107, 13011.869881301445, 13628.65928351799, 13650.658733531343, 10583.508400753171, 10832.0, 10924.945375273073, 10946.233763636788, 10993.835092473459, 10631.468426578485, 10941.507632156412, 10989.395583242998, 10993.450327483753, 11022.393768342497], "unit": "score", "name": "yui.html", "value": 6855.922718941838}], "name": "dromaeo_css", "value": 7080.459956136972}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 105.0, 108.0, 109.0, 111.0, 99.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 107.9}, {"lowerIsBetter": true, "replicates": [146.0, 132.0, 153.0, 167.0, 128.0, 151.0, 160.0, 127.0, 173.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 146.1}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 161.0, 162.0, 159.0, 162.0, 165.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [72.0, 76.0, 106.0, 92.0, 75.0, 76.0, 76.0, 111.0, 100.0, 76.0], "unit": "score", "name": "audio-fft", "value": 86.0}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 144.0, 92.0, 92.0, 92.0, 142.0, 93.0, 101.0, 149.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 127.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.7}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 94.9}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 58.0, 56.0, 55.0, 56.0, 58.0, 65.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.4}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 60.0, 61.0, 61.0, 61.0, 60.0, 60.0, 61.0, 60.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 60.4}, {"lowerIsBetter": true, "replicates": [78.0, 80.0, 78.0, 87.0, 78.0, 78.0, 77.0, 77.0, 81.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.3}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 109.0, 108.0, 114.0, 120.0, 108.0, 110.0, 113.0, 107.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 111.0}, {"lowerIsBetter": true, "replicates": [143.0, 134.0, 142.0, 140.0, 143.0, 133.0, 141.0, 144.0, 144.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.6}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 66.0, 63.0, 65.0, 64.0, 64.0, 64.0, 63.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.3}], "name": "kraken", "value": 1481.1999999999998}]} 16:43:24 INFO - Return code: 0 16:43:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:43:24 ERROR - # TBPL SUCCESS # 16:43:24 INFO - Running post-action listener: _resource_record_post_action 16:43:24 INFO - Running post-run listener: _resource_record_post_run 16:43:25 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 544116736; Read time: 24; Write time: 512088 16:43:25 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 253792256; Read time: 0; Write time: 282636 16:43:25 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290324480; Read time: 24; Write time: 229452 16:43:25 INFO - Running post-run listener: _upload_blobber_files 16:43:25 INFO - Blob upload gear active. 16:43:25 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:43:25 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 16:43:25 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'] 16:43:25 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 16:43:25 INFO - (blobuploader) - INFO - Open directory for files ... 16:43:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 16:43:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:43:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:26 INFO - (blobuploader) - INFO - Done attempting. 16:43:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:43:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:43:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:27 INFO - (blobuploader) - INFO - Done attempting. 16:43:27 INFO - (blobuploader) - INFO - Iteration through files over. 16:43:27 INFO - Return code: 0 16:43:27 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:43:27 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:43:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/48672618e1d7d366431b27a6a235fc4b55616290f2b363a6597a797dfa44674b8fca7fadbfeca73547ca1241e05a4debb092bac7478dc0545aabe1295b5626f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa91607931f96905f8dfbc30a328b901c7df36f9d7b31bac08ec83744f26c80450b4029528fa6c8f20bb8c505f628ac8b307c199b03e4b8a8a3338137fffac58"} 16:43:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:43:27 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:43:27 INFO - Contents: 16:43:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/48672618e1d7d366431b27a6a235fc4b55616290f2b363a6597a797dfa44674b8fca7fadbfeca73547ca1241e05a4debb092bac7478dc0545aabe1295b5626f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa91607931f96905f8dfbc30a328b901c7df36f9d7b31bac08ec83744f26c80450b4029528fa6c8f20bb8c505f628ac8b307c199b03e4b8a8a3338137fffac58"} 16:43:27 INFO - Running post-run listener: copy_logs_to_upload_dir 16:43:27 INFO - Copying logs to upload dir... 16:43:27 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 16:43:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.127829 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-03-16 16:43:27.495140) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 16:43:27.501115) ========= 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=7de08804244eb36560b44971000001c3-1458170579.39929-1302790124 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/48672618e1d7d366431b27a6a235fc4b55616290f2b363a6597a797dfa44674b8fca7fadbfeca73547ca1241e05a4debb092bac7478dc0545aabe1295b5626f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa91607931f96905f8dfbc30a328b901c7df36f9d7b31bac08ec83744f26c80450b4029528fa6c8f20bb8c505f628ac8b307c199b03e4b8a8a3338137fffac58"} build_url:https://queue.taskcluster.net/v1/task/X3bcZRccQUO6XPAAsqH8cA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011528 build_url: 'https://queue.taskcluster.net/v1/task/X3bcZRccQUO6XPAAsqH8cA/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/48672618e1d7d366431b27a6a235fc4b55616290f2b363a6597a797dfa44674b8fca7fadbfeca73547ca1241e05a4debb092bac7478dc0545aabe1295b5626f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa91607931f96905f8dfbc30a328b901c7df36f9d7b31bac08ec83744f26c80450b4029528fa6c8f20bb8c505f628ac8b307c199b03e4b8a8a3338137fffac58"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 16:43:27.525985) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 16:43:27.526309) ========= 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=7de08804244eb36560b44971000001c3-1458170579.39929-1302790124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 16:43:27.610432) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 16:43:27.610760) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 16:43:27.611070) ========= ========= Total master_lag: 0.27 =========