builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-028 starttime: 1450829389.8 results: success (0) buildid: 20151222134825 builduid: 0cea1bf62ce24769879a18e607b93f4b revision: 586fe84e48ca9f914880e5fdbf3dbdae1e82b5e7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 16:09:49.803670) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 16:09:49.804195) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 16:09:49.804494) ========= 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=b00de3c228505fac2445e70d000001bb-1450828060.651877-80247873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006287 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 16:09:49.828749) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 16:09:49.829045) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 16:09:49.852326) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 16:09:49.852727) ========= 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=b00de3c228505fac2445e70d000001bb-1450828060.651877-80247873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004693 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 16:09:49.902401) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 16:09:49.902716) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 16:09:49.903099) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 16:09:49.903374) ========= 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=b00de3c228505fac2445e70d000001bb-1450828060.651877-80247873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-22 16:09:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 83.7M=0s 2015-12-22 16:09:50 (83.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151790 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 16:09:50.071957) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 16:09:50.072250) ========= 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=b00de3c228505fac2445e70d000001bb-1450828060.651877-80247873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022995 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 16:09:50.122286) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 16:09:50.122639) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 586fe84e48ca9f914880e5fdbf3dbdae1e82b5e7 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 586fe84e48ca9f914880e5fdbf3dbdae1e82b5e7 --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=b00de3c228505fac2445e70d000001bb-1450828060.651877-80247873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-22 16:09:50,494 truncating revision to first 12 chars 2015-12-22 16:09:50,494 Setting DEBUG logging. 2015-12-22 16:09:50,494 attempt 1/10 2015-12-22 16:09:50,494 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/586fe84e48ca?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-22 16:09:50,748 unpacking tar archive at: mozilla-aurora-586fe84e48ca/testing/mozharness/ program finished with exit code 0 elapsedTime=0.529673 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 16:09:50.665134) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 16:09:50.665407) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 16:09:50.675143) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 16:09:50.675385) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 16:09:50.675775) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-12-22 16:09:50.676279) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b00de3c228505fac2445e70d000001bb-1450828060.651877-80247873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:09:51 INFO - MultiFileLogger online at 20151222 16:09:51 in /builds/slave/test-pgo 16:09:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:09:51 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:09:51 INFO - {'append_to_log': False, 16:09:51 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:09:51 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:09:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:09:51 INFO - 'branch': 'Mozilla-Aurora', 16:09:51 INFO - 'buildbot_json_path': 'buildprops.json', 16:09:51 INFO - 'config_files': ('talos/linux_config.py',), 16:09:51 INFO - 'default_actions': ('clobber', 16:09:51 INFO - 'read-buildbot-config', 16:09:51 INFO - 'download-and-extract', 16:09:51 INFO - 'populate-webroot', 16:09:51 INFO - 'create-virtualenv', 16:09:51 INFO - 'install', 16:09:51 INFO - 'run-tests'), 16:09:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:09:51 INFO - 'download_minidump_stackwalk': True, 16:09:51 INFO - 'download_symbols': 'ondemand', 16:09:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:09:51 INFO - 'tooltool.py': '/tools/tooltool.py', 16:09:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:09:51 INFO - '/tools/misc-python/virtualenv.py')}, 16:09:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:09:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:09:51 INFO - 'installer_path': 'installer.exe', 16:09:51 INFO - 'log_level': 'info', 16:09:51 INFO - 'log_name': 'talos', 16:09:51 INFO - 'log_to_console': True, 16:09:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:09:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:09:51 INFO - 'opt_config_files': (), 16:09:51 INFO - 'pip_index': False, 16:09:51 INFO - 'sps_profile': False, 16:09:51 INFO - 'sps_profile_interval': 0, 16:09:51 INFO - 'suite': 'dromaeojs-e10s', 16:09:51 INFO - 'system_bits': '64', 16:09:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:09:51 INFO - 'title': 'talos-linux64-ix-028', 16:09:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:09:51 INFO - 'use_talos_json': True, 16:09:51 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:09:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:09:51 INFO - 'work_dir': 'build'} 16:09:51 INFO - ##### 16:09:51 INFO - ##### Running clobber step. 16:09:51 INFO - ##### 16:09:51 INFO - Running pre-action listener: _resource_record_pre_action 16:09:51 INFO - Running main action method: clobber 16:09:51 INFO - rmtree: /builds/slave/test-pgo/build 16:09:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:09:52 INFO - Running post-action listener: _resource_record_post_action 16:09:52 INFO - ##### 16:09:52 INFO - ##### Running read-buildbot-config step. 16:09:52 INFO - ##### 16:09:52 INFO - Running pre-action listener: _resource_record_pre_action 16:09:52 INFO - Running main action method: read_buildbot_config 16:09:52 INFO - Using buildbot properties: 16:09:52 INFO - { 16:09:52 INFO - "properties": { 16:09:52 INFO - "buildnumber": 24, 16:09:52 INFO - "product": "firefox", 16:09:52 INFO - "script_repo_revision": "production", 16:09:52 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 16:09:52 INFO - "repository": "", 16:09:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 16:09:52 INFO - "buildid": "20151222134825", 16:09:52 INFO - "slavename": "talos-linux64-ix-028", 16:09:52 INFO - "pgo_build": "True", 16:09:52 INFO - "basedir": "/builds/slave/test-pgo", 16:09:52 INFO - "project": "", 16:09:52 INFO - "platform": "ubuntu64_hw", 16:09:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:09:52 INFO - "slavebuilddir": "test", 16:09:52 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:09:52 INFO - "branch": "mozilla-aurora", 16:09:52 INFO - "repo_path": "releases/mozilla-aurora", 16:09:52 INFO - "stage_platform": "linux64-pgo", 16:09:52 INFO - "builduid": "0cea1bf62ce24769879a18e607b93f4b", 16:09:52 INFO - "revision": "586fe84e48ca9f914880e5fdbf3dbdae1e82b5e7" 16:09:52 INFO - }, 16:09:52 INFO - "sourcestamp": { 16:09:52 INFO - "repository": "", 16:09:52 INFO - "hasPatch": false, 16:09:52 INFO - "project": "", 16:09:52 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 16:09:52 INFO - "changes": [ 16:09:52 INFO - { 16:09:52 INFO - "category": null, 16:09:52 INFO - "files": [ 16:09:52 INFO - { 16:09:52 INFO - "url": null, 16:09:52 INFO - "name": "https://queue.taskcluster.net/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 16:09:52 INFO - } 16:09:52 INFO - ], 16:09:52 INFO - "repository": "", 16:09:52 INFO - "rev": "586fe84e48ca9f914880e5fdbf3dbdae1e82b5e7", 16:09:52 INFO - "who": "kwierso@gmail.com", 16:09:52 INFO - "when": 1450829319, 16:09:52 INFO - "number": 7388016, 16:09:52 INFO - "comments": "Bug 1232527 - Call into WMF PDM to determine if WMF can decode instead of using GMPVideoDecoderTrialCreator. r=jwwang a=ritu\n\nResurrect WMFDecoderModule::HasAAC() and HasH264(), and use those in\nMediaKeySystemAccess.cpp to figure out whether we gmp-clearkey can decode,\nrather than assuming Vista and later is always able to decode, as that's not\na valid assumption; Vista may not have the required Platfor Update installed,\nor we may be on Windows N or KN without the Media Feature Pack.", 16:09:52 INFO - "project": "", 16:09:52 INFO - "at": "Tue 22 Dec 2015 16:08:39", 16:09:52 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 16:09:52 INFO - "revlink": "", 16:09:52 INFO - "properties": [ 16:09:52 INFO - [ 16:09:52 INFO - "buildid", 16:09:52 INFO - "20151222134825", 16:09:52 INFO - "Change" 16:09:52 INFO - ], 16:09:52 INFO - [ 16:09:52 INFO - "builduid", 16:09:52 INFO - "0cea1bf62ce24769879a18e607b93f4b", 16:09:52 INFO - "Change" 16:09:52 INFO - ], 16:09:52 INFO - [ 16:09:52 INFO - "pgo_build", 16:09:52 INFO - "True", 16:09:52 INFO - "Change" 16:09:52 INFO - ] 16:09:52 INFO - ], 16:09:52 INFO - "revision": "586fe84e48ca9f914880e5fdbf3dbdae1e82b5e7" 16:09:52 INFO - } 16:09:52 INFO - ], 16:09:52 INFO - "revision": "586fe84e48ca9f914880e5fdbf3dbdae1e82b5e7" 16:09:52 INFO - } 16:09:52 INFO - } 16:09:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 16:09:52 INFO - Running post-action listener: _resource_record_post_action 16:09:52 INFO - ##### 16:09:52 INFO - ##### Running download-and-extract step. 16:09:52 INFO - ##### 16:09:52 INFO - Running pre-action listener: _resource_record_pre_action 16:09:52 INFO - Running main action method: download_and_extract 16:09:52 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:09:52 INFO - https://queue.taskcluster.net/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:09:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/test_packages.json 16:09:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/test_packages.json 16:09:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:09:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:09:52 INFO - Downloaded 1302 bytes. 16:09:52 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:09:52 INFO - Using the following test package requirements: 16:09:52 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 16:09:52 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:09:52 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:09:52 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:09:52 INFO - u'jsshell-linux-x86_64.zip'], 16:09:52 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:09:52 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:09:52 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 16:09:52 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:09:52 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:09:52 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:09:52 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:09:52 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:09:52 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:09:52 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 16:09:52 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:09:52 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:09:52 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:09:52 INFO - https://queue.taskcluster.net/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:09:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:09:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:09:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:09:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:09:53 INFO - Downloaded 23022934 bytes. 16:09:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:09:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:09:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:09:54 INFO - Return code: 0 16:09:54 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:09:54 INFO - https://queue.taskcluster.net/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:09:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:09:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:09:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:09:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:10:03 INFO - Downloaded 23022934 bytes. 16:10:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:10:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:10:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:10:05 INFO - Return code: 0 16:10:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:05 INFO - https://queue.taskcluster.net/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:10:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 16:10:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 16:10:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 16:10:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:10:06 INFO - Downloaded 11132038 bytes. 16:10:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 16:10:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 16:10:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 16:10:06 INFO - Return code: 0 16:10:06 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:10:06 INFO - https://queue.taskcluster.net/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:10:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:10:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:10:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:10:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:10:08 INFO - Downloaded 58088046 bytes. 16:10:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:10:08 INFO - mkdir: /builds/slave/test-pgo/properties 16:10:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:10:08 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:10:08 INFO - Contents: 16:10:08 INFO - build_url:https://queue.taskcluster.net/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:10:08 INFO - Running post-action listener: _resource_record_post_action 16:10:08 INFO - Running post-action listener: set_extra_try_arguments 16:10:08 INFO - ##### 16:10:08 INFO - ##### Running populate-webroot step. 16:10:08 INFO - ##### 16:10:08 INFO - Running pre-action listener: _resource_record_pre_action 16:10:08 INFO - Running main action method: populate_webroot 16:10:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:10:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:10:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:10:08 INFO - '--tppagecycles', 16:10:08 INFO - '7'], 16:10:08 INFO - 'tests': ['tsvgm']}}, 16:10:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:10:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:10:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:10:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:10:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:10:08 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:10:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:10:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:08 INFO - 'talos_options': ['--e10s'], 16:10:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:10:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:08 INFO - 'tests': ['damp', 'tps']}, 16:10:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:08 INFO - 'talos_options': ['--e10s'], 16:10:08 INFO - 'tests': ['damp', 'tps']}, 16:10:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:10:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:10:08 INFO - 'other': {'tests': ['a11yr', 16:10:08 INFO - 'ts_paint', 16:10:08 INFO - 'tpaint', 16:10:08 INFO - 'sessionrestore', 16:10:08 INFO - 'sessionrestore_no_auto_restore']}, 16:10:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:10:08 INFO - 'tests': ['a11yr', 16:10:08 INFO - 'ts_paint', 16:10:08 INFO - 'tpaint', 16:10:08 INFO - 'sessionrestore', 16:10:08 INFO - 'sessionrestore_no_auto_restore']}, 16:10:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:10:08 INFO - 'tests': ['a11yr', 16:10:08 INFO - 'ts_paint', 16:10:08 INFO - 'tpaint', 16:10:08 INFO - 'sessionrestore', 16:10:08 INFO - 'sessionrestore_no_auto_restore']}, 16:10:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:10:08 INFO - 'tests': ['a11yr', 16:10:08 INFO - 'ts_paint', 16:10:08 INFO - 'tpaint', 16:10:08 INFO - 'sessionrestore', 16:10:08 INFO - 'sessionrestore_no_auto_restore']}, 16:10:08 INFO - 'other_l64': {'tests': ['a11yr', 16:10:08 INFO - 'ts_paint', 16:10:08 INFO - 'tpaint', 16:10:08 INFO - 'sessionrestore', 16:10:08 INFO - 'sessionrestore_no_auto_restore']}, 16:10:08 INFO - 'other_nol64': {'tests': ['a11yr', 16:10:08 INFO - 'ts_paint', 16:10:08 INFO - 'tpaint', 16:10:08 INFO - 'sessionrestore', 16:10:08 INFO - 'sessionrestore_no_auto_restore']}, 16:10:08 INFO - 'svgr': {'tests': ['tsvgx', 16:10:08 INFO - 'tsvgr_opacity', 16:10:08 INFO - 'tart', 16:10:08 INFO - 'tscrollx', 16:10:08 INFO - 'cart']}, 16:10:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:10:08 INFO - 'tests': ['tsvgx', 16:10:08 INFO - 'tsvgr_opacity', 16:10:08 INFO - 'tart', 16:10:08 INFO - 'tscrollx', 16:10:08 INFO - 'cart']}, 16:10:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:08 INFO - 'tests': ['tp5o']}, 16:10:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:08 INFO - 'talos_options': ['--e10s'], 16:10:08 INFO - 'tests': ['tp5o']}, 16:10:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:08 INFO - 'talos_options': ['--xperf_path', 16:10:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:10:08 INFO - 'tests': ['tp5n']}, 16:10:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:08 INFO - 'talos_options': ['--e10s', 16:10:08 INFO - '--xperf_path', 16:10:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:10:08 INFO - 'tests': ['tp5n']}}, 16:10:08 INFO - 'talos.zip': {'path': '', 16:10:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:10:08 INFO - Running post-action listener: _resource_record_post_action 16:10:08 INFO - ##### 16:10:08 INFO - ##### Running create-virtualenv step. 16:10:08 INFO - ##### 16:10:08 INFO - Running pre-action listener: _resource_record_pre_action 16:10:08 INFO - Running main action method: create_virtualenv 16:10:08 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:10:08 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:10:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:10:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:10:08 INFO - Using real prefix '/usr' 16:10:08 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:10:09 INFO - Installing distribute.............................................................................................................................................................................................done. 16:10:11 INFO - Installing pip.................done. 16:10:11 INFO - Return code: 0 16:10:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:10:11 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:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:11 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:10:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f8476d1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203f500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c6a0>, '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 0x203d5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203da30>, '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': 'b00de3c228505fac2445e70d000001bb-1450828060.651877-80247873', '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:10:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:10:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:10:11 INFO - Using env: {'DISPLAY': ':0', 16:10:11 INFO - 'HOME': '/home/cltbld', 16:10:11 INFO - 'LANG': 'en_US.UTF-8', 16:10:11 INFO - 'LANGUAGE': 'en_US:en', 16:10:11 INFO - 'LOGNAME': 'cltbld', 16:10:11 INFO - 'MAIL': '/var/mail/cltbld', 16:10:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:11 INFO - 'MOZ_NO_REMOTE': '1', 16:10:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:11 INFO - 'NO_EM_RESTART': '1', 16:10:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:10:11 INFO - 'PWD': '/builds/slave/test-pgo', 16:10:11 INFO - 'SHELL': '/bin/bash', 16:10:11 INFO - 'SHLVL': '1', 16:10:11 INFO - 'TERM': 'linux', 16:10:11 INFO - 'TMOUT': '86400', 16:10:11 INFO - 'USER': 'cltbld', 16:10:11 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450828060.651877-80247873', 16:10:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:11 INFO - '_': '/tools/buildbot/bin/python'} 16:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:11 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:10:11 INFO - Cleaning up... 16:10:11 INFO - Return code: 0 16:10:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:10:11 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:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:11 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:10:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f8476d1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203f500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c6a0>, '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 0x203d5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203da30>, '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': 'b00de3c228505fac2445e70d000001bb-1450828060.651877-80247873', '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:10:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:10:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:10:11 INFO - Using env: {'DISPLAY': ':0', 16:10:11 INFO - 'HOME': '/home/cltbld', 16:10:11 INFO - 'LANG': 'en_US.UTF-8', 16:10:11 INFO - 'LANGUAGE': 'en_US:en', 16:10:11 INFO - 'LOGNAME': 'cltbld', 16:10:11 INFO - 'MAIL': '/var/mail/cltbld', 16:10:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:11 INFO - 'MOZ_NO_REMOTE': '1', 16:10:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:11 INFO - 'NO_EM_RESTART': '1', 16:10:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:10:11 INFO - 'PWD': '/builds/slave/test-pgo', 16:10:11 INFO - 'SHELL': '/bin/bash', 16:10:11 INFO - 'SHLVL': '1', 16:10:11 INFO - 'TERM': 'linux', 16:10:11 INFO - 'TMOUT': '86400', 16:10:11 INFO - 'USER': 'cltbld', 16:10:11 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450828060.651877-80247873', 16:10:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:11 INFO - '_': '/tools/buildbot/bin/python'} 16:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:11 INFO - Downloading/unpacking psutil>=0.7.1 16:10:11 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:10:11 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:10:11 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:10:11 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:10:11 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:10:11 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:10:13 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 16:10:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:10:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:10:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:10:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:10:13 INFO - Installing collected packages: psutil 16:10:13 INFO - Running setup.py install for psutil 16:10:13 INFO - building 'psutil._psutil_linux' extension 16:10:13 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:10:13 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:10:13 INFO - building 'psutil._psutil_posix' extension 16:10:13 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:10:13 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:10:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:10:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:10:13 INFO - Successfully installed psutil 16:10:13 INFO - Cleaning up... 16:10:13 INFO - Return code: 0 16:10:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:10: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:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10: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:10:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f8476d1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203f500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c6a0>, '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 0x203d5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203da30>, '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': 'b00de3c228505fac2445e70d000001bb-1450828060.651877-80247873', '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:10:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:10:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:10:13 INFO - Using env: {'DISPLAY': ':0', 16:10:13 INFO - 'HOME': '/home/cltbld', 16:10:13 INFO - 'LANG': 'en_US.UTF-8', 16:10:13 INFO - 'LANGUAGE': 'en_US:en', 16:10:13 INFO - 'LOGNAME': 'cltbld', 16:10:13 INFO - 'MAIL': '/var/mail/cltbld', 16:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:13 INFO - 'MOZ_NO_REMOTE': '1', 16:10:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:13 INFO - 'NO_EM_RESTART': '1', 16:10:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:10:13 INFO - 'PWD': '/builds/slave/test-pgo', 16:10:13 INFO - 'SHELL': '/bin/bash', 16:10:13 INFO - 'SHLVL': '1', 16:10:13 INFO - 'TERM': 'linux', 16:10:13 INFO - 'TMOUT': '86400', 16:10:13 INFO - 'USER': 'cltbld', 16:10:13 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450828060.651877-80247873', 16:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:13 INFO - '_': '/tools/buildbot/bin/python'} 16:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:10: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:10: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:10: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:10: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:10: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:10: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:10:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:10:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:10:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:10:15 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:10:15 INFO - Installing collected packages: mozsystemmonitor 16:10:15 INFO - Running setup.py install for mozsystemmonitor 16:10:15 INFO - Successfully installed mozsystemmonitor 16:10:15 INFO - Cleaning up... 16:10:15 INFO - Return code: 0 16:10:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:10:15 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:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:15 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:10:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f8476d1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203f500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c6a0>, '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 0x203d5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203da30>, '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': 'b00de3c228505fac2445e70d000001bb-1450828060.651877-80247873', '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:10:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:10:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:10:15 INFO - Using env: {'DISPLAY': ':0', 16:10:15 INFO - 'HOME': '/home/cltbld', 16:10:15 INFO - 'LANG': 'en_US.UTF-8', 16:10:15 INFO - 'LANGUAGE': 'en_US:en', 16:10:15 INFO - 'LOGNAME': 'cltbld', 16:10:15 INFO - 'MAIL': '/var/mail/cltbld', 16:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:15 INFO - 'MOZ_NO_REMOTE': '1', 16:10:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:15 INFO - 'NO_EM_RESTART': '1', 16:10:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:10:15 INFO - 'PWD': '/builds/slave/test-pgo', 16:10:15 INFO - 'SHELL': '/bin/bash', 16:10:15 INFO - 'SHLVL': '1', 16:10:15 INFO - 'TERM': 'linux', 16:10:15 INFO - 'TMOUT': '86400', 16:10:15 INFO - 'USER': 'cltbld', 16:10:15 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450828060.651877-80247873', 16:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:15 INFO - '_': '/tools/buildbot/bin/python'} 16:10:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:16 INFO - Downloading/unpacking blobuploader==1.2.4 16:10: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:10: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:10: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:10: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:10: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:10: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:10:17 INFO - Downloading blobuploader-1.2.4.tar.gz 16:10:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:10:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:10:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:10:17 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:10:17 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:10:17 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:10:17 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:10:17 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:10:17 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:10:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:10:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:10:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:10:18 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:10:18 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:10:18 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:10:18 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:10:18 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:10:18 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:10:18 INFO - Downloading docopt-0.6.1.tar.gz 16:10:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:10:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:10:18 INFO - Installing collected packages: blobuploader, requests, docopt 16:10:18 INFO - Running setup.py install for blobuploader 16:10:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:10:18 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:10:18 INFO - Running setup.py install for requests 16:10:19 INFO - Running setup.py install for docopt 16:10:19 INFO - Successfully installed blobuploader requests docopt 16:10:19 INFO - Cleaning up... 16:10:19 INFO - Return code: 0 16:10:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:10:19 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:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:19 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:10:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f8476d1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203f500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c6a0>, '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 0x203d5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203da30>, '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': 'b00de3c228505fac2445e70d000001bb-1450828060.651877-80247873', '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:10:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:10:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --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:10:19 INFO - Using env: {'DISPLAY': ':0', 16:10:19 INFO - 'HOME': '/home/cltbld', 16:10:19 INFO - 'LANG': 'en_US.UTF-8', 16:10:19 INFO - 'LANGUAGE': 'en_US:en', 16:10:19 INFO - 'LOGNAME': 'cltbld', 16:10:19 INFO - 'MAIL': '/var/mail/cltbld', 16:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:19 INFO - 'MOZ_NO_REMOTE': '1', 16:10:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:19 INFO - 'NO_EM_RESTART': '1', 16:10:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:10:19 INFO - 'PWD': '/builds/slave/test-pgo', 16:10:19 INFO - 'SHELL': '/bin/bash', 16:10:19 INFO - 'SHLVL': '1', 16:10:19 INFO - 'TERM': 'linux', 16:10:19 INFO - 'TMOUT': '86400', 16:10:19 INFO - 'USER': 'cltbld', 16:10:19 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450828060.651877-80247873', 16:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:19 INFO - '_': '/tools/buildbot/bin/python'} 16:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:10:19 INFO - Running setup.py (path:/tmp/pip-TIAPp4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:10:19 INFO - Running setup.py (path:/tmp/pip-42MaYB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:10:19 INFO - Running setup.py (path:/tmp/pip-HLwGdj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:10:19 INFO - Running setup.py (path:/tmp/pip-0rVlgN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:10:19 INFO - Running setup.py (path:/tmp/pip-Ji8wKt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:10:19 INFO - Running setup.py (path:/tmp/pip-6NAsA9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:10:19 INFO - Running setup.py (path:/tmp/pip-ng2tb5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:10:19 INFO - Running setup.py (path:/tmp/pip-IE7puk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:10:19 INFO - Running setup.py (path:/tmp/pip-nBDmak-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:10:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:10:20 INFO - Running setup.py (path:/tmp/pip-_VRhNd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:10:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:10:20 INFO - Running setup.py (path:/tmp/pip-fo_8zc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:10:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:10:20 INFO - Running setup.py (path:/tmp/pip-XhW02n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:10:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:10:20 INFO - Running setup.py (path:/tmp/pip-SkuxPM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:10:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:10:20 INFO - Running setup.py (path:/tmp/pip-m0vRac-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:10:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:10:20 INFO - Running setup.py (path:/tmp/pip-l4tzCX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:10:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:10:20 INFO - Running setup.py (path:/tmp/pip-u9CTid-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:10:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:10:20 INFO - Running setup.py (path:/tmp/pip-YtYrp2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:10:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:10:20 INFO - Running setup.py install for manifestparser 16:10:20 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:10:20 INFO - Running setup.py install for mozcrash 16:10:20 INFO - Running setup.py install for mozdebug 16:10:20 INFO - Running setup.py install for mozdevice 16:10:21 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:10:21 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:10:21 INFO - Running setup.py install for mozfile 16:10:21 INFO - Running setup.py install for mozhttpd 16:10:21 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:10:21 INFO - Running setup.py install for mozinfo 16:10:21 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:10:21 INFO - Running setup.py install for mozInstall 16:10:21 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:10:21 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:10:21 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:10:21 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:10:21 INFO - Running setup.py install for mozleak 16:10:21 INFO - Running setup.py install for mozlog 16:10:21 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:10:21 INFO - Running setup.py install for moznetwork 16:10:21 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:10:21 INFO - Running setup.py install for mozprocess 16:10:21 INFO - Running setup.py install for mozprofile 16:10:21 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:10:21 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:10:21 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:10:21 INFO - Running setup.py install for mozrunner 16:10:22 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:10:22 INFO - Running setup.py install for mozscreenshot 16:10:22 INFO - Running setup.py install for moztest 16:10:22 INFO - Running setup.py install for mozversion 16:10:22 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:10:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:10:22 INFO - Cleaning up... 16:10:22 INFO - Return code: 0 16:10:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:10: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:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10: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:10:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:22 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f8476d1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203f500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c6a0>, '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 0x203d5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203da30>, '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': 'b00de3c228505fac2445e70d000001bb-1450828060.651877-80247873', '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:10:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:10:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:10:22 INFO - Using env: {'DISPLAY': ':0', 16:10:22 INFO - 'HOME': '/home/cltbld', 16:10:22 INFO - 'LANG': 'en_US.UTF-8', 16:10:22 INFO - 'LANGUAGE': 'en_US:en', 16:10:22 INFO - 'LOGNAME': 'cltbld', 16:10:22 INFO - 'MAIL': '/var/mail/cltbld', 16:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:22 INFO - 'MOZ_NO_REMOTE': '1', 16:10:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:22 INFO - 'NO_EM_RESTART': '1', 16:10:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:10:22 INFO - 'PWD': '/builds/slave/test-pgo', 16:10:22 INFO - 'SHELL': '/bin/bash', 16:10:22 INFO - 'SHLVL': '1', 16:10:22 INFO - 'TERM': 'linux', 16:10:22 INFO - 'TMOUT': '86400', 16:10:22 INFO - 'USER': 'cltbld', 16:10:22 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450828060.651877-80247873', 16:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:22 INFO - '_': '/tools/buildbot/bin/python'} 16:10:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:10:22 INFO - Running setup.py (path:/tmp/pip-tPhG8e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:10:22 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:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:10:22 INFO - Running setup.py (path:/tmp/pip-YNMf7Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:10:22 INFO - Running setup.py (path:/tmp/pip-7iQi1m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:10:22 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:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:10:22 INFO - Running setup.py (path:/tmp/pip-A0ezZg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:10:22 INFO - Running setup.py (path:/tmp/pip-UFdTyU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:10:22 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:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:10:22 INFO - Running setup.py (path:/tmp/pip-9mJpEA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:10:23 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:10:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:10:23 INFO - Running setup.py (path:/tmp/pip-dPDYsN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:10:23 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:10:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:10:23 INFO - Running setup.py (path:/tmp/pip-LjmAlb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:10:23 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:10:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:10:23 INFO - Running setup.py (path:/tmp/pip-Znbkmk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:10:23 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:10:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:10:23 INFO - Running setup.py (path:/tmp/pip-ZmC50W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:10:23 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:10:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:10:23 INFO - Running setup.py (path:/tmp/pip-GHwp51-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:10:23 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:10:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:10:23 INFO - Running setup.py (path:/tmp/pip-y4fCnE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:10:23 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:10:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:10:23 INFO - Running setup.py (path:/tmp/pip-62tLrF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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:10:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:10:23 INFO - Running setup.py (path:/tmp/pip-Fn82Xk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:10:23 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:10:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:10:23 INFO - Running setup.py (path:/tmp/pip-BZHmBf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:10:23 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:10:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:10:23 INFO - Running setup.py (path:/tmp/pip-EHbRU3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:10:23 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:10:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:10:23 INFO - Running setup.py (path:/tmp/pip-LgRHf9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:10:23 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:10:23 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.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:10:23 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.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:10:23 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:10:23 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:10:23 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:10:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:10:23 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:10:23 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:10:23 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:10:23 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:10:23 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:10:23 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:10:25 INFO - Downloading blessings-1.5.1.tar.gz 16:10:25 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 16:10:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:10:25 INFO - Installing collected packages: blessings 16:10:25 INFO - Running setup.py install for blessings 16:10:25 INFO - Successfully installed blessings 16:10:25 INFO - Cleaning up... 16:10:25 INFO - Return code: 0 16:10:25 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:10:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:10:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:10:26 INFO - Reading from file tmpfile_stdout 16:10:26 INFO - Current package versions: 16:10:26 INFO - argparse == 1.2.1 16:10:26 INFO - blessings == 1.5.1 16:10:26 INFO - blobuploader == 1.2.4 16:10:26 INFO - docopt == 0.6.1 16:10:26 INFO - manifestparser == 1.1 16:10:26 INFO - mozInstall == 1.12 16:10:26 INFO - mozcrash == 0.16 16:10:26 INFO - mozdebug == 0.1 16:10:26 INFO - mozdevice == 0.47 16:10:26 INFO - mozfile == 1.2 16:10:26 INFO - mozhttpd == 0.7 16:10:26 INFO - mozinfo == 0.9 16:10:26 INFO - mozleak == 0.1 16:10:26 INFO - mozlog == 3.1 16:10:26 INFO - moznetwork == 0.27 16:10:26 INFO - mozprocess == 0.22 16:10:26 INFO - mozprofile == 0.27 16:10:26 INFO - mozrunner == 6.11 16:10:26 INFO - mozscreenshot == 0.1 16:10:26 INFO - mozsystemmonitor == 0.0 16:10:26 INFO - moztest == 0.7 16:10:26 INFO - mozversion == 1.4 16:10:26 INFO - psutil == 3.1.1 16:10:26 INFO - requests == 1.2.3 16:10:26 INFO - wsgiref == 0.1.2 16:10:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:10:26 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:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:26 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:10:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:26 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f8476d1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203f500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c6a0>, '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 0x203d5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203da30>, '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': 'b00de3c228505fac2445e70d000001bb-1450828060.651877-80247873', '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:10:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:10:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:10:26 INFO - Using env: {'DISPLAY': ':0', 16:10:26 INFO - 'HOME': '/home/cltbld', 16:10:26 INFO - 'LANG': 'en_US.UTF-8', 16:10:26 INFO - 'LANGUAGE': 'en_US:en', 16:10:26 INFO - 'LOGNAME': 'cltbld', 16:10:26 INFO - 'MAIL': '/var/mail/cltbld', 16:10:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:26 INFO - 'MOZ_NO_REMOTE': '1', 16:10:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:26 INFO - 'NO_EM_RESTART': '1', 16:10:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:10:26 INFO - 'PWD': '/builds/slave/test-pgo', 16:10:26 INFO - 'SHELL': '/bin/bash', 16:10:26 INFO - 'SHLVL': '1', 16:10:26 INFO - 'TERM': 'linux', 16:10:26 INFO - 'TMOUT': '86400', 16:10:26 INFO - 'USER': 'cltbld', 16:10:26 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450828060.651877-80247873', 16:10:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:26 INFO - '_': '/tools/buildbot/bin/python'} 16:10:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:26 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 1)) 16:10:26 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 2)) 16:10:26 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 3)) 16:10:26 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 4)) 16:10:26 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 5)) 16:10:26 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 6)) 16:10:26 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 7)) 16:10:26 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 8)) 16:10:26 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:10:26 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 3)) 16:10:26 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:10:26 INFO - Cleaning up... 16:10:26 INFO - Return code: 0 16:10:26 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:10:26 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:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:26 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:10:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:26 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f8476d1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203f500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c6a0>, '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 0x203d5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203da30>, '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': 'b00de3c228505fac2445e70d000001bb-1450828060.651877-80247873', '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:10:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:10:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:10:26 INFO - Using env: {'DISPLAY': ':0', 16:10:26 INFO - 'HOME': '/home/cltbld', 16:10:26 INFO - 'LANG': 'en_US.UTF-8', 16:10:26 INFO - 'LANGUAGE': 'en_US:en', 16:10:26 INFO - 'LOGNAME': 'cltbld', 16:10:26 INFO - 'MAIL': '/var/mail/cltbld', 16:10:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:26 INFO - 'MOZ_NO_REMOTE': '1', 16:10:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:26 INFO - 'NO_EM_RESTART': '1', 16:10:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:10:26 INFO - 'PWD': '/builds/slave/test-pgo', 16:10:26 INFO - 'SHELL': '/bin/bash', 16:10:26 INFO - 'SHLVL': '1', 16:10:26 INFO - 'TERM': 'linux', 16:10:26 INFO - 'TMOUT': '86400', 16:10:26 INFO - 'USER': 'cltbld', 16:10:26 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450828060.651877-80247873', 16:10:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:26 INFO - '_': '/tools/buildbot/bin/python'} 16:10:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:26 INFO - Downloading/unpacking jsonschema 16:10:26 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:10:26 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:10:26 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:10:26 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:10:26 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:10:26 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:10:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:10:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 16:10:28 INFO - Downloading/unpacking functools32 (from jsonschema) 16:10:28 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:10:28 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:10:28 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:10:28 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:10:28 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:10:28 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:10:28 INFO - Downloading functools32-3.2.3-2.tar.gz 16:10:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 16:10:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:10:28 INFO - warning: no files found matching '*.txt' 16:10:28 INFO - no previously-included directories found matching 'build' 16:10:28 INFO - no previously-included directories found matching 'dist' 16:10:28 INFO - no previously-included directories found matching '.git*' 16:10:28 INFO - Installing collected packages: jsonschema, functools32 16:10:28 INFO - Running setup.py install for functools32 16:10:28 INFO - warning: no files found matching '*.txt' 16:10:28 INFO - no previously-included directories found matching 'build' 16:10:28 INFO - no previously-included directories found matching 'dist' 16:10:28 INFO - no previously-included directories found matching '.git*' 16:10:28 INFO - Successfully installed jsonschema functools32 16:10:28 INFO - Cleaning up... 16:10:28 INFO - Return code: 0 16:10:28 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f8476d1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203f500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c6a0>, '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 0x203d5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203da30>, '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': 'b00de3c228505fac2445e70d000001bb-1450828060.651877-80247873', '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:10:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:10:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:10:28 INFO - Using env: {'DISPLAY': ':0', 16:10:28 INFO - 'HOME': '/home/cltbld', 16:10:28 INFO - 'LANG': 'en_US.UTF-8', 16:10:28 INFO - 'LANGUAGE': 'en_US:en', 16:10:28 INFO - 'LOGNAME': 'cltbld', 16:10:28 INFO - 'MAIL': '/var/mail/cltbld', 16:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:28 INFO - 'MOZ_NO_REMOTE': '1', 16:10:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:28 INFO - 'NO_EM_RESTART': '1', 16:10:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:10:28 INFO - 'PWD': '/builds/slave/test-pgo', 16:10:28 INFO - 'SHELL': '/bin/bash', 16:10:28 INFO - 'SHLVL': '1', 16:10:28 INFO - 'TERM': 'linux', 16:10:28 INFO - 'TMOUT': '86400', 16:10:28 INFO - 'USER': 'cltbld', 16:10:28 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450828060.651877-80247873', 16:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:28 INFO - '_': '/tools/buildbot/bin/python'} 16:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:28 INFO - Downloading/unpacking flake8 16:10:28 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:10:28 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:10:28 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:10:28 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:10:28 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:10:28 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:10:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:10:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 16:10:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:10:30 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:10:30 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:10:30 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:10:30 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:10:30 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:10:30 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:10:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:10:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 16:10:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:10:30 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:10:30 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:10:30 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:10:30 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:10:30 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:10:30 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:10:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 16:10:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:10: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:10: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:10: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:10: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:10: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:10: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:10:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 16:10:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:10:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:10:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:10:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:10:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:10:31 INFO - no previously-included directories found matching 'docs/_build' 16:10:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:10:31 INFO - Running setup.py install for pep8 16:10:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:10:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:10:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:10:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:10:31 INFO - no previously-included directories found matching 'docs/_build' 16:10:31 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:10:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:10:31 INFO - Cleaning up... 16:10:31 INFO - Return code: 0 16:10:31 INFO - Running post-action listener: _resource_record_post_action 16:10:31 INFO - Running post-action listener: _start_resource_monitoring 16:10:31 INFO - Starting resource monitoring. 16:10:31 INFO - ##### 16:10:31 INFO - ##### Running install step. 16:10:31 INFO - ##### 16:10:31 INFO - Running pre-action listener: _resource_record_pre_action 16:10:31 INFO - Running main action method: install 16:10:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:10:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:10:31 INFO - Reading from file tmpfile_stdout 16:10:31 INFO - Detecting whether we're running mozinstall >=1.0... 16:10:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:10:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:10:31 INFO - Reading from file tmpfile_stdout 16:10:31 INFO - Output received: 16:10:31 INFO - Usage: mozinstall [options] installer 16:10:31 INFO - Options: 16:10:31 INFO - -h, --help show this help message and exit 16:10:31 INFO - -d DEST, --destination=DEST 16:10:31 INFO - Directory to install application into. [default: 16:10:31 INFO - "/builds/slave/test-pgo"] 16:10:31 INFO - --app=APP Application being installed. [default: firefox] 16:10:31 INFO - mkdir: /builds/slave/test-pgo/build/application 16:10:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 16:10:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 16:10:46 INFO - Reading from file tmpfile_stdout 16:10:46 INFO - Output received: 16:10:46 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:10:46 INFO - Running post-action listener: _resource_record_post_action 16:10:46 INFO - ##### 16:10:46 INFO - ##### Running run-tests step. 16:10:46 INFO - ##### 16:10:46 INFO - Running pre-action listener: _resource_record_pre_action 16:10:46 INFO - Running main action method: run_tests 16:10:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:10:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:10:46 INFO - Python 2.7.3 16:10:46 INFO - Return code: 0 16:10:46 INFO - grabbing minidump binary from tooltool 16:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:46 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 0x203c6a0>, '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 0x203d5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203da30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:10:46 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:10:46 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:10:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:10:46 INFO - Return code: 0 16:10:46 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:10:46 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:10:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:10:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:10:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:10:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:10:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:10:47 INFO - Return code: 0 16:10:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 16:10:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost 16:10:47 INFO - Using env: {'DISPLAY': ':0', 16:10:47 INFO - 'HOME': '/home/cltbld', 16:10:47 INFO - 'LANG': 'en_US.UTF-8', 16:10:47 INFO - 'LANGUAGE': 'en_US:en', 16:10:47 INFO - 'LOGNAME': 'cltbld', 16:10:47 INFO - 'MAIL': '/var/mail/cltbld', 16:10:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:10:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:47 INFO - 'MOZ_NO_REMOTE': '1', 16:10:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:10:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:47 INFO - 'NO_EM_RESTART': '1', 16:10:47 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:10:47 INFO - 'PWD': '/builds/slave/test-pgo', 16:10:47 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:10:47 INFO - 'SHELL': '/bin/bash', 16:10:47 INFO - 'SHLVL': '1', 16:10:47 INFO - 'TERM': 'linux', 16:10:47 INFO - 'TMOUT': '86400', 16:10:47 INFO - 'USER': 'cltbld', 16:10:47 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1450828060.651877-80247873', 16:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:47 INFO - '_': '/tools/buildbot/bin/python'} 16:10:47 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost'] with output_timeout 3600 16:10:47 INFO - mozversion INFO | application_buildid: 20151222134825 16:10:47 INFO - mozversion INFO | application_changeset: 586fe84e48ca9f914880e5fdbf3dbdae1e82b5e7 16:10:47 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 16:10:47 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:10:47 INFO - mozversion INFO | application_name: Firefox 16:10:47 INFO - mozversion INFO | application_remotingname: firefox-dev 16:10:47 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:10:47 INFO - mozversion INFO | application_vendor: Mozilla 16:10:47 INFO - mozversion INFO | application_version: 45.0a2 16:10:47 INFO - mozversion INFO | platform_buildid: 20151222134825 16:10:47 INFO - mozversion INFO | platform_changeset: 586fe84e48ca9f914880e5fdbf3dbdae1e82b5e7 16:10:47 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:10:47 INFO - mozversion INFO | platform_version: 45.0a2 16:10:47 INFO - 2015-12-22 16:10:47,706 DEBUG : using testdate: 1450829447 16:10:47 INFO - 2015-12-22 16:10:47,706 DEBUG : actual date: 1450829447 16:10:47 INFO - 2015-12-22 16:10:47,783 INFO : starting webserver on 'localhost:45682' 16:10:47 INFO - 2015-12-22 16:10:47,784 INFO : Starting test suite talos-linux64-ix-028.e 16:10:47 INFO - 2015-12-22 16:10:47,784 INFO : Starting test dromaeo_css 16:10:47 INFO - 2015-12-22 16:10:47,784 DEBUG : operating with platform_type : linux_ 16:10:47 INFO - 2015-12-22 16:10:47,785 INFO : Initialising browser for dromaeo_css test... 16:10:47 INFO - 2015-12-22 16:10:47,797 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqL4N4K/profile http://localhost:45682/getInfo.html 16:10:52 INFO - 2015-12-22 16:10:52,044 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:10:52 INFO - 2015-12-22 16:10:52,044 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:10:52 INFO - 2015-12-22 16:10:52,044 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:10:52 INFO - 2015-12-22 16:10:52,044 DEBUG : BROWSER_OUTPUT: __metrics 16:10:53 INFO - 2015-12-22 16:10:53,078 INFO : Browser initialized. 16:10:53 INFO - 2015-12-22 16:10:53,078 INFO : Running cycle 1/1 for dromaeo_css test... 16:10:53 INFO - 2015-12-22 16:10:53,079 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqL4N4K/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:11:04 INFO - 2015-12-22 16:11:04,894 DEBUG : BROWSER_OUTPUT: RSS: Main: 138403840 16:11:04 INFO - 2015-12-22 16:11:04,895 DEBUG : BROWSER_OUTPUT: 16:11:54 INFO - 2015-12-22 16:11:54,510 DEBUG : BROWSER_OUTPUT: 1450829514505 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:14:02 INFO - 2015-12-22 16:14:02,555 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45682/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45682/tests/dromaeo/cssquery-ext.html) 16:14:03 INFO - 2015-12-22 16:14:03,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 142114816 16:14:03 INFO - 2015-12-22 16:14:03,540 DEBUG : BROWSER_OUTPUT: 16:17:05 INFO - 2015-12-22 16:17:05,302 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45682/tests/dromaeo/cssquery-ext.html (next: http://localhost:45682/tests/dromaeo/cssquery-jquery.html) 16:17:05 INFO - 2015-12-22 16:17:05,888 DEBUG : BROWSER_OUTPUT: RSS: Main: 140226560 16:17:05 INFO - 2015-12-22 16:17:05,889 DEBUG : BROWSER_OUTPUT: 16:20:07 INFO - 2015-12-22 16:20:07,484 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45682/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45682/tests/dromaeo/cssquery-mootools.html) 16:20:08 INFO - 2015-12-22 16:20:08,066 DEBUG : BROWSER_OUTPUT: RSS: Main: 138506240 16:20:08 INFO - 2015-12-22 16:20:08,066 DEBUG : BROWSER_OUTPUT: 16:23:09 INFO - 2015-12-22 16:23:09,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45682/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45682/tests/dromaeo/cssquery-prototype.html) 16:23:10 INFO - 2015-12-22 16:23:10,180 DEBUG : BROWSER_OUTPUT: RSS: Main: 139403264 16:23:10 INFO - 2015-12-22 16:23:10,180 DEBUG : BROWSER_OUTPUT: 16:26:12 INFO - 2015-12-22 16:26:12,440 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45682/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45682/tests/dromaeo/cssquery-yui.html) 16:26:13 INFO - 2015-12-22 16:26:13,022 DEBUG : BROWSER_OUTPUT: RSS: Main: 140222464 16:26:13 INFO - 2015-12-22 16:26:13,022 DEBUG : BROWSER_OUTPUT: 16:29:15 INFO - 2015-12-22 16:29:15,050 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45682/tests/dromaeo/cssquery-yui.html (next: http://localhost:45682/tests/dromaeo/cssquery-dojo.html) 16:29:15 INFO - 2015-12-22 16:29:15,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 142639104 16:29:15 INFO - 2015-12-22 16:29:15,301 DEBUG : BROWSER_OUTPUT: 16:29:15 INFO - 2015-12-22 16:29:15,301 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:29:15 INFO - 2015-12-22 16:29:15,301 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:29:15 INFO - 2015-12-22 16:29:15,301 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:29:15 INFO - 2015-12-22 16:29:15,301 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:29:15 INFO - 2015-12-22 16:29:15,302 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3377.763556551041;3419.401604719175;3434.0899661589697;3452.741044421669;3458.2046129390246;5688.886222275557;5689.743961521731;5699.74351154198;5720.713964301784;5722.113072473763;5705.686187259699;5731.885362292752;5732.340780810208;5734.770609175628;5742.368339482654;5199.038177937075;5210.713410762407;5254.553362964152;5275.6043296752705;5298;5103.362079740033;5142.717150556718;5201.55786758126;5214.374275086995;5238.79044838206;5152.355955505562;5240.842774716764;5254.343207099113;5255.211718242275;5256.26412302278;5230;5252.185911183773;5276.234945932857;5280.3663560373;5323.840284791462;4973;5019.949800502021;5025.321581586476;5181.5077567631015;5191.532762051395;5482.972585137089;5486.780528778844;5510.421405752379;5528.530074943635;5529.529989950859;6137.263528376623;6140.4473597376;6151.415615516519;6163.691815409256;6174.660393678346;5950.434708702666;6118.847028824271;6136.386361363828;6140.631562106243;6207.162033125515;5625.09998400254;5655.208270842086;5763.682997435181;5785.2189954356045;5803.187553742438;6286.49708023357;6308.337624549356;6318.336574659595;6323.778667746698;6354.205724284465;5859.355470898197;6093.23101592027;6093.99449090895;6113.816585502442;6116.35778243278;6053.394660534;6087.391260873877;6142.201513803177;6192.318844927055;6195.783147589813;6104.3590423005835;6133.172021777093;6159.414855588712;6168.722407491674;6196.411340922605;5819;5885.440883116097;6158.599691020069;6168.1056246844855;6170.197874276405;4621.676482646182;4674.532546745366;4674.906501869944;4678.906421871544;4709.576138147583;4230.534641189467;4231.830726770956;4243.533211346749;4258.020655249248;4266.445362102907;5739;5761.711914404263;5827;5968.820935371946;5975.701214939322;6237.688115594202;6252.218472690914;6267.310595834455;6269.498440124779;6273.811785646438;5935.970320148458;5945.7621695132575;5960.85097872548;5961.433663801932;5963.4334738199805;5237.8428647140645;5322.946770532322;5354.759035843396;5364;5436.238926550286;6283.654399008007;6340;6342.207224096988;6346.9682651586445;6365.777197798055;6142.385761423822;6193.721282542297;6193.81418557444;6198.318184999556;6198.721057552511;6129.478994285536;6237.407446292595;6265;6386.074019267273;6412.839679008062;6102.755889764359;6158.168647232566;6208.068789681584;6208.317085120723;6234.0337247726675;6035.215421995288;6285.182926219562;6286.811395658137;6292.433680968735;6298.590591611531;5977.402259774161;6014.518838492998;6098.75604975796;6124.8775024500155;6126.816195514141;6018.097285407049;6029.3669164737075;6041.939580604314;6063.454289114001;6068.848278793065;5640.125780504029;5814.651120932588;5952.553558483044;5967.582269241285;5972.9701351494705;5912.142739302863;5942.049272116441;6019.608725432833;6020.698965051817;6026.517878569792;5918.112283157561;6006.339302676614;6021.7591296347655;6024.548158888013;6028.668423236764 16:29:15 INFO - 2015-12-22 16:29:15,303 DEBUG : BROWSER_OUTPUT: |1;ext.html;595.2351228671156;635.8124353315774;635.9300476947537;645.8320836582488;653.2716021635878;32503.837480812592;33858;38112.80943595285;38670.419943700865;39004.21991560167;45514.31728524075;46062;46267.30599041009;46285.1485940562;46342.53657463424;9044.90955090449;9077.773055673595;9195.678151264707;9215.400998935082;9222.262219022496;8945.955270223672;9044.05037471066;9056.456612603264;9058.184763371295;9073.954630226839;9081.182693557612;9086.954565227164;9144.268458523335;9159.633614655406;9174.587143578556;8767.824643507127;8801.251893589053;8936.731898043005;8983.910160898373;9051.456912585232;8956;9100.180983711498;9103.453792772454;9115.772105697411;9121.726348209499;41450;41616.79191604022;41952.160956781;41976.370354444705;42159;3645.2162785001087;3669.1377526281303;3772;4080.204360149772;4213.367994800805;31379.48157711784;31779.04662860118;31788.887388941275;31811.84094079538;32415.51376729351;4132.297509423405;4235.809388577491;4250.958515163774;4264.6801489888385;4323.135372925428;276766;277415.6129219361;277563;278286;279323;44799.32801007987;44989;45055;45153.77423112929;45490.31764523535;42347;42644;42803.35794963016;42946.355804662955;42968.57031429708;15427.30577124032;15605.68788624221;15609.375624974873;15665.843341566666;15748.92125539388;11448.313101213787;11491.42542872853;11543.653690389301;11564.363959982282;12020.63938081859;15597.83016273784;15612.219389030502;15614.531564053097;15620.140892251035;15660.295286712126;6161.199044124325;6242.469390101802;6263.964211631147;6293.874122517524;6408.263049749338;1056.9154467642725;1077.5151181968147;1087.271528076175;1103.5751235774123;1125.386664267976;28837.27906802347;29035.274118147216;29044.273893152418;29532.704672953427;29681.703182967893;1103.7020004598714;1104.6741211342674;1115.8716747573972;1117.7820325036703;1122.4668282565715;14358.784618230735;17261.39585114515;17613.207405666777;17935.372261971028;17937.192826322847;814154;819944;824070;827294;827361;57248.42751572514;57507.42492575021;57630.4236957625;57747;57857;1464.7583148780545;1488.672492051747;1507.1936513964977;1515.613518552762;1523.9238038098051;30031.849840750656;30543.628048171206;30572.694273056986;31326.686733132377;31342.529862052543;47285;48162.518374817206;48339.5166048335;48405;48520.27219591638;321269;321905;322484;322565;324571;33938.793978391324;49272.75363623159;49592.75203623959;49867.750661246464;50169;45612.543874560826;46276.7686161567;46334.53665463302;46565;46578.76710616561;39068.218635627694;39673.801630991664;39730.80134599309;39919.80040099781;40322.1935561293;38715.612843871204;38987;39572;39655.60344396519;39942.600573993885;43501.12997740091;43586;43828;43965.560344396145;44659.330110047726;33315.50026749649;33863.492047619795;34418;34548.654513454545;34596.30807383889;26217.213483595522;26894.193174204804;26962.191134266002;27539.586906196822;28101.859490703235 16:29:15 INFO - 2015-12-22 16:29:15,306 DEBUG : BROWSER_OUTPUT: |2;jquery.html;390.9413587961805;393.35097089801826;393.842463014794;394.899300678327;396.7203121799132;15772.21138943054;16786.66426671466;17682.734758978608;19979.400617981464;20114.295999640017;11637.534498620067;11992.580259690912;12201.816972745415;12226.44980975856;12259.693507662312;5124.128898087334;5192.584593232532;5265.289185959904;5267.157254839227;5280.471952804708;5362.758675859595;5485.835424937259;5489.34127904652;5499.120140777476;5599.888002239953;5460.235567020621;5472.124460086367;5505.449455054482;5534.667919924797;5722.141678748179;5657.745401456924;5660.433956604327;5667.546596272288;5670.7731690732735;5677.290338707661;5478.506934375885;5570.275864137677;5571.387147413781;5761.942380576183;5768.048272035109;12947.741045179044;13133.934330328288;13152.210867347894;17731.37940172088;21221;2272.556851413975;2275.943101422461;2282.7146606674164;2417.16607770319;2451.705795304557;10117.241206909512;10382.117520010808;10554.577816887315;12052.216605920587;13939.705875004356;1891.6216756648726;1901.5151136460252;1923.307609260665;1932.8357089647398;1967;64028.67985660042;65765.3423465764;65958.3404165957;66746.3325366745;67000.6649966747;10780.137588992862;11049.558017679363;11067.833982490269;11160.386178760084;11176.776464470666;14775.92612036933;14866.108033518023;14972;14999.625009374853;15022.924885375503;8230.176982301722;8288.792780180544;8382.538960357238;8391.496510209285;8408.453450525696;7951.324137448266;7974.5215287082965;7992.880106798402;8025.919740802634;8033.19668033192;4361.890952726144;4576.794044268016;4718.292256161603;4774.856754297377;4781.163296423112;1877.418000419847;1989.1844343818964;2014.0433294185439;2019.5052212207809;2045.5397535554382;842.7640260727006;886.2998231397253;900.2887718702283;977.2914636888199;978.5303054533864;14463;17130.314787408613;17668.646627067643;18776.0611969401;19331.613367732567;1053.536443964653;1066.3228849680509;1109.8002359575194;1110.3448965110624;1132.9603463878725;9986.400815950921;10161.796764064826;10193.592256309812;10250.231232657581;10302.948485257526;451953;454210;461135;739241;744494;71931.2806871935;73924;76620;81163.59418202871;90130.54934725285;1181.5923506390109;1187.3884949251142;1205.487667741224;1206.029146537046;1218.147296892179;15248.085114893142;15388.84611153919;15457.149856757986;15495.535133946;15682.294296756902;20003.499912502302;32666.693332267394;33067.66932330742;33867.322653547286;33950.49074263839;37287.44068838915;40515;45080.323795143755;47228.7638561805;47993;9348.158665720119;9551.570179342085;9676.612935482503;9689.70930872075;9734.36726612768;16951.406700765416;17687.55781105431;17932.820671793113;18057.097145142954;18115.365962191787;14513.274336282933;14721.631959201106;14748.63128421798;14823.332950017491;15213.771793422886;14488.203148826915;14938.775918361016;15118.773218401953;15128.773068404204;15167.772483412979;15015.399384024517;15358;15399.61500962485;15630.843691562939;15656.608584785472;10105.292629515863;10406.58373665045;10481.737956551147;10851.620193293196;10854.403007834644;15139.772903406678;15595.454159104831;15935.760963585324;15968.201589920689;16094.597635059217 16:29:15 INFO - 2015-12-22 16:29:15,307 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1483.8071050763403;1497.1092200140915;1677.471596447119;1803.6032072943947;1821.6265665538565;8074.071481779597;8285.54429506377;8328.54193019383;8372.581370931452;8541.829163416727;8580.613872375758;8631.30949524038;8669.133086691329;8722.520261385622;8725.694600688978;2453.619688948211;2478.0954951442773;2483.1433155561394;2488.4027833319965;2492.5762620354494;2449.6570480132796;2452.509498100378;2491.0907518755616;2495.051880285489;2495.9750402496015;2400.9159679411223;2417.9758202417925;2443.535728211643;2457.741937096606;2466.679331686887;2426.6238732996326;2464.297675162588;2464.4824586836785;2467.506498700267;2473.480569080495;2376.346504711201;2477.380654836291;2478.368016155887;2483.205374280231;2483.689538807649;8480.915190848136;8523.318134549221;8534.487930724114;8550.01674807399;8571.699990500303;5052.0906236877345;5139.408967968694;5152.098382782998;5161.354830646169;5167.199084141964;3289.9506507402407;3315.419801534722;3339.8497067632015;3356.093854659253;3394.7793393429347;1040.921930855189;1058.6929790360787;1059.3273271472594;1060.2101434431397;1082.5020490574345;11792.764144717143;11818.468168932419;11835.585754498552;11897;11933.403329833474;4417.580329868657;4442.755648439303;4493.865184044484;4527.275635898241;4545.568171023813;9506.90493095074;9520.952395237979;9567.234621230285;9588.37675551087;9595.28035397348;5077.7715002824225;5079;5083.186690129562;5109.718965456861;5120.769565369567;4627.8611641650805;4642.582167604932;4679.298105284234;4680.438347398334;4692.788824502905;3816.656500914931;3826.521684789401;3831.4635950966886;3856.4986551748093;3956.050547868491;1129.2772625519674;1134.9319040857574;1142.3374442823308;1143.857017872766;1147.7991351513451;1178.5109179690332;1186.0689358853258;1294.7086905446388;1420.5028240115876;1439.16528413522;7710.730124445618;7770.961145194351;7997.960010199912;8052.838943221102;8056.194380562014;1209.3167360441323;1210.1589395370308;1217.0811037666506;1226.5952235762177;1249.4127759952808;6266.624002559861;6281.371862813682;6286.968565157145;6353.205849268841;6363.204599425072;10300.690979270634;10354.844677329846;10371.58513659445;10373.377597344184;10399.84400233997;9897.40615563054;10159.644412445528;10211;10229.232807539463;10264.794704105876;7993.68025278994;8082.515049097073;8102.230288122619;8106.47307924983;8151.30713889326;8020.959895200486;8080;8104;8124.55314957683;8144.592770361577;8928.553572321229;9099.818003640023;9178.173964343241;9201.815963680823;9213.493257870614;9362.297827662816;9419.246460283299;9494.430334179971;9503.429794212369;9644.132028117503;7246.7101315946775;7325.560466372035;7382.926170738224;7408.333250007525;7421.332080112816;8108;8112.878306825521;8137.552434615916;8171.182881711781;8176.591170441573;6800.761973330909;7737.3036426721865;7829.921700782919;7862.095858976291;7868.84262314762;7462.10454745434;7567.31894129531;7592.278733520307;7620.314171724572;7697.576633285223;7621.885671714817;7650.196729343562;7672.271134242238;7696.653650585625;7696.7306144284685;6907.654617269217;6987.825304367431;6989.126359205099;7052.647367631701;7070.257622949722;7007.579545227302;7062;7093.467989900675;7101;7102.254263302486 16:29:15 INFO - 2015-12-22 16:29:15,310 DEBUG : BROWSER_OUTPUT: |4;prototype.html;368.3847973883615;372.50642898159947;373.2218324792807;377.322705743191;381.3250546532639;6315.431611154995;6319.77880774173;6398.9680051599735;6403.039544068386;6516.0877477153235;6305;6330;6355.872882542347;6360.745570177199;6374.426301632852;4857.077155340492;4871.805127794884;4873.805047798101;4882.462929077798;4889.633277504184;4874.220124780036;4876.049170411771;4887.584555312803;4895.437024742165;4896.1186986342445;4629.8148074077;4701.059788042388;4756.548127927841;4764.690295130806;4790.257510085942;4752.215884379073;4781.497942716;4807.351007613962;4810.158222311082;4812.061647978646;4199.118185181115;4200.327947528412;4202.873913782591;4211.515675697304;4214.578542145791;5920.763169473259;5938.406159384071;5941.732622032019;5941.970290148522;5958.910616340759;5533.22534845122;5574.60977731559;5622.746976386073;5629.971850140723;5643.887122257573;6691.5315927884585;6695.263521012685;6700.195976482804;6707.966460167717;6724.3611856874;4658.720476771371;4658.930116048262;4664.207084795593;4668.626509879202;4671.813127474931;6881.346272104142;6939.375456208965;6956.582605043714;7009.649517524154;7010.579365238102;4763.7141771493825;4807.399075115611;4809;4813.326134341195;4813.350197723333;4871.2206047032305;4871.3667223260745;4880.243562247857;4882.121218180761;4884.926726099111;5622.690752008597;5629.268195134607;5630.324361076615;5636.4927156556105;5637.9718101409235;6545.116409284686;6698.665066746643;6741.8651626967185;6755.2906944771075;6761.661916904135;1703.6763015027104;1706.5818874375857;1715.6482921001166;1719.6388758360633;1723.7242041273337;1152.6196355202762;1154.2324354304462;1156.3119943633524;1168.7662467506532;1170.5083864776814;6553.639549824806;6553.705083271264;6564.146660934143;6566.277709451956;6571.868562628721;6920.723171073201;6926.757563485254;6942.652867356612;6961.477889158334;6966.5471744336455;6427.935720642734;6533.738650454024;6552.082708420825;6584.8024559263295;6600.240972288152;3734.458503516975;3813.0848596336677;3829.4447305141157;3836.194399176204;3841.0589405595806;7121;7142.178649455379;7143.4999550031;7147.82130446743;7150.856982860418;7071.292870712888;7206.243344448862;7211.242819503981;7254.274572542704;7264.200937896827;7214.386777123898;7237.203907570269;7241.963790181121;7248.528845625017;7251.274872512707;6950.478714096362;6969.825754356181;6970.093887794555;6990.510664253657;7006.894896576454;6796.72813087471;6929.965350173217;6947.062146610143;6947.930520694728;6967.965160174167;7221.566705997657;7225.819354516179;7236.38490728294;7239.457040721862;7249.710011599688;4763.4522029967;4795.664303498861;4800.303955926441;4800.879978000578;4802.991371811819;6893.7931862044215;7052.647367631701;7057.36483716468;7059.5764254144915;7062.71749130029;6846.383825455733;6851.246362899978;6852.109225800813;6855.485838562227;6861.416779573792;6551.312112228338;6739.1804212863235;6808.795736127924;6812.795616131524;6813.965930170318;6637.900431493628;6711.161104861892;6716.3955244028275;6722.462203023844;6728.259891411843;6781.6270105144695;6840.931590684029;6856.862862742817;6867.244603093755;6872.175338959357;6573.3426657333885;6651.900221496585;6676.666166691549;6682.866342673022;6684 16:29:15 INFO - 2015-12-22 16:29:15,310 DEBUG : BROWSER_OUTPUT: |5;yui.html;856.2379482260789;934.7943452440466;938.1978408460761;944.140831843023;958.0993865766179;13381.7992730109;13798.517051903185;13836.893048556116;13845.792313115298;13891.513797017107;13307.667308317297;13439.93280033601;13450.5292314769;13474.663133421669;13536.526221582246;876.1370050500252;883.8718385834051;887.5029983209423;890.9599068041921;892.6429428228696;865.7272959017921;890.2922176869405;891.131147131548;893.3344658229628;897.58710992943;907.4237858959575;921.6912334367995;929.6420877961966;929.8465753150722;929.9209567186764;890.0876601483467;909.3316412436853;911.1617312072909;912.8265629530368;921.6912334367995;686.0772261308532;689.1489011071322;693.2997672350912;694.6596167877703;695.5826504097552;13596;13630.727385452334;13702.657433564142;13728.519501817389;13735;12343.93828030863;12497.375131243401;12657.30384828834;13037.478500859954;13729.931350343284;10629.309094908805;10846.837297440545;10981.780364392667;11151.275167114112;11287.435628218556;3802.8478860845535;3874.1670540833857;3882.9029274268087;3888.727789054767;3902.083010492532;51382.22926656103;51628;53209;53477;53508.19737703977;9972.60109595608;10048.246381521269;10138;10208.693739187836;10227.335223210468;19242.903785480983;19270.132844022053;19278.421647350602;19311.710324345146;19349.709754353695;7473.1032276126125;7537.283958023979;7556.357709594746;7791.80520486981;7824.491408058458;4536;4607.470140933836;4632.235681112578;4706.788194531255;4726.95273047272;3410.9829450853085;3415.9146021349666;3461.3423449544507;3463.0303515015835;3475;644.3685188515187;664.5979182594557;670.1254862404609;671.7111641993891;673.1988933169513;633.7926250492818;678.1489231015144;689.4312192441256;722.6856317501904;726.5459088069956;8737.912620873836;9167.17495425415;9177.403468774508;9292.860607090899;9404.106609872051;609.8170548835332;731.2833423245249;734.9637011813318;747.5365273530338;769.3998681028806;3912.39357899526;4124.587541245912;4185.267578173807;4310.892227694333;4427.424434823517;56980.43019569834;57090.714546427;57623.42376576264;57858.132128018115;61241.08138377928;46327;55241.723791380784;56076.158857616356;56253.71873140608;56254;51307.23039154416;51424;51961.220581691305;51981.480185197666;52863.47136528663;8520.318374530147;8635.395522313378;8834.734957951272;8959.910400895908;8979.371443998858;37445;37456.81271593625;38490.23019539649;38532.614673852906;38672.80663596664;46113.76943115263;46182.76908615435;48336.5166348332;49327.50672493229;49936.75031624819;10970.506327215135;11093.16801239894;11339.716507087389;11363.261388009752;11490.253133546626;11560.132990025613;11796;11985.28088314704;12164.330961797186;12521.248725076524;11181.888181118411;11300.378479183724;11826.34955077479;11869;11900;11057.668269951915;11212.83180752273;11311.377874216669;11369;11503.309801411942;11498.712532186428;11705.824412633987;11795.941020294844;11835.82246266324;11941.64175074749;10058.798824023625;10298.897011030094;10380.844287335847;10405.167586593207;10656.786864262827;9817.410955342702;9922.305438619227;9971.102600765966;9981.301308908307;10148.543315550965 16:29:15 INFO - 2015-12-22 16:29:15,310 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:29:15 INFO - 2015-12-22 16:29:15,311 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:29:15 INFO - 2015-12-22 16:29:15,311 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,294 16:29:15 INFO - 2015-12-22 16:29:15,311 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:29:15 INFO - 2015-12-22 16:29:15,311 DEBUG : BROWSER_OUTPUT: __startTimestamp1450830555298__endTimestamp 16:29:15 INFO - 2015-12-22 16:29:15,311 DEBUG : BROWSER_OUTPUT: 16:29:15 INFO - 2015-12-22 16:29:15,311 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:29:15 INFO - 2015-12-22 16:29:15,311 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:29:15 INFO - 2015-12-22 16:29:15,311 DEBUG : BROWSER_OUTPUT: 16:29:15 INFO - 2015-12-22 16:29:15,311 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5715.03 Median:5963.43 stddev:644.85 (10.8%) stddev-sans-first:620.22 16:29:15 INFO - 2015-12-22 16:29:15,312 DEBUG : BROWSER_OUTPUT: Values: 3377.8 3419.4 3434.1 3452.7 3458.2 5688.9 5689.7 5699.7 5720.7 5722.1 5705.7 5731.9 5732.3 5734.8 5742.4 5199.0 5210.7 5254.6 5275.6 5298.0 5103.4 5142.7 5201.6 5214.4 5238.8 5152.4 5240.8 5254.3 5255.2 5256.3 5230.0 5252.2 5276.2 5280.4 5323.8 4973.0 5019.9 5025.3 5181.5 5191.5 5483.0 5486.8 5510.4 5528.5 5529.5 6137.3 6140.4 6151.4 6163.7 6174.7 5950.4 6118.8 6136.4 6140.6 6207.2 5625.1 5655.2 5763.7 5785.2 5803.2 6286.5 6308.3 6318.3 6323.8 6354.2 5859.4 6093.2 6094.0 6113.8 6116.4 6053.4 6087.4 6142.2 6192.3 6195.8 6104.4 6133.2 6159.4 6168.7 6196.4 5819.0 5885.4 6158.6 6168.1 6170.2 4621.7 4674.5 4674.9 4678.9 4709.6 4230.5 4231.8 4243.5 4258.0 4266.4 5739.0 5761.7 5827.0 5968.8 5975.7 6237.7 6252.2 6267.3 6269.5 6273.8 5936.0 5945.8 5960.9 5961.4 5963.4 5237.8 5322.9 5354.8 5364.0 5436.2 6283.7 6340.0 6342.2 6347.0 6365.8 6142.4 6193.7 6193.8 6198.3 6198.7 6129.5 6237.4 6265.0 6386.1 6412.8 6102.8 6158.2 6208.1 6208.3 6234.0 6035.2 6285.2 6286.8 6292.4 6298.6 5977.4 6014.5 6098.8 6124.9 6126.8 6018.1 6029.4 6041.9 6063.5 6068.8 5640.1 5814.7 5952.6 5967.6 5973.0 5912.1 5942.0 6019.6 6020.7 6026.5 5918.1 6006.3 6021.8 6024.5 6028.7 16:29:15 INFO - 2015-12-22 16:29:15,312 DEBUG : BROWSER_OUTPUT: 16:29:15 INFO - 2015-12-22 16:29:15,313 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:62050.31 Median:22791.15 stddev:144693.96 (634.9%) stddev-sans-first:145026.30 16:29:15 INFO - 2015-12-22 16:29:15,313 DEBUG : BROWSER_OUTPUT: Values: 595.2 635.8 635.9 645.8 653.3 32503.8 33858.0 38112.8 38670.4 39004.2 45514.3 46062.0 46267.3 46285.1 46342.5 9044.9 9077.8 9195.7 9215.4 9222.3 8946.0 9044.1 9056.5 9058.2 9074.0 9081.2 9087.0 9144.3 9159.6 9174.6 8767.8 8801.3 8936.7 8983.9 9051.5 8956.0 9100.2 9103.5 9115.8 9121.7 41450.0 41616.8 41952.2 41976.4 42159.0 3645.2 3669.1 3772.0 4080.2 4213.4 31379.5 31779.0 31788.9 31811.8 32415.5 4132.3 4235.8 4251.0 4264.7 4323.1 276766.0 277415.6 277563.0 278286.0 279323.0 44799.3 44989.0 45055.0 45153.8 45490.3 42347.0 42644.0 42803.4 42946.4 42968.6 15427.3 15605.7 15609.4 15665.8 15748.9 11448.3 11491.4 11543.7 11564.4 12020.6 15597.8 15612.2 15614.5 15620.1 15660.3 6161.2 6242.5 6264.0 6293.9 6408.3 1056.9 1077.5 1087.3 1103.6 1125.4 28837.3 29035.3 29044.3 29532.7 29681.7 1103.7 1104.7 1115.9 1117.8 1122.5 14358.8 17261.4 17613.2 17935.4 17937.2 814154.0 819944.0 824070.0 827294.0 827361.0 57248.4 57507.4 57630.4 57747.0 57857.0 1464.8 1488.7 1507.2 1515.6 1523.9 30031.8 30543.6 30572.7 31326.7 31342.5 47285.0 48162.5 48339.5 48405.0 48520.3 321269.0 321905.0 322484.0 322565.0 324571.0 33938.8 49272.8 49592.8 49867.8 50169.0 45612.5 46276.8 46334.5 46565.0 46578.8 39068.2 39673.8 39730.8 39919.8 40322.2 38715.6 38987.0 39572.0 39655.6 39942.6 43501.1 43586.0 43828.0 43965.6 44659.3 33315.5 33863.5 34418.0 34548.7 34596.3 26217.2 26894.2 26962.2 27539.6 28101.9 16:29:15 INFO - 2015-12-22 16:29:15,313 DEBUG : BROWSER_OUTPUT: 16:29:15 INFO - 2015-12-22 16:29:15,313 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29796.02 Median:11064.17 stddev:96001.18 (867.7%) stddev-sans-first:96245.10 16:29:15 INFO - 2015-12-22 16:29:15,313 DEBUG : BROWSER_OUTPUT: Values: 390.9 393.4 393.8 394.9 396.7 15772.2 16786.7 17682.7 19979.4 20114.3 11637.5 11992.6 12201.8 12226.4 12259.7 5124.1 5192.6 5265.3 5267.2 5280.5 5362.8 5485.8 5489.3 5499.1 5599.9 5460.2 5472.1 5505.4 5534.7 5722.1 5657.7 5660.4 5667.5 5670.8 5677.3 5478.5 5570.3 5571.4 5761.9 5768.0 12947.7 13133.9 13152.2 17731.4 21221.0 2272.6 2275.9 2282.7 2417.2 2451.7 10117.2 10382.1 10554.6 12052.2 13939.7 1891.6 1901.5 1923.3 1932.8 1967.0 64028.7 65765.3 65958.3 66746.3 67000.7 10780.1 11049.6 11067.8 11160.4 11176.8 14775.9 14866.1 14972.0 14999.6 15022.9 8230.2 8288.8 8382.5 8391.5 8408.5 7951.3 7974.5 7992.9 8025.9 8033.2 4361.9 4576.8 4718.3 4774.9 4781.2 1877.4 1989.2 2014.0 2019.5 2045.5 842.8 886.3 900.3 977.3 978.5 14463.0 17130.3 17668.6 18776.1 19331.6 1053.5 1066.3 1109.8 1110.3 1133.0 9986.4 10161.8 10193.6 10250.2 10302.9 451953.0 454210.0 461135.0 739241.0 744494.0 71931.3 73924.0 76620.0 81163.6 90130.5 1181.6 1187.4 1205.5 1206.0 1218.1 15248.1 15388.8 15457.1 15495.5 15682.3 20003.5 32666.7 33067.7 33867.3 33950.5 37287.4 40515.0 45080.3 47228.8 47993.0 9348.2 9551.6 9676.6 9689.7 9734.4 16951.4 17687.6 17932.8 18057.1 18115.4 14513.3 14721.6 14748.6 14823.3 15213.8 14488.2 14938.8 15118.8 15128.8 15167.8 15015.4 15358.0 15399.6 15630.8 15656.6 10105.3 10406.6 10481.7 10851.6 10854.4 15139.8 15595.5 15935.8 15968.2 16094.6 16:29:15 INFO - 2015-12-22 16:29:15,313 DEBUG : BROWSER_OUTPUT: 16:29:15 INFO - 2015-12-22 16:29:15,313 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5949.45 Median:5145.75 stddev:3103.92 (60.3%) stddev-sans-first:3094.47 16:29:15 INFO - 2015-12-22 16:29:15,313 DEBUG : BROWSER_OUTPUT: Values: 1483.8 1497.1 1677.5 1803.6 1821.6 8074.1 8285.5 8328.5 8372.6 8541.8 8580.6 8631.3 8669.1 8722.5 8725.7 2453.6 2478.1 2483.1 2488.4 2492.6 2449.7 2452.5 2491.1 2495.1 2496.0 2400.9 2418.0 2443.5 2457.7 2466.7 2426.6 2464.3 2464.5 2467.5 2473.5 2376.3 2477.4 2478.4 2483.2 2483.7 8480.9 8523.3 8534.5 8550.0 8571.7 5052.1 5139.4 5152.1 5161.4 5167.2 3290.0 3315.4 3339.8 3356.1 3394.8 1040.9 1058.7 1059.3 1060.2 1082.5 11792.8 11818.5 11835.6 11897.0 11933.4 4417.6 4442.8 4493.9 4527.3 4545.6 9506.9 9521.0 9567.2 9588.4 9595.3 5077.8 5079.0 5083.2 5109.7 5120.8 4627.9 4642.6 4679.3 4680.4 4692.8 3816.7 3826.5 3831.5 3856.5 3956.1 1129.3 1134.9 1142.3 1143.9 1147.8 1178.5 1186.1 1294.7 1420.5 1439.2 7710.7 7771.0 7998.0 8052.8 8056.2 1209.3 1210.2 1217.1 1226.6 1249.4 6266.6 6281.4 6287.0 6353.2 6363.2 10300.7 10354.8 10371.6 10373.4 10399.8 9897.4 10159.6 10211.0 10229.2 10264.8 7993.7 8082.5 8102.2 8106.5 8151.3 8021.0 8080.0 8104.0 8124.6 8144.6 8928.6 9099.8 9178.2 9201.8 9213.5 9362.3 9419.2 9494.4 9503.4 9644.1 7246.7 7325.6 7382.9 7408.3 7421.3 8108.0 8112.9 8137.6 8171.2 8176.6 6800.8 7737.3 7829.9 7862.1 7868.8 7462.1 7567.3 7592.3 7620.3 7697.6 7621.9 7650.2 7672.3 7696.7 7696.7 6907.7 6987.8 6989.1 7052.6 7070.3 7007.6 7062.0 7093.5 7101.0 7102.3 16:29:15 INFO - 2015-12-22 16:29:15,315 DEBUG : BROWSER_OUTPUT: 16:29:15 INFO - 2015-12-22 16:29:15,315 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5653.81 Median:6524.91 stddev:1706.50 (26.2%) stddev-sans-first:1664.53 16:29:15 INFO - 2015-12-22 16:29:15,316 DEBUG : BROWSER_OUTPUT: Values: 368.4 372.5 373.2 377.3 381.3 6315.4 6319.8 6399.0 6403.0 6516.1 6305.0 6330.0 6355.9 6360.7 6374.4 4857.1 4871.8 4873.8 4882.5 4889.6 4874.2 4876.0 4887.6 4895.4 4896.1 4629.8 4701.1 4756.5 4764.7 4790.3 4752.2 4781.5 4807.4 4810.2 4812.1 4199.1 4200.3 4202.9 4211.5 4214.6 5920.8 5938.4 5941.7 5942.0 5958.9 5533.2 5574.6 5622.7 5630.0 5643.9 6691.5 6695.3 6700.2 6708.0 6724.4 4658.7 4658.9 4664.2 4668.6 4671.8 6881.3 6939.4 6956.6 7009.6 7010.6 4763.7 4807.4 4809.0 4813.3 4813.4 4871.2 4871.4 4880.2 4882.1 4884.9 5622.7 5629.3 5630.3 5636.5 5638.0 6545.1 6698.7 6741.9 6755.3 6761.7 1703.7 1706.6 1715.6 1719.6 1723.7 1152.6 1154.2 1156.3 1168.8 1170.5 6553.6 6553.7 6564.1 6566.3 6571.9 6920.7 6926.8 6942.7 6961.5 6966.5 6427.9 6533.7 6552.1 6584.8 6600.2 3734.5 3813.1 3829.4 3836.2 3841.1 7121.0 7142.2 7143.5 7147.8 7150.9 7071.3 7206.2 7211.2 7254.3 7264.2 7214.4 7237.2 7242.0 7248.5 7251.3 6950.5 6969.8 6970.1 6990.5 7006.9 6796.7 6930.0 6947.1 6947.9 6968.0 7221.6 7225.8 7236.4 7239.5 7249.7 4763.5 4795.7 4800.3 4800.9 4803.0 6893.8 7052.6 7057.4 7059.6 7062.7 6846.4 6851.2 6852.1 6855.5 6861.4 6551.3 6739.2 6808.8 6812.8 6814.0 6637.9 6711.2 6716.4 6722.5 6728.3 6781.6 6840.9 6856.9 6867.2 6872.2 6573.3 6651.9 6676.7 6682.9 6684.0 16:29:15 INFO - 2015-12-22 16:29:15,316 DEBUG : BROWSER_OUTPUT: 16:29:15 INFO - 2015-12-22 16:29:15,316 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14561.75 Median:25516.89 stddev:17042.07 (66.8%) stddev-sans-first:17058.80 16:29:15 INFO - 2015-12-22 16:29:15,316 DEBUG : BROWSER_OUTPUT: Values: 856.2 934.8 938.2 944.1 958.1 13381.8 13798.5 13836.9 13845.8 13891.5 13307.7 13439.9 13450.5 13474.7 13536.5 876.1 883.9 887.5 891.0 892.6 865.7 890.3 891.1 893.3 897.6 907.4 921.7 929.6 929.8 929.9 890.1 909.3 911.2 912.8 921.7 686.1 689.1 693.3 694.7 695.6 13596.0 13630.7 13702.7 13728.5 13735.0 12343.9 12497.4 12657.3 13037.5 13729.9 10629.3 10846.8 10981.8 11151.3 11287.4 3802.8 3874.2 3882.9 3888.7 3902.1 51382.2 51628.0 53209.0 53477.0 53508.2 9972.6 10048.2 10138.0 10208.7 10227.3 19242.9 19270.1 19278.4 19311.7 19349.7 7473.1 7537.3 7556.4 7791.8 7824.5 4536.0 4607.5 4632.2 4706.8 4727.0 3411.0 3415.9 3461.3 3463.0 3475.0 644.4 664.6 670.1 671.7 673.2 633.8 678.1 689.4 722.7 726.5 8737.9 9167.2 9177.4 9292.9 9404.1 609.8 731.3 735.0 747.5 769.4 3912.4 4124.6 4185.3 4310.9 4427.4 56980.4 57090.7 57623.4 57858.1 61241.1 46327.0 55241.7 56076.2 56253.7 56254.0 51307.2 51424.0 51961.2 51981.5 52863.5 8520.3 8635.4 8834.7 8959.9 8979.4 37445.0 37456.8 38490.2 38532.6 38672.8 46113.8 46182.8 48336.5 49327.5 49936.8 10970.5 11093.2 11339.7 11363.3 11490.3 11560.1 11796.0 11985.3 12164.3 12521.2 11181.9 11300.4 11826.3 11869.0 11900.0 11057.7 11212.8 11311.4 11369.0 11503.3 11498.7 11705.8 11795.9 11835.8 11941.6 10058.8 10298.9 10380.8 10405.2 10656.8 9817.4 9922.3 9971.1 9981.3 10148.5 16:29:15 INFO - 2015-12-22 16:29:15,316 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:29:15 INFO - 2015-12-22 16:29:15,316 DEBUG : BROWSER_OUTPUT: 16:29:15 INFO - 2015-12-22 16:29:15,990 INFO : Browser exited with error code: 0 16:29:16 INFO - 2015-12-22 16:29:16,004 INFO : Completed test dromaeo_css (00:18:28) 16:29:16 INFO - 2015-12-22 16:29:16,004 INFO : Starting test kraken 16:29:16 INFO - 2015-12-22 16:29:16,004 DEBUG : operating with platform_type : linux_ 16:29:16 INFO - 2015-12-22 16:29:16,004 INFO : Initialising browser for kraken test... 16:29:16 INFO - 2015-12-22 16:29:16,010 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMmTnIz/profile http://localhost:45682/getInfo.html 16:29:19 INFO - 2015-12-22 16:29:19,989 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:29:19 INFO - 2015-12-22 16:29:19,990 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:29:19 INFO - 2015-12-22 16:29:19,990 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:29:19 INFO - 2015-12-22 16:29:19,990 DEBUG : BROWSER_OUTPUT: __metrics 16:29:20 INFO - 2015-12-22 16:29:20,902 INFO : Browser initialized. 16:29:20 INFO - 2015-12-22 16:29:20,902 INFO : Running cycle 1/1 for kraken test... 16:29:20 INFO - 2015-12-22 16:29:20,903 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMmTnIz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:29:32 INFO - 2015-12-22 16:29:32,674 DEBUG : BROWSER_OUTPUT: RSS: Main: 138522624 16:29:32 INFO - 2015-12-22 16:29:32,674 DEBUG : BROWSER_OUTPUT: 16:29:35 INFO - 2015-12-22 16:29:35,150 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45682/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45682/tests/kraken/driver.html?testName=audio-beat-detection) 16:29:35 INFO - 2015-12-22 16:29:35,752 DEBUG : BROWSER_OUTPUT: RSS: Main: 139108352 16:29:35 INFO - 2015-12-22 16:29:35,752 DEBUG : BROWSER_OUTPUT: 16:29:38 INFO - 2015-12-22 16:29:38,355 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45682/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45682/tests/kraken/driver.html?testName=audio-dft) 16:29:38 INFO - 2015-12-22 16:29:38,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 138891264 16:29:38 INFO - 2015-12-22 16:29:38,941 DEBUG : BROWSER_OUTPUT: 16:29:41 INFO - 2015-12-22 16:29:41,765 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45682/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45682/tests/kraken/driver.html?testName=audio-fft) 16:29:42 INFO - 2015-12-22 16:29:42,348 DEBUG : BROWSER_OUTPUT: RSS: Main: 138895360 16:29:42 INFO - 2015-12-22 16:29:42,348 DEBUG : BROWSER_OUTPUT: 16:29:44 INFO - 2015-12-22 16:29:44,342 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45682/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45682/tests/kraken/driver.html?testName=audio-oscillator) 16:29:44 INFO - 2015-12-22 16:29:44,923 DEBUG : BROWSER_OUTPUT: RSS: Main: 138924032 16:29:44 INFO - 2015-12-22 16:29:44,923 DEBUG : BROWSER_OUTPUT: 16:29:47 INFO - 2015-12-22 16:29:47,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45682/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45682/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:29:47 INFO - 2015-12-22 16:29:47,674 DEBUG : BROWSER_OUTPUT: RSS: Main: 138874880 16:29:47 INFO - 2015-12-22 16:29:47,674 DEBUG : BROWSER_OUTPUT: 16:29:50 INFO - 2015-12-22 16:29:50,625 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45682/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45682/tests/kraken/driver.html?testName=imaging-darkroom) 16:29:51 INFO - 2015-12-22 16:29:51,215 DEBUG : BROWSER_OUTPUT: RSS: Main: 140337152 16:29:51 INFO - 2015-12-22 16:29:51,215 DEBUG : BROWSER_OUTPUT: 16:29:54 INFO - 2015-12-22 16:29:54,617 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45682/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45682/tests/kraken/driver.html?testName=imaging-desaturate) 16:29:55 INFO - 2015-12-22 16:29:55,199 DEBUG : BROWSER_OUTPUT: RSS: Main: 139710464 16:29:55 INFO - 2015-12-22 16:29:55,199 DEBUG : BROWSER_OUTPUT: 16:29:57 INFO - 2015-12-22 16:29:57,957 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45682/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45682/tests/kraken/driver.html?testName=json-parse-financial) 16:29:58 INFO - 2015-12-22 16:29:58,544 DEBUG : BROWSER_OUTPUT: RSS: Main: 138309632 16:29:58 INFO - 2015-12-22 16:29:58,545 DEBUG : BROWSER_OUTPUT: 16:30:00 INFO - 2015-12-22 16:30:00,134 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45682/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45682/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:30:00 INFO - 2015-12-22 16:30:00,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 138260480 16:30:00 INFO - 2015-12-22 16:30:00,704 DEBUG : BROWSER_OUTPUT: 16:30:02 INFO - 2015-12-22 16:30:02,478 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45682/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45682/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:30:03 INFO - 2015-12-22 16:30:03,100 DEBUG : BROWSER_OUTPUT: RSS: Main: 138874880 16:30:03 INFO - 2015-12-22 16:30:03,101 DEBUG : BROWSER_OUTPUT: 16:30:05 INFO - 2015-12-22 16:30:05,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45682/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45682/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:30:05 INFO - 2015-12-22 16:30:05,674 DEBUG : BROWSER_OUTPUT: RSS: Main: 139661312 16:30:05 INFO - 2015-12-22 16:30:05,674 DEBUG : BROWSER_OUTPUT: 16:30:08 INFO - 2015-12-22 16:30:08,151 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45682/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45682/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:30:08 INFO - 2015-12-22 16:30:08,752 DEBUG : BROWSER_OUTPUT: RSS: Main: 140095488 16:30:08 INFO - 2015-12-22 16:30:08,752 DEBUG : BROWSER_OUTPUT: 16:30:11 INFO - 2015-12-22 16:30:11,252 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45682/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45682/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:30:11 INFO - 2015-12-22 16:30:11,834 DEBUG : BROWSER_OUTPUT: RSS: Main: 138940416 16:30:11 INFO - 2015-12-22 16:30:11,835 DEBUG : BROWSER_OUTPUT: 16:30:13 INFO - 2015-12-22 16:30:13,488 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45682/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45682/tests/kraken/driver.html?testName=ai-astar) 16:30:13 INFO - 2015-12-22 16:30:13,746 DEBUG : BROWSER_OUTPUT: RSS: Main: 140128256 16:30:13 INFO - 2015-12-22 16:30:13,746 DEBUG : BROWSER_OUTPUT: 16:30:13 INFO - 2015-12-22 16:30:13,747 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:30:13 INFO - 2015-12-22 16:30:13,747 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:30:13 INFO - 2015-12-22 16:30:13,747 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:30:13 INFO - 2015-12-22 16:30:13,747 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:30:13 INFO - 2015-12-22 16:30:13,747 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;106;110;109;111;122;111;113;108;110 16:30:13 INFO - 2015-12-22 16:30:13,747 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;144;126;157;164;131;147;155;125;169;123 16:30:13 INFO - 2015-12-22 16:30:13,747 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;161;161;162;161;166;163;164;161 16:30:13 INFO - 2015-12-22 16:30:13,747 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;72;72;155;71;72;73;75;151;74 16:30:13 INFO - 2015-12-22 16:30:13,748 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;134;92;93;92;134;93;92;132 16:30:13 INFO - 2015-12-22 16:30:13,748 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;111;109;110;110;110;110;110 16:30:13 INFO - 2015-12-22 16:30:13,748 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;145;146;147;146;145;146;147;146;147 16:30:13 INFO - 2015-12-22 16:30:13,748 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;96;97;96;97;95 16:30:13 INFO - 2015-12-22 16:30:13,748 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;61;61;62;63;62;62;61;63;59 16:30:13 INFO - 2015-12-22 16:30:13,748 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;63;64;65;64;65;64;65;65;64 16:30:13 INFO - 2015-12-22 16:30:13,748 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;80;81;82;82;81;81;82;80;81 16:30:13 INFO - 2015-12-22 16:30:13,749 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;112;122;127;128;120;125;126;129;117;135 16:30:13 INFO - 2015-12-22 16:30:13,749 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;149;144;145;143;146;135;148;135;145;144 16:30:13 INFO - 2015-12-22 16:30:13,749 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;64;74;64;64;64;69;65;65;66 16:30:13 INFO - 2015-12-22 16:30:13,749 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:30:13 INFO - 2015-12-22 16:30:13,749 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:30:13 INFO - 2015-12-22 16:30:13,749 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,701 16:30:13 INFO - 2015-12-22 16:30:13,750 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:30:13 INFO - 2015-12-22 16:30:13,750 DEBUG : BROWSER_OUTPUT: __startTimestamp1450830613741__endTimestamp 16:30:13 INFO - 2015-12-22 16:30:13,750 DEBUG : BROWSER_OUTPUT: 16:30:13 INFO - 2015-12-22 16:30:13,750 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:30:13 INFO - 2015-12-22 16:30:13,750 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:30:13 INFO - 2015-12-22 16:30:13,750 DEBUG : BROWSER_OUTPUT: 16:30:13 INFO - 2015-12-22 16:30:13,750 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:4.32 (3.9%) stddev-sans-first:4.54 16:30:13 INFO - 2015-12-22 16:30:13,750 DEBUG : BROWSER_OUTPUT: Values: 113.0 106.0 110.0 109.0 111.0 122.0 111.0 113.0 108.0 110.0 16:30:13 INFO - 2015-12-22 16:30:13,750 DEBUG : BROWSER_OUTPUT: 16:30:13 INFO - 2015-12-22 16:30:13,750 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.10 Median:151.00 stddev:17.06 (11.3%) stddev-sans-first:18.09 16:30:13 INFO - 2015-12-22 16:30:13,750 DEBUG : BROWSER_OUTPUT: Values: 144.0 126.0 157.0 164.0 131.0 147.0 155.0 125.0 169.0 123.0 16:30:13 INFO - 2015-12-22 16:30:13,751 DEBUG : BROWSER_OUTPUT: 16:30:13 INFO - 2015-12-22 16:30:13,752 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.00 Median:161.50 stddev:1.83 (1.1%) stddev-sans-first:1.79 16:30:13 INFO - 2015-12-22 16:30:13,752 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 161.0 161.0 162.0 161.0 166.0 163.0 164.0 161.0 16:30:13 INFO - 2015-12-22 16:30:13,752 DEBUG : BROWSER_OUTPUT: 16:30:13 INFO - 2015-12-22 16:30:13,752 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.30 Median:72.50 stddev:33.65 (46.4%) stddev-sans-first:35.44 16:30:13 INFO - 2015-12-22 16:30:13,752 DEBUG : BROWSER_OUTPUT: Values: 78.0 72.0 72.0 155.0 71.0 72.0 73.0 75.0 151.0 74.0 16:30:13 INFO - 2015-12-22 16:30:13,752 DEBUG : BROWSER_OUTPUT: 16:30:13 INFO - 2015-12-22 16:30:13,752 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.70 Median:92.00 stddev:19.77 (21.5%) stddev-sans-first:20.43 16:30:13 INFO - 2015-12-22 16:30:13,753 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 134.0 92.0 93.0 92.0 134.0 93.0 92.0 132.0 16:30:13 INFO - 2015-12-22 16:30:13,753 DEBUG : BROWSER_OUTPUT: 16:30:13 INFO - 2015-12-22 16:30:13,753 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 16:30:13 INFO - 2015-12-22 16:30:13,753 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 111.0 109.0 110.0 110.0 110.0 110.0 110.0 16:30:13 INFO - 2015-12-22 16:30:13,753 DEBUG : BROWSER_OUTPUT: 16:30:13 INFO - 2015-12-22 16:30:13,753 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.95 (0.6%) stddev-sans-first:0.78 16:30:13 INFO - 2015-12-22 16:30:13,753 DEBUG : BROWSER_OUTPUT: Values: 148.0 145.0 146.0 147.0 146.0 145.0 146.0 147.0 146.0 147.0 16:30:13 INFO - 2015-12-22 16:30:13,753 DEBUG : BROWSER_OUTPUT: 16:30:13 INFO - 2015-12-22 16:30:13,753 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 16:30:13 INFO - 2015-12-22 16:30:13,753 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 97.0 95.0 16:30:13 INFO - 2015-12-22 16:30:13,753 DEBUG : BROWSER_OUTPUT: 16:30:13 INFO - 2015-12-22 16:30:13,753 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.50 Median:62.00 stddev:1.18 (1.9%) stddev-sans-first:1.24 16:30:13 INFO - 2015-12-22 16:30:13,753 DEBUG : BROWSER_OUTPUT: Values: 61.0 61.0 61.0 62.0 63.0 62.0 62.0 61.0 63.0 59.0 16:30:13 INFO - 2015-12-22 16:30:13,753 DEBUG : BROWSER_OUTPUT: 16:30:13 INFO - 2015-12-22 16:30:13,754 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.50 stddev:0.79 (1.2%) stddev-sans-first:0.71 16:30:13 INFO - 2015-12-22 16:30:13,754 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 64.0 65.0 64.0 65.0 64.0 65.0 65.0 64.0 16:30:13 INFO - 2015-12-22 16:30:13,754 DEBUG : BROWSER_OUTPUT: 16:30:13 INFO - 2015-12-22 16:30:13,754 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:81.00 stddev:0.74 (0.9%) stddev-sans-first:0.78 16:30:13 INFO - 2015-12-22 16:30:13,754 DEBUG : BROWSER_OUTPUT: Values: 81.0 80.0 81.0 82.0 82.0 81.0 81.0 82.0 80.0 81.0 16:30:13 INFO - 2015-12-22 16:30:13,754 DEBUG : BROWSER_OUTPUT: 16:30:13 INFO - 2015-12-22 16:30:13,754 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:126.50 stddev:6.57 (5.2%) stddev-sans-first:5.32 16:30:13 INFO - 2015-12-22 16:30:13,754 DEBUG : BROWSER_OUTPUT: Values: 112.0 122.0 127.0 128.0 120.0 125.0 126.0 129.0 117.0 135.0 16:30:13 INFO - 2015-12-22 16:30:13,754 DEBUG : BROWSER_OUTPUT: 16:30:13 INFO - 2015-12-22 16:30:13,754 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.40 Median:145.00 stddev:4.79 (3.3%) stddev-sans-first:4.63 16:30:13 INFO - 2015-12-22 16:30:13,754 DEBUG : BROWSER_OUTPUT: Values: 149.0 144.0 145.0 143.0 146.0 135.0 148.0 135.0 145.0 144.0 16:30:13 INFO - 2015-12-22 16:30:13,754 DEBUG : BROWSER_OUTPUT: 16:30:13 INFO - 2015-12-22 16:30:13,754 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:65.50 stddev:3.18 (4.9%) stddev-sans-first:3.37 16:30:13 INFO - 2015-12-22 16:30:13,754 DEBUG : BROWSER_OUTPUT: Values: 66.0 64.0 74.0 64.0 64.0 64.0 69.0 65.0 65.0 66.0 16:30:13 INFO - 2015-12-22 16:30:13,754 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:30:13 INFO - 2015-12-22 16:30:13,755 DEBUG : BROWSER_OUTPUT: 16:30:14 INFO - 2015-12-22 16:30:14,566 INFO : Browser exited with error code: 0 16:30:14 INFO - 2015-12-22 16:30:14,619 INFO : Completed test kraken (00:00:58) 16:30:14 INFO - 2015-12-22 16:30:14,619 INFO : Starting test v8_7 16:30:14 INFO - 2015-12-22 16:30:14,619 DEBUG : operating with platform_type : linux_ 16:30:14 INFO - 2015-12-22 16:30:14,619 INFO : Initialising browser for v8_7 test... 16:30:14 INFO - 2015-12-22 16:30:14,625 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpa2zIDY/profile http://localhost:45682/getInfo.html 16:30:18 INFO - 2015-12-22 16:30:18,511 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:30:18 INFO - 2015-12-22 16:30:18,511 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:30:18 INFO - 2015-12-22 16:30:18,511 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:30:18 INFO - 2015-12-22 16:30:18,511 DEBUG : BROWSER_OUTPUT: __metrics 16:30:19 INFO - 2015-12-22 16:30:19,462 INFO : Browser initialized. 16:30:19 INFO - 2015-12-22 16:30:19,462 INFO : Running cycle 1/1 for v8_7 test... 16:30:19 INFO - 2015-12-22 16:30:19,463 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpa2zIDY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:30:31 INFO - 2015-12-22 16:30:31,251 DEBUG : BROWSER_OUTPUT: RSS: Main: 138481664 16:30:31 INFO - 2015-12-22 16:30:31,251 DEBUG : BROWSER_OUTPUT: 16:30:52 INFO - 2015-12-22 16:30:52,586 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45682/tests/v8_7/run.html (next: http://localhost:45682/tests/v8_7/run.html) 16:30:52 INFO - 2015-12-22 16:30:52,832 DEBUG : BROWSER_OUTPUT: RSS: Main: 136937472 16:30:52 INFO - 2015-12-22 16:30:52,833 DEBUG : BROWSER_OUTPUT: 16:30:52 INFO - 2015-12-22 16:30:52,833 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:30:52 INFO - 2015-12-22 16:30:52,833 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:30:52 INFO - 2015-12-22 16:30:52,833 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:30:52 INFO - 2015-12-22 16:30:52,833 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:30:52 INFO - 2015-12-22 16:30:52,833 DEBUG : BROWSER_OUTPUT: |0;Richards;164.14970453053184 16:30:52 INFO - 2015-12-22 16:30:52,834 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;173.4304543877905 16:30:52 INFO - 2015-12-22 16:30:52,834 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.2415136338342 16:30:52 INFO - 2015-12-22 16:30:52,834 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5191.709844559586 16:30:52 INFO - 2015-12-22 16:30:52,834 DEBUG : BROWSER_OUTPUT: |4;RayTrace;921.6589861751152 16:30:52 INFO - 2015-12-22 16:30:52,834 DEBUG : BROWSER_OUTPUT: |5;Earley;550.357732526142 16:30:52 INFO - 2015-12-22 16:30:52,834 DEBUG : BROWSER_OUTPUT: |6;Boyer;10913.04347826087 16:30:52 INFO - 2015-12-22 16:30:52,834 DEBUG : BROWSER_OUTPUT: |7;RegExp;24707.317073170732 16:30:52 INFO - 2015-12-22 16:30:52,835 DEBUG : BROWSER_OUTPUT: |8;Splay;504.79555779909134 16:30:52 INFO - 2015-12-22 16:30:52,835 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 16:30:52 INFO - 2015-12-22 16:30:52,835 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:30:52 INFO - 2015-12-22 16:30:52,835 DEBUG : BROWSER_OUTPUT: __startTimestamp1450830652832__endTimestamp 16:30:52 INFO - 2015-12-22 16:30:52,835 DEBUG : BROWSER_OUTPUT: 16:30:52 INFO - 2015-12-22 16:30:52,836 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:30:52 INFO - 2015-12-22 16:30:52,836 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:30:52 INFO - 2015-12-22 16:30:52,836 DEBUG : BROWSER_OUTPUT: 16:30:52 INFO - 2015-12-22 16:30:52,836 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.15 Median:164.15 stddev:0.00 (0.0%) 16:30:52 INFO - 2015-12-22 16:30:52,837 DEBUG : BROWSER_OUTPUT: Values: 164.1 16:30:52 INFO - 2015-12-22 16:30:52,837 DEBUG : BROWSER_OUTPUT: 16:30:52 INFO - 2015-12-22 16:30:52,837 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:173.43 Median:173.43 stddev:0.00 (0.0%) 16:30:52 INFO - 2015-12-22 16:30:52,837 DEBUG : BROWSER_OUTPUT: Values: 173.4 16:30:52 INFO - 2015-12-22 16:30:52,837 DEBUG : BROWSER_OUTPUT: 16:30:52 INFO - 2015-12-22 16:30:52,838 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.24 Median:278.24 stddev:0.00 (0.0%) 16:30:52 INFO - 2015-12-22 16:30:52,838 DEBUG : BROWSER_OUTPUT: Values: 278.2 16:30:52 INFO - 2015-12-22 16:30:52,838 DEBUG : BROWSER_OUTPUT: 16:30:52 INFO - 2015-12-22 16:30:52,838 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 16:30:52 INFO - 2015-12-22 16:30:52,838 DEBUG : BROWSER_OUTPUT: Values: 5191.7 16:30:52 INFO - 2015-12-22 16:30:52,838 DEBUG : BROWSER_OUTPUT: 16:30:52 INFO - 2015-12-22 16:30:52,839 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:921.66 Median:921.66 stddev:0.00 (0.0%) 16:30:52 INFO - 2015-12-22 16:30:52,839 DEBUG : BROWSER_OUTPUT: Values: 921.7 16:30:52 INFO - 2015-12-22 16:30:52,839 DEBUG : BROWSER_OUTPUT: 16:30:52 INFO - 2015-12-22 16:30:52,840 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:550.36 Median:550.36 stddev:0.00 (0.0%) 16:30:52 INFO - 2015-12-22 16:30:52,840 DEBUG : BROWSER_OUTPUT: Values: 550.4 16:30:52 INFO - 2015-12-22 16:30:52,841 DEBUG : BROWSER_OUTPUT: 16:30:52 INFO - 2015-12-22 16:30:52,841 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10913.04 Median:10913.04 stddev:0.00 (0.0%) 16:30:52 INFO - 2015-12-22 16:30:52,841 DEBUG : BROWSER_OUTPUT: Values: 10913.0 16:30:52 INFO - 2015-12-22 16:30:52,841 DEBUG : BROWSER_OUTPUT: 16:30:52 INFO - 2015-12-22 16:30:52,841 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24707.32 Median:24707.32 stddev:0.00 (0.0%) 16:30:52 INFO - 2015-12-22 16:30:52,841 DEBUG : BROWSER_OUTPUT: Values: 24707.3 16:30:52 INFO - 2015-12-22 16:30:52,841 DEBUG : BROWSER_OUTPUT: 16:30:52 INFO - 2015-12-22 16:30:52,841 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:504.80 Median:504.80 stddev:0.00 (0.0%) 16:30:52 INFO - 2015-12-22 16:30:52,842 DEBUG : BROWSER_OUTPUT: Values: 504.8 16:30:52 INFO - 2015-12-22 16:30:52,842 DEBUG : BROWSER_OUTPUT: 16:30:52 INFO - 2015-12-22 16:30:52,842 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 16:30:52 INFO - 2015-12-22 16:30:52,842 DEBUG : BROWSER_OUTPUT: Values: 4830.9 16:30:52 INFO - 2015-12-22 16:30:52,842 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:30:52 INFO - 2015-12-22 16:30:52,842 DEBUG : BROWSER_OUTPUT: 16:30:53 INFO - 2015-12-22 16:30:53,650 INFO : Browser exited with error code: 0 16:30:53 INFO - 2015-12-22 16:30:53,664 INFO : Completed test v8_7 (00:00:39) 16:30:53 INFO - 2015-12-22 16:30:53,897 INFO : Completed test suite (00:20:06) 16:30:53 INFO - 2015-12-22 16:30:53,897 DEBUG : Working with test: dromaeo_css 16:30:53 INFO - 2015-12-22 16:30:53,897 DEBUG : Generating results file: dromaeo_css 16:30:53 INFO - 2015-12-22 16:30:53,898 DEBUG : Working with test: kraken 16:30:53 INFO - 2015-12-22 16:30:53,898 DEBUG : Generating results file: kraken 16:30:53 INFO - 2015-12-22 16:30:53,899 INFO : javascript benchmark 16:30:53 INFO - 2015-12-22 16:30:53,899 DEBUG : Working with test: v8_7 16:30:53 INFO - 2015-12-22 16:30:53,899 DEBUG : Generating results file: v8_7 16:30:53 INFO - 2015-12-22 16:30:53,899 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:30:53 INFO - 2015-12-22 16:30:53,957 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 16:30:53 INFO - 2015-12-22 16:30:53,957 DEBUG : process_Request line: dromaeo_css 7445.77 graph.html#tests=[[72,52,43]] 16:30:53 INFO - 2015-12-22 16:30:53,957 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:30:54 INFO - 2015-12-22 16:30:54,090 DEBUG : process_Request line: kraken 1504.20 graph.html#tests=[[232,52,43]] 16:30:54 INFO - 2015-12-22 16:30:54,090 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:30:54 INFO - 2015-12-22 16:30:54,125 DEBUG : process_Request line: v8_7 23211.70 graph.html#tests=[[230,52,43]] 16:30:54 INFO - 2015-12-22 16:30:54,126 INFO : javascript benchmark 16:30:54 INFO - 2015-12-22 16:30:54,130 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3377.763556551041, 3419.401604719175, 3434.0899661589697, 3452.741044421669, 3458.2046129390246, 5688.886222275557, 5689.743961521731, 5699.74351154198, 5720.713964301784, 5722.113072473763, 5705.686187259699, 5731.885362292752, 5732.340780810208, 5734.770609175628, 5742.368339482654, 5199.038177937075, 5210.713410762407, 5254.553362964152, 5275.6043296752705, 5298.0, 5103.362079740033, 5142.717150556718, 5201.55786758126, 5214.374275086995, 5238.79044838206, 5152.355955505562, 5240.842774716764, 5254.343207099113, 5255.211718242275, 5256.26412302278, 5230.0, 5252.185911183773, 5276.234945932857, 5280.3663560373, 5323.840284791462, 4973.0, 5019.949800502021, 5025.321581586476, 5181.5077567631015, 5191.532762051395, 5482.972585137089, 5486.780528778844, 5510.421405752379, 5528.530074943635, 5529.529989950859, 6137.263528376623, 6140.4473597376, 6151.415615516519, 6163.691815409256, 6174.660393678346, 5950.434708702666, 6118.847028824271, 6136.386361363828, 6140.631562106243, 6207.162033125515, 5625.09998400254, 5655.208270842086, 5763.682997435181, 5785.2189954356045, 5803.187553742438, 6286.49708023357, 6308.337624549356, 6318.336574659595, 6323.778667746698, 6354.205724284465, 5859.355470898197, 6093.23101592027, 6093.99449090895, 6113.816585502442, 6116.35778243278, 6053.394660534, 6087.391260873877, 6142.201513803177, 6192.318844927055, 6195.783147589813, 6104.3590423005835, 6133.172021777093, 6159.414855588712, 6168.722407491674, 6196.411340922605, 5819.0, 5885.440883116097, 6158.599691020069, 6168.1056246844855, 6170.197874276405, 4621.676482646182, 4674.532546745366, 4674.906501869944, 4678.906421871544, 4709.576138147583, 4230.534641189467, 4231.830726770956, 4243.533211346749, 4258.020655249248, 4266.445362102907, 5739.0, 5761.711914404263, 5827.0, 5968.820935371946, 5975.701214939322, 6237.688115594202, 6252.218472690914, 6267.310595834455, 6269.498440124779, 6273.811785646438, 5935.970320148458, 5945.7621695132575, 5960.85097872548, 5961.433663801932, 5963.4334738199805, 5237.8428647140645, 5322.946770532322, 5354.759035843396, 5364.0, 5436.238926550286, 6283.654399008007, 6340.0, 6342.207224096988, 6346.9682651586445, 6365.777197798055, 6142.385761423822, 6193.721282542297, 6193.81418557444, 6198.318184999556, 6198.721057552511, 6129.478994285536, 6237.407446292595, 6265.0, 6386.074019267273, 6412.839679008062, 6102.755889764359, 6158.168647232566, 6208.068789681584, 6208.317085120723, 6234.0337247726675, 6035.215421995288, 6285.182926219562, 6286.811395658137, 6292.433680968735, 6298.590591611531, 5977.402259774161, 6014.518838492998, 6098.75604975796, 6124.8775024500155, 6126.816195514141, 6018.097285407049, 6029.3669164737075, 6041.939580604314, 6063.454289114001, 6068.848278793065, 5640.125780504029, 5814.651120932588, 5952.553558483044, 5967.582269241285, 5972.9701351494705, 5912.142739302863, 5942.049272116441, 6019.608725432833, 6020.698965051817, 6026.517878569792, 5918.112283157561, 6006.339302676614, 6021.7591296347655, 6024.548158888013, 6028.668423236764], "unit": "ms", "name": "dojo.html", "value": 5672.650170749565}, {"lowerIsBetter": false, "replicates": [595.2351228671156, 635.8124353315774, 635.9300476947537, 645.8320836582488, 653.2716021635878, 32503.837480812592, 33858.0, 38112.80943595285, 38670.419943700865, 39004.21991560167, 45514.31728524075, 46062.0, 46267.30599041009, 46285.1485940562, 46342.53657463424, 9044.90955090449, 9077.773055673595, 9195.678151264707, 9215.400998935082, 9222.262219022496, 8945.955270223672, 9044.05037471066, 9056.456612603264, 9058.184763371295, 9073.954630226839, 9081.182693557612, 9086.954565227164, 9144.268458523335, 9159.633614655406, 9174.587143578556, 8767.824643507127, 8801.251893589053, 8936.731898043005, 8983.910160898373, 9051.456912585232, 8956.0, 9100.180983711498, 9103.453792772454, 9115.772105697411, 9121.726348209499, 41450.0, 41616.79191604022, 41952.160956781, 41976.370354444705, 42159.0, 3645.2162785001087, 3669.1377526281303, 3772.0, 4080.204360149772, 4213.367994800805, 31379.48157711784, 31779.04662860118, 31788.887388941275, 31811.84094079538, 32415.51376729351, 4132.297509423405, 4235.809388577491, 4250.958515163774, 4264.6801489888385, 4323.135372925428, 276766.0, 277415.6129219361, 277563.0, 278286.0, 279323.0, 44799.32801007987, 44989.0, 45055.0, 45153.77423112929, 45490.31764523535, 42347.0, 42644.0, 42803.35794963016, 42946.355804662955, 42968.57031429708, 15427.30577124032, 15605.68788624221, 15609.375624974873, 15665.843341566666, 15748.92125539388, 11448.313101213787, 11491.42542872853, 11543.653690389301, 11564.363959982282, 12020.63938081859, 15597.83016273784, 15612.219389030502, 15614.531564053097, 15620.140892251035, 15660.295286712126, 6161.199044124325, 6242.469390101802, 6263.964211631147, 6293.874122517524, 6408.263049749338, 1056.9154467642725, 1077.5151181968147, 1087.271528076175, 1103.5751235774123, 1125.386664267976, 28837.27906802347, 29035.274118147216, 29044.273893152418, 29532.704672953427, 29681.703182967893, 1103.7020004598714, 1104.6741211342674, 1115.8716747573972, 1117.7820325036703, 1122.4668282565715, 14358.784618230735, 17261.39585114515, 17613.207405666777, 17935.372261971028, 17937.192826322847, 814154.0, 819944.0, 824070.0, 827294.0, 827361.0, 57248.42751572514, 57507.42492575021, 57630.4236957625, 57747.0, 57857.0, 1464.7583148780545, 1488.672492051747, 1507.1936513964977, 1515.613518552762, 1523.9238038098051, 30031.849840750656, 30543.628048171206, 30572.694273056986, 31326.686733132377, 31342.529862052543, 47285.0, 48162.518374817206, 48339.5166048335, 48405.0, 48520.27219591638, 321269.0, 321905.0, 322484.0, 322565.0, 324571.0, 33938.793978391324, 49272.75363623159, 49592.75203623959, 49867.750661246464, 50169.0, 45612.543874560826, 46276.7686161567, 46334.53665463302, 46565.0, 46578.76710616561, 39068.218635627694, 39673.801630991664, 39730.80134599309, 39919.80040099781, 40322.1935561293, 38715.612843871204, 38987.0, 39572.0, 39655.60344396519, 39942.600573993885, 43501.12997740091, 43586.0, 43828.0, 43965.560344396145, 44659.330110047726, 33315.50026749649, 33863.492047619795, 34418.0, 34548.654513454545, 34596.30807383889, 26217.213483595522, 26894.193174204804, 26962.191134266002, 27539.586906196822, 28101.859490703235], "unit": "ms", "name": "ext.html", "value": 19676.35882134497}, {"lowerIsBetter": false, "replicates": [390.9413587961805, 393.35097089801826, 393.842463014794, 394.899300678327, 396.7203121799132, 15772.21138943054, 16786.66426671466, 17682.734758978608, 19979.400617981464, 20114.295999640017, 11637.534498620067, 11992.580259690912, 12201.816972745415, 12226.44980975856, 12259.693507662312, 5124.128898087334, 5192.584593232532, 5265.289185959904, 5267.157254839227, 5280.471952804708, 5362.758675859595, 5485.835424937259, 5489.34127904652, 5499.120140777476, 5599.888002239953, 5460.235567020621, 5472.124460086367, 5505.449455054482, 5534.667919924797, 5722.141678748179, 5657.745401456924, 5660.433956604327, 5667.546596272288, 5670.7731690732735, 5677.290338707661, 5478.506934375885, 5570.275864137677, 5571.387147413781, 5761.942380576183, 5768.048272035109, 12947.741045179044, 13133.934330328288, 13152.210867347894, 17731.37940172088, 21221.0, 2272.556851413975, 2275.943101422461, 2282.7146606674164, 2417.16607770319, 2451.705795304557, 10117.241206909512, 10382.117520010808, 10554.577816887315, 12052.216605920587, 13939.705875004356, 1891.6216756648726, 1901.5151136460252, 1923.307609260665, 1932.8357089647398, 1967.0, 64028.67985660042, 65765.3423465764, 65958.3404165957, 66746.3325366745, 67000.6649966747, 10780.137588992862, 11049.558017679363, 11067.833982490269, 11160.386178760084, 11176.776464470666, 14775.92612036933, 14866.108033518023, 14972.0, 14999.625009374853, 15022.924885375503, 8230.176982301722, 8288.792780180544, 8382.538960357238, 8391.496510209285, 8408.453450525696, 7951.324137448266, 7974.5215287082965, 7992.880106798402, 8025.919740802634, 8033.19668033192, 4361.890952726144, 4576.794044268016, 4718.292256161603, 4774.856754297377, 4781.163296423112, 1877.418000419847, 1989.1844343818964, 2014.0433294185439, 2019.5052212207809, 2045.5397535554382, 842.7640260727006, 886.2998231397253, 900.2887718702283, 977.2914636888199, 978.5303054533864, 14463.0, 17130.314787408613, 17668.646627067643, 18776.0611969401, 19331.613367732567, 1053.536443964653, 1066.3228849680509, 1109.8002359575194, 1110.3448965110624, 1132.9603463878725, 9986.400815950921, 10161.796764064826, 10193.592256309812, 10250.231232657581, 10302.948485257526, 451953.0, 454210.0, 461135.0, 739241.0, 744494.0, 71931.2806871935, 73924.0, 76620.0, 81163.59418202871, 90130.54934725285, 1181.5923506390109, 1187.3884949251142, 1205.487667741224, 1206.029146537046, 1218.147296892179, 15248.085114893142, 15388.84611153919, 15457.149856757986, 15495.535133946, 15682.294296756902, 20003.499912502302, 32666.693332267394, 33067.66932330742, 33867.322653547286, 33950.49074263839, 37287.44068838915, 40515.0, 45080.323795143755, 47228.7638561805, 47993.0, 9348.158665720119, 9551.570179342085, 9676.612935482503, 9689.70930872075, 9734.36726612768, 16951.406700765416, 17687.55781105431, 17932.820671793113, 18057.097145142954, 18115.365962191787, 14513.274336282933, 14721.631959201106, 14748.63128421798, 14823.332950017491, 15213.771793422886, 14488.203148826915, 14938.775918361016, 15118.773218401953, 15128.773068404204, 15167.772483412979, 15015.399384024517, 15358.0, 15399.61500962485, 15630.843691562939, 15656.608584785472, 10105.292629515863, 10406.58373665045, 10481.737956551147, 10851.620193293196, 10854.403007834644, 15139.772903406678, 15595.454159104831, 15935.760963585324, 15968.201589920689, 16094.597635059217], "unit": "ms", "name": "jquery.html", "value": 9175.873207156623}, {"lowerIsBetter": false, "replicates": [1483.8071050763403, 1497.1092200140915, 1677.471596447119, 1803.6032072943947, 1821.6265665538565, 8074.071481779597, 8285.54429506377, 8328.54193019383, 8372.581370931452, 8541.829163416727, 8580.613872375758, 8631.30949524038, 8669.133086691329, 8722.520261385622, 8725.694600688978, 2453.619688948211, 2478.0954951442773, 2483.1433155561394, 2488.4027833319965, 2492.5762620354494, 2449.6570480132796, 2452.509498100378, 2491.0907518755616, 2495.051880285489, 2495.9750402496015, 2400.9159679411223, 2417.9758202417925, 2443.535728211643, 2457.741937096606, 2466.679331686887, 2426.6238732996326, 2464.297675162588, 2464.4824586836785, 2467.506498700267, 2473.480569080495, 2376.346504711201, 2477.380654836291, 2478.368016155887, 2483.205374280231, 2483.689538807649, 8480.915190848136, 8523.318134549221, 8534.487930724114, 8550.01674807399, 8571.699990500303, 5052.0906236877345, 5139.408967968694, 5152.098382782998, 5161.354830646169, 5167.199084141964, 3289.9506507402407, 3315.419801534722, 3339.8497067632015, 3356.093854659253, 3394.7793393429347, 1040.921930855189, 1058.6929790360787, 1059.3273271472594, 1060.2101434431397, 1082.5020490574345, 11792.764144717143, 11818.468168932419, 11835.585754498552, 11897.0, 11933.403329833474, 4417.580329868657, 4442.755648439303, 4493.865184044484, 4527.275635898241, 4545.568171023813, 9506.90493095074, 9520.952395237979, 9567.234621230285, 9588.37675551087, 9595.28035397348, 5077.7715002824225, 5079.0, 5083.186690129562, 5109.718965456861, 5120.769565369567, 4627.8611641650805, 4642.582167604932, 4679.298105284234, 4680.438347398334, 4692.788824502905, 3816.656500914931, 3826.521684789401, 3831.4635950966886, 3856.4986551748093, 3956.050547868491, 1129.2772625519674, 1134.9319040857574, 1142.3374442823308, 1143.857017872766, 1147.7991351513451, 1178.5109179690332, 1186.0689358853258, 1294.7086905446388, 1420.5028240115876, 1439.16528413522, 7710.730124445618, 7770.961145194351, 7997.960010199912, 8052.838943221102, 8056.194380562014, 1209.3167360441323, 1210.1589395370308, 1217.0811037666506, 1226.5952235762177, 1249.4127759952808, 6266.624002559861, 6281.371862813682, 6286.968565157145, 6353.205849268841, 6363.204599425072, 10300.690979270634, 10354.844677329846, 10371.58513659445, 10373.377597344184, 10399.84400233997, 9897.40615563054, 10159.644412445528, 10211.0, 10229.232807539463, 10264.794704105876, 7993.68025278994, 8082.515049097073, 8102.230288122619, 8106.47307924983, 8151.30713889326, 8020.959895200486, 8080.0, 8104.0, 8124.55314957683, 8144.592770361577, 8928.553572321229, 9099.818003640023, 9178.173964343241, 9201.815963680823, 9213.493257870614, 9362.297827662816, 9419.246460283299, 9494.430334179971, 9503.429794212369, 9644.132028117503, 7246.7101315946775, 7325.560466372035, 7382.926170738224, 7408.333250007525, 7421.332080112816, 8108.0, 8112.878306825521, 8137.552434615916, 8171.182881711781, 8176.591170441573, 6800.761973330909, 7737.3036426721865, 7829.921700782919, 7862.095858976291, 7868.84262314762, 7462.10454745434, 7567.31894129531, 7592.278733520307, 7620.314171724572, 7697.576633285223, 7621.885671714817, 7650.196729343562, 7672.271134242238, 7696.653650585625, 7696.7306144284685, 6907.654617269217, 6987.825304367431, 6989.126359205099, 7052.647367631701, 7070.257622949722, 7007.579545227302, 7062.0, 7093.467989900675, 7101.0, 7102.254263302486], "unit": "ms", "name": "mootools.html", "value": 4868.391206303935}, {"lowerIsBetter": false, "replicates": [368.3847973883615, 372.50642898159947, 373.2218324792807, 377.322705743191, 381.3250546532639, 6315.431611154995, 6319.77880774173, 6398.9680051599735, 6403.039544068386, 6516.0877477153235, 6305.0, 6330.0, 6355.872882542347, 6360.745570177199, 6374.426301632852, 4857.077155340492, 4871.805127794884, 4873.805047798101, 4882.462929077798, 4889.633277504184, 4874.220124780036, 4876.049170411771, 4887.584555312803, 4895.437024742165, 4896.1186986342445, 4629.8148074077, 4701.059788042388, 4756.548127927841, 4764.690295130806, 4790.257510085942, 4752.215884379073, 4781.497942716, 4807.351007613962, 4810.158222311082, 4812.061647978646, 4199.118185181115, 4200.327947528412, 4202.873913782591, 4211.515675697304, 4214.578542145791, 5920.763169473259, 5938.406159384071, 5941.732622032019, 5941.970290148522, 5958.910616340759, 5533.22534845122, 5574.60977731559, 5622.746976386073, 5629.971850140723, 5643.887122257573, 6691.5315927884585, 6695.263521012685, 6700.195976482804, 6707.966460167717, 6724.3611856874, 4658.720476771371, 4658.930116048262, 4664.207084795593, 4668.626509879202, 4671.813127474931, 6881.346272104142, 6939.375456208965, 6956.582605043714, 7009.649517524154, 7010.579365238102, 4763.7141771493825, 4807.399075115611, 4809.0, 4813.326134341195, 4813.350197723333, 4871.2206047032305, 4871.3667223260745, 4880.243562247857, 4882.121218180761, 4884.926726099111, 5622.690752008597, 5629.268195134607, 5630.324361076615, 5636.4927156556105, 5637.9718101409235, 6545.116409284686, 6698.665066746643, 6741.8651626967185, 6755.2906944771075, 6761.661916904135, 1703.6763015027104, 1706.5818874375857, 1715.6482921001166, 1719.6388758360633, 1723.7242041273337, 1152.6196355202762, 1154.2324354304462, 1156.3119943633524, 1168.7662467506532, 1170.5083864776814, 6553.639549824806, 6553.705083271264, 6564.146660934143, 6566.277709451956, 6571.868562628721, 6920.723171073201, 6926.757563485254, 6942.652867356612, 6961.477889158334, 6966.5471744336455, 6427.935720642734, 6533.738650454024, 6552.082708420825, 6584.8024559263295, 6600.240972288152, 3734.458503516975, 3813.0848596336677, 3829.4447305141157, 3836.194399176204, 3841.0589405595806, 7121.0, 7142.178649455379, 7143.4999550031, 7147.82130446743, 7150.856982860418, 7071.292870712888, 7206.243344448862, 7211.242819503981, 7254.274572542704, 7264.200937896827, 7214.386777123898, 7237.203907570269, 7241.963790181121, 7248.528845625017, 7251.274872512707, 6950.478714096362, 6969.825754356181, 6970.093887794555, 6990.510664253657, 7006.894896576454, 6796.72813087471, 6929.965350173217, 6947.062146610143, 6947.930520694728, 6967.965160174167, 7221.566705997657, 7225.819354516179, 7236.38490728294, 7239.457040721862, 7249.710011599688, 4763.4522029967, 4795.664303498861, 4800.303955926441, 4800.879978000578, 4802.991371811819, 6893.7931862044215, 7052.647367631701, 7057.36483716468, 7059.5764254144915, 7062.71749130029, 6846.383825455733, 6851.246362899978, 6852.109225800813, 6855.485838562227, 6861.416779573792, 6551.312112228338, 6739.1804212863235, 6808.795736127924, 6812.795616131524, 6813.965930170318, 6637.900431493628, 6711.161104861892, 6716.3955244028275, 6722.462203023844, 6728.259891411843, 6781.6270105144695, 6840.931590684029, 6856.862862742817, 6867.244603093755, 6872.175338959357, 6573.3426657333885, 6651.900221496585, 6676.666166691549, 6682.866342673022, 6684.0], "unit": "ms", "name": "prototype.html", "value": 5105.489875296292}, {"lowerIsBetter": false, "replicates": [856.2379482260789, 934.7943452440466, 938.1978408460761, 944.140831843023, 958.0993865766179, 13381.7992730109, 13798.517051903185, 13836.893048556116, 13845.792313115298, 13891.513797017107, 13307.667308317297, 13439.93280033601, 13450.5292314769, 13474.663133421669, 13536.526221582246, 876.1370050500252, 883.8718385834051, 887.5029983209423, 890.9599068041921, 892.6429428228696, 865.7272959017921, 890.2922176869405, 891.131147131548, 893.3344658229628, 897.58710992943, 907.4237858959575, 921.6912334367995, 929.6420877961966, 929.8465753150722, 929.9209567186764, 890.0876601483467, 909.3316412436853, 911.1617312072909, 912.8265629530368, 921.6912334367995, 686.0772261308532, 689.1489011071322, 693.2997672350912, 694.6596167877703, 695.5826504097552, 13596.0, 13630.727385452334, 13702.657433564142, 13728.519501817389, 13735.0, 12343.93828030863, 12497.375131243401, 12657.30384828834, 13037.478500859954, 13729.931350343284, 10629.309094908805, 10846.837297440545, 10981.780364392667, 11151.275167114112, 11287.435628218556, 3802.8478860845535, 3874.1670540833857, 3882.9029274268087, 3888.727789054767, 3902.083010492532, 51382.22926656103, 51628.0, 53209.0, 53477.0, 53508.19737703977, 9972.60109595608, 10048.246381521269, 10138.0, 10208.693739187836, 10227.335223210468, 19242.903785480983, 19270.132844022053, 19278.421647350602, 19311.710324345146, 19349.709754353695, 7473.1032276126125, 7537.283958023979, 7556.357709594746, 7791.80520486981, 7824.491408058458, 4536.0, 4607.470140933836, 4632.235681112578, 4706.788194531255, 4726.95273047272, 3410.9829450853085, 3415.9146021349666, 3461.3423449544507, 3463.0303515015835, 3475.0, 644.3685188515187, 664.5979182594557, 670.1254862404609, 671.7111641993891, 673.1988933169513, 633.7926250492818, 678.1489231015144, 689.4312192441256, 722.6856317501904, 726.5459088069956, 8737.912620873836, 9167.17495425415, 9177.403468774508, 9292.860607090899, 9404.106609872051, 609.8170548835332, 731.2833423245249, 734.9637011813318, 747.5365273530338, 769.3998681028806, 3912.39357899526, 4124.587541245912, 4185.267578173807, 4310.892227694333, 4427.424434823517, 56980.43019569834, 57090.714546427, 57623.42376576264, 57858.132128018115, 61241.08138377928, 46327.0, 55241.723791380784, 56076.158857616356, 56253.71873140608, 56254.0, 51307.23039154416, 51424.0, 51961.220581691305, 51981.480185197666, 52863.47136528663, 8520.318374530147, 8635.395522313378, 8834.734957951272, 8959.910400895908, 8979.371443998858, 37445.0, 37456.81271593625, 38490.23019539649, 38532.614673852906, 38672.80663596664, 46113.76943115263, 46182.76908615435, 48336.5166348332, 49327.50672493229, 49936.75031624819, 10970.506327215135, 11093.16801239894, 11339.716507087389, 11363.261388009752, 11490.253133546626, 11560.132990025613, 11796.0, 11985.28088314704, 12164.330961797186, 12521.248725076524, 11181.888181118411, 11300.378479183724, 11826.34955077479, 11869.0, 11900.0, 11057.668269951915, 11212.83180752273, 11311.377874216669, 11369.0, 11503.309801411942, 11498.712532186428, 11705.824412633987, 11795.941020294844, 11835.82246266324, 11941.64175074749, 10058.798824023625, 10298.897011030094, 10380.844287335847, 10405.167586593207, 10656.786864262827, 9817.410955342702, 9922.305438619227, 9971.102600765966, 9981.301308908307, 10148.543315550965], "unit": "ms", "name": "yui.html", "value": 6692.998013376683}], "name": "dromaeo_css", "value": 7445.767625861024}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 106.0, 110.0, 109.0, 111.0, 122.0, 111.0, 113.0, 108.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [144.0, 126.0, 157.0, 164.0, 131.0, 147.0, 155.0, 125.0, 169.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.1}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 161.0, 162.0, 161.0, 166.0, 163.0, 164.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [78.0, 72.0, 72.0, 155.0, 71.0, 72.0, 73.0, 75.0, 151.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 89.3}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 134.0, 92.0, 93.0, 92.0, 134.0, 93.0, 92.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 104.7}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 111.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [148.0, 145.0, 146.0, 147.0, 146.0, 145.0, 146.0, 147.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [61.0, 61.0, 61.0, 62.0, 63.0, 62.0, 62.0, 61.0, 63.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 61.5}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 64.0, 65.0, 64.0, 65.0, 64.0, 65.0, 65.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.2}, {"lowerIsBetter": true, "replicates": [81.0, 80.0, 81.0, 82.0, 82.0, 81.0, 81.0, 82.0, 80.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 81.1}, {"lowerIsBetter": true, "replicates": [112.0, 122.0, 127.0, 128.0, 120.0, 125.0, 126.0, 129.0, 117.0, 135.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.1}, {"lowerIsBetter": true, "replicates": [149.0, 144.0, 145.0, 143.0, 146.0, 135.0, 148.0, 135.0, 145.0, 144.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.4}, {"lowerIsBetter": true, "replicates": [66.0, 64.0, 74.0, 64.0, 64.0, 64.0, 69.0, 65.0, 65.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.1}], "name": "kraken", "value": 1504.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.14970453053184], "unit": "score", "name": "Richards", "value": 215.0597840000001}, {"lowerIsBetter": false, "replicates": [173.4304543877905], "unit": "score", "name": "DeltaBlue", "value": 381.2363880000001}, {"lowerIsBetter": false, "replicates": [278.2415136338342], "unit": "score", "name": "Encrypt", "value": 956.654514}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [921.6589861751152], "unit": "score", "name": "RayTrace", "value": 802.8880650000001}, {"lowerIsBetter": false, "replicates": [550.357732526142], "unit": "score", "name": "Earley", "value": 1210.9632709999996}, {"lowerIsBetter": false, "replicates": [10913.04347826087], "unit": "score", "name": "Boyer", "value": 61.07031474103584}, {"lowerIsBetter": false, "replicates": [24707.317073170732], "unit": "score", "name": "RegExp", "value": 36.871061204343526}, {"lowerIsBetter": false, "replicates": [504.79555779909134], "unit": "score", "name": "Splay", "value": 161.4336710000001}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 23211.69665052093}]} 16:30:54 INFO - RETURN: dromaeo_css: 7445.77 16:30:54 INFO - RETURN: kraken: 1504.20 16:30:54 INFO - RETURN: v8_7: 23211.70 16:30:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23211.70"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1504.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7445.77"}}} 16:30:54 INFO - Return code: 0 16:30:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:30:54 INFO - # TBPL SUCCESS # 16:30:54 INFO - Running post-action listener: _resource_record_post_action 16:30:54 INFO - Running post-run listener: _resource_record_post_run 16:30:55 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 8192; Write bytes: 503742464; Read time: 28; Write time: 366024 16:30:55 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 236670976; Read time: 0; Write time: 215500 16:30:55 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 8192; Write bytes: 266207232; Read time: 28; Write time: 150488 16:30:55 INFO - Running post-run listener: _upload_blobber_files 16:30:55 INFO - Blob upload gear active. 16:30:55 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:30:55 INFO - Copying logs to upload dir... 16:30:55 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.360060 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-12-22 16:30:55.073026) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-22 16:30:55.077978) ========= 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=b00de3c228505fac2445e70d000001bb-1450828060.651877-80247873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009897 build_url: 'https://queue.taskcluster.net/v1/task/vQptS6AgR-GU82YlWfvDlg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-22 16:30:55.132540) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 16:30:55.133004) ========= 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=b00de3c228505fac2445e70d000001bb-1450828060.651877-80247873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004655 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 16:30:55.182340) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 16:30:55.182681) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 16:30:55.183018) ========= ========= Total master_lag: 0.25 =========