builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1453323398.03 results: success (0) buildid: 20160120103210 builduid: 827053235f354d35b33aaa0966db3698 revision: cf7672d6635465a2ae70b7de562abc30848768ca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 12:56:38.029122) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 12:56:38.029654) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 12:56:38.029944) ========= 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=32c5991c409366f7fec8a718000001d2-1453323122.434493-2042910664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006415 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 12:56:38.059776) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 12:56:38.060145) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 12:56:38.125213) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:56:38.125728) ========= 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=32c5991c409366f7fec8a718000001d2-1453323122.434493-2042910664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004663 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:56:38.183406) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 12:56:38.183713) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 12:56:38.184077) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:56:38.184347) ========= 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=32c5991c409366f7fec8a718000001d2-1453323122.434493-2042910664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-20 12:56:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 19.5M=0.001s 2016-01-20 12:56:38 (19.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118191 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:56:38.316870) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:56:38.317153) ========= 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=32c5991c409366f7fec8a718000001d2-1453323122.434493-2042910664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022868 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:56:38.367334) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:56:38.367664) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cf7672d6635465a2ae70b7de562abc30848768ca --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 cf7672d6635465a2ae70b7de562abc30848768ca --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=32c5991c409366f7fec8a718000001d2-1453323122.434493-2042910664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-20 12:56:38,843 truncating revision to first 12 chars 2016-01-20 12:56:38,843 Setting DEBUG logging. 2016-01-20 12:56:38,843 attempt 1/10 2016-01-20 12:56:38,843 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/cf7672d66354?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-20 12:56:39,230 unpacking tar archive at: mozilla-aurora-cf7672d66354/testing/mozharness/ program finished with exit code 0 elapsedTime=0.660300 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:56:39.041283) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 12:56:39.041668) ========= echo cf7672d6635465a2ae70b7de562abc30848768ca in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'cf7672d6635465a2ae70b7de562abc30848768ca'] 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=32c5991c409366f7fec8a718000001d2-1453323122.434493-2042910664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False cf7672d6635465a2ae70b7de562abc30848768ca program finished with exit code 0 elapsedTime=0.004626 script_repo_revision: 'cf7672d6635465a2ae70b7de562abc30848768ca' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 12:56:39.092117) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 12:56:39.092436) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 12:56:39.102329) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 12:56:39.102673) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/cf7672d6635465a2ae70b7de562abc30848768ca ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 12:56:39.103092) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-01-20 12:56:39.103399) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1453323122.434493-2042910664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:56:39 INFO - MultiFileLogger online at 20160120 12:56:39 in /builds/slave/test-pgo 12:56:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 12:56:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:56:39 INFO - {'append_to_log': False, 12:56:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:56:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:56:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:56:39 INFO - 'branch': 'Mozilla-Aurora', 12:56:39 INFO - 'buildbot_json_path': 'buildprops.json', 12:56:39 INFO - 'config_files': ('talos/linux_config.py',), 12:56:39 INFO - 'default_actions': ('clobber', 12:56:39 INFO - 'read-buildbot-config', 12:56:39 INFO - 'download-and-extract', 12:56:39 INFO - 'populate-webroot', 12:56:39 INFO - 'create-virtualenv', 12:56:39 INFO - 'install', 12:56:39 INFO - 'run-tests'), 12:56:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:56:39 INFO - 'download_minidump_stackwalk': True, 12:56:39 INFO - 'download_symbols': 'ondemand', 12:56:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:56:39 INFO - 'tooltool.py': '/tools/tooltool.py', 12:56:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:56:39 INFO - '/tools/misc-python/virtualenv.py')}, 12:56:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:56:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:56:39 INFO - 'installer_path': 'installer.exe', 12:56:39 INFO - 'log_level': 'info', 12:56:39 INFO - 'log_name': 'talos', 12:56:39 INFO - 'log_to_console': True, 12:56:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:56:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:56:39 INFO - 'opt_config_files': (), 12:56:39 INFO - 'pip_index': False, 12:56:39 INFO - 'sps_profile': False, 12:56:39 INFO - 'sps_profile_interval': 0, 12:56:39 INFO - 'suite': 'dromaeojs', 12:56:39 INFO - 'system_bits': '32', 12:56:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:56:39 INFO - 'title': 'talos-linux64-ix-008', 12:56:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:56:39 INFO - 'use_talos_json': True, 12:56:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:56:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:56:39 INFO - 'work_dir': 'build'} 12:56:39 INFO - ##### 12:56:39 INFO - ##### Running clobber step. 12:56:39 INFO - ##### 12:56:39 INFO - Running pre-action listener: _resource_record_pre_action 12:56:39 INFO - Running main action method: clobber 12:56:39 INFO - rmtree: /builds/slave/test-pgo/build 12:56:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:56:40 INFO - Running post-action listener: _resource_record_post_action 12:56:40 INFO - ##### 12:56:40 INFO - ##### Running read-buildbot-config step. 12:56:40 INFO - ##### 12:56:40 INFO - Running pre-action listener: _resource_record_pre_action 12:56:40 INFO - Running main action method: read_buildbot_config 12:56:40 INFO - Using buildbot properties: 12:56:40 INFO - { 12:56:40 INFO - "properties": { 12:56:40 INFO - "buildnumber": 207, 12:56:40 INFO - "product": "firefox", 12:56:40 INFO - "script_repo_revision": "production", 12:56:40 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 12:56:40 INFO - "repository": "", 12:56:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 12:56:40 INFO - "buildid": "20160120103210", 12:56:40 INFO - "slavename": "talos-linux64-ix-008", 12:56:40 INFO - "pgo_build": "True", 12:56:40 INFO - "basedir": "/builds/slave/test-pgo", 12:56:40 INFO - "project": "", 12:56:40 INFO - "platform": "ubuntu64_hw", 12:56:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:56:40 INFO - "slavebuilddir": "test", 12:56:40 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 12:56:40 INFO - "branch": "mozilla-aurora", 12:56:40 INFO - "repo_path": "releases/mozilla-aurora", 12:56:40 INFO - "stage_platform": "linux64-pgo", 12:56:40 INFO - "builduid": "827053235f354d35b33aaa0966db3698", 12:56:40 INFO - "revision": "cf7672d6635465a2ae70b7de562abc30848768ca" 12:56:40 INFO - }, 12:56:40 INFO - "sourcestamp": { 12:56:40 INFO - "repository": "", 12:56:40 INFO - "hasPatch": false, 12:56:40 INFO - "project": "", 12:56:40 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 12:56:40 INFO - "changes": [ 12:56:40 INFO - { 12:56:40 INFO - "category": null, 12:56:40 INFO - "files": [ 12:56:40 INFO - { 12:56:40 INFO - "url": null, 12:56:40 INFO - "name": "https://queue.taskcluster.net/v1/task/kPWp9zfgTqGvJD34lcTwVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 12:56:40 INFO - } 12:56:40 INFO - ], 12:56:40 INFO - "repository": "", 12:56:40 INFO - "rev": "cf7672d6635465a2ae70b7de562abc30848768ca", 12:56:40 INFO - "who": "hskupin@mozilla.com", 12:56:40 INFO - "when": 1453323339, 12:56:40 INFO - "number": 7488071, 12:56:40 INFO - "comments": "Bug 1212609 - Add common test package rules for firefox-ui-tests. r=gps a=testonly\n", 12:56:40 INFO - "project": "", 12:56:40 INFO - "at": "Wed 20 Jan 2016 12:55:39", 12:56:40 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 12:56:40 INFO - "revlink": "", 12:56:40 INFO - "properties": [ 12:56:40 INFO - [ 12:56:40 INFO - "buildid", 12:56:40 INFO - "20160120103210", 12:56:40 INFO - "Change" 12:56:40 INFO - ], 12:56:40 INFO - [ 12:56:40 INFO - "builduid", 12:56:40 INFO - "827053235f354d35b33aaa0966db3698", 12:56:40 INFO - "Change" 12:56:40 INFO - ], 12:56:40 INFO - [ 12:56:40 INFO - "pgo_build", 12:56:40 INFO - "True", 12:56:40 INFO - "Change" 12:56:40 INFO - ] 12:56:40 INFO - ], 12:56:40 INFO - "revision": "cf7672d6635465a2ae70b7de562abc30848768ca" 12:56:40 INFO - } 12:56:40 INFO - ], 12:56:40 INFO - "revision": "cf7672d6635465a2ae70b7de562abc30848768ca" 12:56:40 INFO - } 12:56:40 INFO - } 12:56:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/kPWp9zfgTqGvJD34lcTwVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 12:56:40 INFO - Running post-action listener: _resource_record_post_action 12:56:40 INFO - ##### 12:56:40 INFO - ##### Running download-and-extract step. 12:56:40 INFO - ##### 12:56:40 INFO - Running pre-action listener: _resource_record_pre_action 12:56:40 INFO - Running main action method: download_and_extract 12:56:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:40 INFO - https://queue.taskcluster.net/v1/task/kPWp9zfgTqGvJD34lcTwVQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:56:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kPWp9zfgTqGvJD34lcTwVQ/artifacts/public/build/test_packages.json 12:56:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kPWp9zfgTqGvJD34lcTwVQ/artifacts/public/build/test_packages.json 12:56:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kPWp9zfgTqGvJD34lcTwVQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 12:56:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kPWp9zfgTqGvJD34lcTwVQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 12:56:40 INFO - Downloaded 1302 bytes. 12:56:40 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 12:56:40 INFO - Using the following test package requirements: 12:56:40 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 12:56:40 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 12:56:40 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 12:56:40 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 12:56:40 INFO - u'jsshell-linux-x86_64.zip'], 12:56:40 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 12:56:40 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 12:56:40 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 12:56:40 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 12:56:40 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 12:56:40 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 12:56:40 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 12:56:40 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 12:56:40 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 12:56:40 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 12:56:40 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 12:56:40 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 12:56:40 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:40 INFO - https://queue.taskcluster.net/v1/task/kPWp9zfgTqGvJD34lcTwVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:56:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kPWp9zfgTqGvJD34lcTwVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 12:56:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kPWp9zfgTqGvJD34lcTwVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 12:56:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kPWp9zfgTqGvJD34lcTwVQ/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 12:56:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kPWp9zfgTqGvJD34lcTwVQ/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 12:56:41 INFO - Downloaded 23159749 bytes. 12:56:41 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 12:56:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 12:56:41 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 12:56:43 INFO - Return code: 0 12:56:43 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 12:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:43 INFO - https://queue.taskcluster.net/v1/task/kPWp9zfgTqGvJD34lcTwVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:56:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kPWp9zfgTqGvJD34lcTwVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 12:56:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kPWp9zfgTqGvJD34lcTwVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 12:56:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kPWp9zfgTqGvJD34lcTwVQ/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 12:56:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kPWp9zfgTqGvJD34lcTwVQ/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 12:56:48 INFO - Downloaded 23159749 bytes. 12:56:48 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 12:56:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 12:56:48 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 12:56:49 INFO - Return code: 0 12:56:49 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')]} 12:56:49 INFO - https://queue.taskcluster.net/v1/task/kPWp9zfgTqGvJD34lcTwVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:56:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kPWp9zfgTqGvJD34lcTwVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 12:56:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kPWp9zfgTqGvJD34lcTwVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 12:56:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kPWp9zfgTqGvJD34lcTwVQ/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 12:56:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kPWp9zfgTqGvJD34lcTwVQ/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 12:56:51 INFO - Downloaded 11132038 bytes. 12:56:51 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 12:56:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 12:56:51 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 12:56:51 INFO - Return code: 0 12:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:51 INFO - https://queue.taskcluster.net/v1/task/kPWp9zfgTqGvJD34lcTwVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:56:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kPWp9zfgTqGvJD34lcTwVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 12:56:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kPWp9zfgTqGvJD34lcTwVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 12:56:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kPWp9zfgTqGvJD34lcTwVQ/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 12:56:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kPWp9zfgTqGvJD34lcTwVQ/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 12:56:53 INFO - Downloaded 58126718 bytes. 12:56:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/kPWp9zfgTqGvJD34lcTwVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 12:56:53 INFO - mkdir: /builds/slave/test-pgo/properties 12:56:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:56:53 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:56:53 INFO - Contents: 12:56:53 INFO - build_url:https://queue.taskcluster.net/v1/task/kPWp9zfgTqGvJD34lcTwVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 12:56:53 INFO - Running post-action listener: _resource_record_post_action 12:56:53 INFO - Running post-action listener: set_extra_try_arguments 12:56:53 INFO - ##### 12:56:53 INFO - ##### Running populate-webroot step. 12:56:53 INFO - ##### 12:56:53 INFO - Running pre-action listener: _resource_record_pre_action 12:56:53 INFO - Running main action method: populate_webroot 12:56:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:56:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:56:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:56:53 INFO - '--tppagecycles', 12:56:53 INFO - '7'], 12:56:53 INFO - 'tests': ['tsvgm']}}, 12:56:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:56:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:56:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:56:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:56:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:56:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:56:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:56:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:53 INFO - 'talos_options': ['--e10s'], 12:56:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:56:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:53 INFO - 'tests': ['damp', 'tps']}, 12:56:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:53 INFO - 'talos_options': ['--e10s'], 12:56:53 INFO - 'tests': ['damp', 'tps']}, 12:56:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:56:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:56:53 INFO - 'other': {'tests': ['a11yr', 12:56:53 INFO - 'ts_paint', 12:56:53 INFO - 'tpaint', 12:56:53 INFO - 'sessionrestore', 12:56:53 INFO - 'sessionrestore_no_auto_restore']}, 12:56:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:56:53 INFO - 'tests': ['a11yr', 12:56:53 INFO - 'ts_paint', 12:56:53 INFO - 'tpaint', 12:56:53 INFO - 'sessionrestore', 12:56:53 INFO - 'sessionrestore_no_auto_restore']}, 12:56:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:56:53 INFO - 'tests': ['a11yr', 12:56:53 INFO - 'ts_paint', 12:56:53 INFO - 'tpaint', 12:56:53 INFO - 'sessionrestore', 12:56:53 INFO - 'sessionrestore_no_auto_restore']}, 12:56:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:56:53 INFO - 'tests': ['a11yr', 12:56:53 INFO - 'ts_paint', 12:56:53 INFO - 'tpaint', 12:56:53 INFO - 'sessionrestore', 12:56:53 INFO - 'sessionrestore_no_auto_restore']}, 12:56:53 INFO - 'other_l64': {'tests': ['a11yr', 12:56:53 INFO - 'ts_paint', 12:56:53 INFO - 'tpaint', 12:56:53 INFO - 'sessionrestore', 12:56:53 INFO - 'sessionrestore_no_auto_restore']}, 12:56:53 INFO - 'other_nol64': {'tests': ['a11yr', 12:56:53 INFO - 'ts_paint', 12:56:53 INFO - 'tpaint', 12:56:53 INFO - 'sessionrestore', 12:56:53 INFO - 'sessionrestore_no_auto_restore']}, 12:56:53 INFO - 'svgr': {'tests': ['tsvgx', 12:56:53 INFO - 'tsvgr_opacity', 12:56:53 INFO - 'tart', 12:56:53 INFO - 'tscrollx', 12:56:53 INFO - 'cart']}, 12:56:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:56:53 INFO - 'tests': ['tsvgx', 12:56:53 INFO - 'tsvgr_opacity', 12:56:53 INFO - 'tart', 12:56:53 INFO - 'tscrollx', 12:56:53 INFO - 'cart']}, 12:56:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:53 INFO - 'tests': ['tp5o']}, 12:56:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:53 INFO - 'talos_options': ['--e10s'], 12:56:53 INFO - 'tests': ['tp5o']}, 12:56:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:53 INFO - 'talos_options': ['--xperf_path', 12:56:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:56:53 INFO - 'tests': ['tp5n']}, 12:56:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:53 INFO - 'talos_options': ['--e10s', 12:56:53 INFO - '--xperf_path', 12:56:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:56:53 INFO - 'tests': ['tp5n']}}, 12:56:53 INFO - 'talos.zip': {'path': '', 12:56:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:56:53 INFO - Running post-action listener: _resource_record_post_action 12:56:53 INFO - ##### 12:56:53 INFO - ##### Running create-virtualenv step. 12:56:53 INFO - ##### 12:56:53 INFO - Running pre-action listener: _resource_record_pre_action 12:56:53 INFO - Running main action method: create_virtualenv 12:56:53 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:56:53 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 12:56:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:56:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:56:53 INFO - Using real prefix '/usr' 12:56:53 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:56:54 INFO - Installing distribute.............................................................................................................................................................................................done. 12:56:55 INFO - Installing pip.................done. 12:56:56 INFO - Return code: 0 12:56:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f21e55ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, '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 0xd75250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd756e0>, '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': '32c5991c409366f7fec8a718000001d2-1453323122.434493-2042910664', '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 12:56:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 12:56:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:56:56 INFO - Using env: {'DISPLAY': ':0', 12:56:56 INFO - 'HOME': '/home/cltbld', 12:56:56 INFO - 'LANG': 'en_US.UTF-8', 12:56:56 INFO - 'LANGUAGE': 'en_US:en', 12:56:56 INFO - 'LOGNAME': 'cltbld', 12:56:56 INFO - 'MAIL': '/var/mail/cltbld', 12:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:56 INFO - 'MOZ_NO_REMOTE': '1', 12:56:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:56 INFO - 'NO_EM_RESTART': '1', 12:56:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:56:56 INFO - 'PWD': '/builds/slave/test-pgo', 12:56:56 INFO - 'SHELL': '/bin/bash', 12:56:56 INFO - 'SHLVL': '1', 12:56:56 INFO - 'TERM': 'linux', 12:56:56 INFO - 'TMOUT': '86400', 12:56:56 INFO - 'USER': 'cltbld', 12:56:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453323122.434493-2042910664', 12:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:56 INFO - '_': '/tools/buildbot/bin/python'} 12:56:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:56 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 12:56:56 INFO - Cleaning up... 12:56:56 INFO - Return code: 0 12:56:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f21e55ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, '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 0xd75250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd756e0>, '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': '32c5991c409366f7fec8a718000001d2-1453323122.434493-2042910664', '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 12:56:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 12:56:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:56:56 INFO - Using env: {'DISPLAY': ':0', 12:56:56 INFO - 'HOME': '/home/cltbld', 12:56:56 INFO - 'LANG': 'en_US.UTF-8', 12:56:56 INFO - 'LANGUAGE': 'en_US:en', 12:56:56 INFO - 'LOGNAME': 'cltbld', 12:56:56 INFO - 'MAIL': '/var/mail/cltbld', 12:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:56 INFO - 'MOZ_NO_REMOTE': '1', 12:56:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:56 INFO - 'NO_EM_RESTART': '1', 12:56:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:56:56 INFO - 'PWD': '/builds/slave/test-pgo', 12:56:56 INFO - 'SHELL': '/bin/bash', 12:56:56 INFO - 'SHLVL': '1', 12:56:56 INFO - 'TERM': 'linux', 12:56:56 INFO - 'TMOUT': '86400', 12:56:56 INFO - 'USER': 'cltbld', 12:56:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453323122.434493-2042910664', 12:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:56 INFO - '_': '/tools/buildbot/bin/python'} 12:56:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:56 INFO - Downloading/unpacking psutil>=0.7.1 12:56:56 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 12:56:56 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 12:56:56 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 12:56:56 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 12:56:56 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 12:56:56 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 12:56:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:56:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:56:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:56:58 INFO - Installing collected packages: psutil 12:56:58 INFO - Running setup.py install for psutil 12:56:58 INFO - building 'psutil._psutil_linux' extension 12:56:58 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 12:56:58 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 12:56:58 INFO - building 'psutil._psutil_posix' extension 12:56:58 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 12:56:58 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 12:56:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:56:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:56:58 INFO - Successfully installed psutil 12:56:58 INFO - Cleaning up... 12:56:58 INFO - Return code: 0 12:56:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:56:58 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')]} 12:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:58 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')]} 12:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f21e55ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, '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 0xd75250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd756e0>, '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': '32c5991c409366f7fec8a718000001d2-1453323122.434493-2042910664', '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 12:56:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 12:56:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:56:58 INFO - Using env: {'DISPLAY': ':0', 12:56:58 INFO - 'HOME': '/home/cltbld', 12:56:58 INFO - 'LANG': 'en_US.UTF-8', 12:56:58 INFO - 'LANGUAGE': 'en_US:en', 12:56:58 INFO - 'LOGNAME': 'cltbld', 12:56:58 INFO - 'MAIL': '/var/mail/cltbld', 12:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:58 INFO - 'MOZ_NO_REMOTE': '1', 12:56:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:58 INFO - 'NO_EM_RESTART': '1', 12:56:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:56:58 INFO - 'PWD': '/builds/slave/test-pgo', 12:56:58 INFO - 'SHELL': '/bin/bash', 12:56:58 INFO - 'SHLVL': '1', 12:56:58 INFO - 'TERM': 'linux', 12:56:58 INFO - 'TMOUT': '86400', 12:56:58 INFO - 'USER': 'cltbld', 12:56:58 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453323122.434493-2042910664', 12:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:58 INFO - '_': '/tools/buildbot/bin/python'} 12:56:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:57:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:57:00 INFO - Installing collected packages: mozsystemmonitor 12:57:00 INFO - Running setup.py install for mozsystemmonitor 12:57:00 INFO - Successfully installed mozsystemmonitor 12:57:00 INFO - Cleaning up... 12:57:00 INFO - Return code: 0 12:57:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f21e55ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, '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 0xd75250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd756e0>, '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': '32c5991c409366f7fec8a718000001d2-1453323122.434493-2042910664', '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 12:57:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 12:57:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:57:00 INFO - Using env: {'DISPLAY': ':0', 12:57:00 INFO - 'HOME': '/home/cltbld', 12:57:00 INFO - 'LANG': 'en_US.UTF-8', 12:57:00 INFO - 'LANGUAGE': 'en_US:en', 12:57:00 INFO - 'LOGNAME': 'cltbld', 12:57:00 INFO - 'MAIL': '/var/mail/cltbld', 12:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:00 INFO - 'MOZ_NO_REMOTE': '1', 12:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:00 INFO - 'NO_EM_RESTART': '1', 12:57:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:57:00 INFO - 'PWD': '/builds/slave/test-pgo', 12:57:00 INFO - 'SHELL': '/bin/bash', 12:57:00 INFO - 'SHLVL': '1', 12:57:00 INFO - 'TERM': 'linux', 12:57:00 INFO - 'TMOUT': '86400', 12:57:00 INFO - 'USER': 'cltbld', 12:57:00 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453323122.434493-2042910664', 12:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:00 INFO - '_': '/tools/buildbot/bin/python'} 12:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:01 INFO - Downloading/unpacking blobuploader==1.2.4 12:57:01 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 12:57:01 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 12:57:01 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 12:57:01 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 12:57:01 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 12:57:01 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 12:57:02 INFO - Downloading blobuploader-1.2.4.tar.gz 12:57:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:57:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:57:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:03 INFO - Downloading docopt-0.6.1.tar.gz 12:57:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:57:03 INFO - Installing collected packages: blobuploader, requests, docopt 12:57:03 INFO - Running setup.py install for blobuploader 12:57:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:57:03 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:57:03 INFO - Running setup.py install for requests 12:57:04 INFO - Running setup.py install for docopt 12:57:04 INFO - Successfully installed blobuploader requests docopt 12:57:04 INFO - Cleaning up... 12:57:04 INFO - Return code: 0 12:57:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f21e55ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, '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 0xd75250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd756e0>, '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': '32c5991c409366f7fec8a718000001d2-1453323122.434493-2042910664', '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 12:57:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 12:57:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:57:04 INFO - Using env: {'DISPLAY': ':0', 12:57:04 INFO - 'HOME': '/home/cltbld', 12:57:04 INFO - 'LANG': 'en_US.UTF-8', 12:57:04 INFO - 'LANGUAGE': 'en_US:en', 12:57:04 INFO - 'LOGNAME': 'cltbld', 12:57:04 INFO - 'MAIL': '/var/mail/cltbld', 12:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:04 INFO - 'MOZ_NO_REMOTE': '1', 12:57:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:04 INFO - 'NO_EM_RESTART': '1', 12:57:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:57:04 INFO - 'PWD': '/builds/slave/test-pgo', 12:57:04 INFO - 'SHELL': '/bin/bash', 12:57:04 INFO - 'SHLVL': '1', 12:57:04 INFO - 'TERM': 'linux', 12:57:04 INFO - 'TMOUT': '86400', 12:57:04 INFO - 'USER': 'cltbld', 12:57:04 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453323122.434493-2042910664', 12:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:04 INFO - '_': '/tools/buildbot/bin/python'} 12:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:57:04 INFO - Running setup.py (path:/tmp/pip-EKhE5o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:57:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:57:04 INFO - Running setup.py (path:/tmp/pip-tcYYwC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:57:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:57:04 INFO - Running setup.py (path:/tmp/pip-2XYI22-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:57:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:57:04 INFO - Running setup.py (path:/tmp/pip-V4gwC_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:57:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:57:04 INFO - Running setup.py (path:/tmp/pip-lRzJq0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:57:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:57:04 INFO - Running setup.py (path:/tmp/pip-frCPaw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:57:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:57:04 INFO - Running setup.py (path:/tmp/pip-QQq21D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:57:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:57:04 INFO - Running setup.py (path:/tmp/pip-pLBtOQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:57:05 INFO - Running setup.py (path:/tmp/pip-_EmIuh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:57:05 INFO - Running setup.py (path:/tmp/pip-brhX4L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:57:05 INFO - Running setup.py (path:/tmp/pip-Zj_sbF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:57:05 INFO - Running setup.py (path:/tmp/pip-JNKzok-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:57:05 INFO - Running setup.py (path:/tmp/pip-J8Ty2R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:57:05 INFO - Running setup.py (path:/tmp/pip-RGWe1U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:57:05 INFO - Running setup.py (path:/tmp/pip-ygTUrB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:57:05 INFO - Running setup.py (path:/tmp/pip-FGtLia-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:57:05 INFO - Running setup.py (path:/tmp/pip-jqa_vq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:57:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:57:05 INFO - Running setup.py install for manifestparser 12:57:05 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:57:05 INFO - Running setup.py install for mozcrash 12:57:05 INFO - Running setup.py install for mozdebug 12:57:06 INFO - Running setup.py install for mozdevice 12:57:06 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:57:06 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:57:06 INFO - Running setup.py install for mozfile 12:57:06 INFO - Running setup.py install for mozhttpd 12:57:06 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:57:06 INFO - Running setup.py install for mozinfo 12:57:06 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:57:06 INFO - Running setup.py install for mozInstall 12:57:06 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:57:06 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:57:06 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:57:06 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:57:06 INFO - Running setup.py install for mozleak 12:57:06 INFO - Running setup.py install for mozlog 12:57:06 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:57:06 INFO - Running setup.py install for moznetwork 12:57:06 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:57:06 INFO - Running setup.py install for mozprocess 12:57:06 INFO - Running setup.py install for mozprofile 12:57:07 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:57:07 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:57:07 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:57:07 INFO - Running setup.py install for mozrunner 12:57:07 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:57:07 INFO - Running setup.py install for mozscreenshot 12:57:07 INFO - Running setup.py install for moztest 12:57:07 INFO - Running setup.py install for mozversion 12:57:07 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:57:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:57:07 INFO - Cleaning up... 12:57:07 INFO - Return code: 0 12:57:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f21e55ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, '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 0xd75250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd756e0>, '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': '32c5991c409366f7fec8a718000001d2-1453323122.434493-2042910664', '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 12:57:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 12:57:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:57:07 INFO - Using env: {'DISPLAY': ':0', 12:57:07 INFO - 'HOME': '/home/cltbld', 12:57:07 INFO - 'LANG': 'en_US.UTF-8', 12:57:07 INFO - 'LANGUAGE': 'en_US:en', 12:57:07 INFO - 'LOGNAME': 'cltbld', 12:57:07 INFO - 'MAIL': '/var/mail/cltbld', 12:57:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:07 INFO - 'MOZ_NO_REMOTE': '1', 12:57:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:07 INFO - 'NO_EM_RESTART': '1', 12:57:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:57:07 INFO - 'PWD': '/builds/slave/test-pgo', 12:57:07 INFO - 'SHELL': '/bin/bash', 12:57:07 INFO - 'SHLVL': '1', 12:57:07 INFO - 'TERM': 'linux', 12:57:07 INFO - 'TMOUT': '86400', 12:57:07 INFO - 'USER': 'cltbld', 12:57:07 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453323122.434493-2042910664', 12:57:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:07 INFO - '_': '/tools/buildbot/bin/python'} 12:57:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:57:07 INFO - Running setup.py (path:/tmp/pip-dShbdF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:57:07 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)) 12:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:57:07 INFO - Running setup.py (path:/tmp/pip-2Yh7tR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:57:07 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)) 12:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:57:07 INFO - Running setup.py (path:/tmp/pip-qDac9w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:57:07 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)) 12:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:57:07 INFO - Running setup.py (path:/tmp/pip-22tujd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:57:08 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)) 12:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:57:08 INFO - Running setup.py (path:/tmp/pip-6oHOrx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:57:08 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)) 12:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:57:08 INFO - Running setup.py (path:/tmp/pip-D7pCUt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:57:08 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)) 12:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:57:08 INFO - Running setup.py (path:/tmp/pip-3jJNUe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:57:08 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)) 12:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:57:08 INFO - Running setup.py (path:/tmp/pip-eC5qgk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:57:08 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)) 12:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:57:08 INFO - Running setup.py (path:/tmp/pip-w1XEak-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:57:08 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)) 12:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:57:08 INFO - Running setup.py (path:/tmp/pip-SThCmI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:57:08 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)) 12:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:57:08 INFO - Running setup.py (path:/tmp/pip-h3Ffhj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:57:08 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)) 12:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:57:08 INFO - Running setup.py (path:/tmp/pip-OKvblT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:57:08 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)) 12:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:57:08 INFO - Running setup.py (path:/tmp/pip-K6bu36-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:57:08 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)) 12:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:57:08 INFO - Running setup.py (path:/tmp/pip-T7t8cz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:57:08 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)) 12:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:57:08 INFO - Running setup.py (path:/tmp/pip-Ly8QHL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:57:08 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)) 12:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:57:08 INFO - Running setup.py (path:/tmp/pip-Zrg5B_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:57:08 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)) 12:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:57:08 INFO - Running setup.py (path:/tmp/pip-Vli2on-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:57:08 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)) 12:57:08 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)) 12:57:08 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)) 12:57:08 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)) 12:57:08 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)) 12:57:08 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)) 12:57:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:10 INFO - Downloading blessings-1.6.tar.gz 12:57:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:57:10 INFO - Installing collected packages: blessings 12:57:10 INFO - Running setup.py install for blessings 12:57:10 INFO - Successfully installed blessings 12:57:10 INFO - Cleaning up... 12:57:10 INFO - Return code: 0 12:57:10 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:57:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:57:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:57:11 INFO - Reading from file tmpfile_stdout 12:57:11 INFO - Current package versions: 12:57:11 INFO - argparse == 1.2.1 12:57:11 INFO - blessings == 1.6 12:57:11 INFO - blobuploader == 1.2.4 12:57:11 INFO - docopt == 0.6.1 12:57:11 INFO - manifestparser == 1.1 12:57:11 INFO - mozInstall == 1.12 12:57:11 INFO - mozcrash == 0.16 12:57:11 INFO - mozdebug == 0.1 12:57:11 INFO - mozdevice == 0.47 12:57:11 INFO - mozfile == 1.2 12:57:11 INFO - mozhttpd == 0.7 12:57:11 INFO - mozinfo == 0.9 12:57:11 INFO - mozleak == 0.1 12:57:11 INFO - mozlog == 3.1 12:57:11 INFO - moznetwork == 0.27 12:57:11 INFO - mozprocess == 0.22 12:57:11 INFO - mozprofile == 0.27 12:57:11 INFO - mozrunner == 6.11 12:57:11 INFO - mozscreenshot == 0.1 12:57:11 INFO - mozsystemmonitor == 0.0 12:57:11 INFO - moztest == 0.7 12:57:11 INFO - mozversion == 1.4 12:57:11 INFO - psutil == 3.1.1 12:57:11 INFO - requests == 1.2.3 12:57:11 INFO - wsgiref == 0.1.2 12:57:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:57: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')]} 12:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57: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')]} 12:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f21e55ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, '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 0xd75250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd756e0>, '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': '32c5991c409366f7fec8a718000001d2-1453323122.434493-2042910664', '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 12:57:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 12:57:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:57:11 INFO - Using env: {'DISPLAY': ':0', 12:57:11 INFO - 'HOME': '/home/cltbld', 12:57:11 INFO - 'LANG': 'en_US.UTF-8', 12:57:11 INFO - 'LANGUAGE': 'en_US:en', 12:57:11 INFO - 'LOGNAME': 'cltbld', 12:57:11 INFO - 'MAIL': '/var/mail/cltbld', 12:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:11 INFO - 'MOZ_NO_REMOTE': '1', 12:57:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:11 INFO - 'NO_EM_RESTART': '1', 12:57:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:57:11 INFO - 'PWD': '/builds/slave/test-pgo', 12:57:11 INFO - 'SHELL': '/bin/bash', 12:57:11 INFO - 'SHLVL': '1', 12:57:11 INFO - 'TERM': 'linux', 12:57:11 INFO - 'TMOUT': '86400', 12:57:11 INFO - 'USER': 'cltbld', 12:57:11 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453323122.434493-2042910664', 12:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:11 INFO - '_': '/tools/buildbot/bin/python'} 12:57:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:11 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)) 12:57:11 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)) 12:57:11 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)) 12:57:11 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)) 12:57:11 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)) 12:57:11 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)) 12:57:11 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)) 12:57:11 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)) 12:57:11 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)) 12:57:11 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)) 12:57:11 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)) 12:57:11 INFO - Cleaning up... 12:57:11 INFO - Return code: 0 12:57:11 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 12:57: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')]} 12:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57: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')]} 12:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f21e55ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, '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 0xd75250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd756e0>, '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': '32c5991c409366f7fec8a718000001d2-1453323122.434493-2042910664', '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 12:57:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 12:57:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:57:11 INFO - Using env: {'DISPLAY': ':0', 12:57:11 INFO - 'HOME': '/home/cltbld', 12:57:11 INFO - 'LANG': 'en_US.UTF-8', 12:57:11 INFO - 'LANGUAGE': 'en_US:en', 12:57:11 INFO - 'LOGNAME': 'cltbld', 12:57:11 INFO - 'MAIL': '/var/mail/cltbld', 12:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:11 INFO - 'MOZ_NO_REMOTE': '1', 12:57:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:11 INFO - 'NO_EM_RESTART': '1', 12:57:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:57:11 INFO - 'PWD': '/builds/slave/test-pgo', 12:57:11 INFO - 'SHELL': '/bin/bash', 12:57:11 INFO - 'SHLVL': '1', 12:57:11 INFO - 'TERM': 'linux', 12:57:11 INFO - 'TMOUT': '86400', 12:57:11 INFO - 'USER': 'cltbld', 12:57:11 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453323122.434493-2042910664', 12:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:11 INFO - '_': '/tools/buildbot/bin/python'} 12:57:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:11 INFO - Downloading/unpacking jsonschema 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:57:13 INFO - Downloading/unpacking functools32 (from jsonschema) 12:57:13 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 12:57:13 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 12:57:13 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 12:57:13 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 12:57:13 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 12:57:13 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 12:57:13 INFO - Downloading functools32-3.2.3-2.tar.gz 12:57:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 12:57:13 INFO - warning: no files found matching '*.txt' 12:57:13 INFO - no previously-included directories found matching 'build' 12:57:13 INFO - no previously-included directories found matching 'dist' 12:57:13 INFO - no previously-included directories found matching '.git*' 12:57:13 INFO - Installing collected packages: jsonschema, functools32 12:57:13 INFO - Running setup.py install for functools32 12:57:13 INFO - warning: no files found matching '*.txt' 12:57:13 INFO - no previously-included directories found matching 'build' 12:57:13 INFO - no previously-included directories found matching 'dist' 12:57:13 INFO - no previously-included directories found matching '.git*' 12:57:13 INFO - Successfully installed jsonschema functools32 12:57:13 INFO - Cleaning up... 12:57:13 INFO - Return code: 0 12:57:13 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 12:57: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')]} 12:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57: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')]} 12:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f21e55ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, '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 0xd75250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd756e0>, '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': '32c5991c409366f7fec8a718000001d2-1453323122.434493-2042910664', '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 12:57:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 12:57:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:57:13 INFO - Using env: {'DISPLAY': ':0', 12:57:13 INFO - 'HOME': '/home/cltbld', 12:57:13 INFO - 'LANG': 'en_US.UTF-8', 12:57:13 INFO - 'LANGUAGE': 'en_US:en', 12:57:13 INFO - 'LOGNAME': 'cltbld', 12:57:13 INFO - 'MAIL': '/var/mail/cltbld', 12:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:13 INFO - 'MOZ_NO_REMOTE': '1', 12:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:13 INFO - 'NO_EM_RESTART': '1', 12:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:57:13 INFO - 'PWD': '/builds/slave/test-pgo', 12:57:13 INFO - 'SHELL': '/bin/bash', 12:57:13 INFO - 'SHLVL': '1', 12:57:13 INFO - 'TERM': 'linux', 12:57:13 INFO - 'TMOUT': '86400', 12:57:13 INFO - 'USER': 'cltbld', 12:57:13 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453323122.434493-2042910664', 12:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:13 INFO - '_': '/tools/buildbot/bin/python'} 12:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:13 INFO - Downloading/unpacking flake8 12:57:13 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 12:57:13 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 12:57:13 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 12:57:13 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 12:57:13 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 12:57:13 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 12:57:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:57:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:57:15 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 12:57:15 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 12:57:15 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 12:57:15 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 12:57:15 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 12:57:15 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 12:57:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:57:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:57:15 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 12:57:15 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 12:57:15 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 12:57:15 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 12:57:15 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 12:57:15 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 12:57:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 12:57:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:57:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:57:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:57:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:57:16 INFO - no previously-included directories found matching 'docs/_build' 12:57:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:57:16 INFO - Running setup.py install for pep8 12:57:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:57:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:57:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:57:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:57:16 INFO - no previously-included directories found matching 'docs/_build' 12:57:16 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 12:57:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:57:16 INFO - Cleaning up... 12:57:16 INFO - Return code: 0 12:57:16 INFO - Running post-action listener: _resource_record_post_action 12:57:16 INFO - Running post-action listener: _start_resource_monitoring 12:57:16 INFO - Starting resource monitoring. 12:57:16 INFO - ##### 12:57:16 INFO - ##### Running install step. 12:57:16 INFO - ##### 12:57:16 INFO - Running pre-action listener: _resource_record_pre_action 12:57:16 INFO - Running main action method: install 12:57:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:57:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:57:16 INFO - Reading from file tmpfile_stdout 12:57:16 INFO - Detecting whether we're running mozinstall >=1.0... 12:57:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:57:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:57:16 INFO - Reading from file tmpfile_stdout 12:57:16 INFO - Output received: 12:57:16 INFO - Usage: mozinstall [options] installer 12:57:16 INFO - Options: 12:57:16 INFO - -h, --help show this help message and exit 12:57:16 INFO - -d DEST, --destination=DEST 12:57:16 INFO - Directory to install application into. [default: 12:57:16 INFO - "/builds/slave/test-pgo"] 12:57:16 INFO - --app=APP Application being installed. [default: firefox] 12:57:16 INFO - mkdir: /builds/slave/test-pgo/build/application 12:57:16 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'] 12:57:16 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 12:57:31 INFO - Reading from file tmpfile_stdout 12:57:31 INFO - Output received: 12:57:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:57:31 INFO - Running post-action listener: _resource_record_post_action 12:57:31 INFO - ##### 12:57:31 INFO - ##### Running run-tests step. 12:57:31 INFO - ##### 12:57:31 INFO - Running pre-action listener: _resource_record_pre_action 12:57:31 INFO - Running main action method: run_tests 12:57:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:57:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:57:31 INFO - Python 2.7.3 12:57:31 INFO - Return code: 0 12:57:31 INFO - grabbing minidump binary from tooltool 12:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:31 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 0xd74350>, '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 0xd75250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd756e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:57:31 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 12:57:31 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 12:57:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:57:31 INFO - Return code: 0 12:57:31 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:57:31 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:57:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:57:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:57:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:57:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 12:57:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 12:57:32 INFO - Return code: 0 12:57:32 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/kPWp9zfgTqGvJD34lcTwVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 12:57:32 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/kPWp9zfgTqGvJD34lcTwVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost 12:57:32 INFO - Using env: {'DISPLAY': ':0', 12:57:32 INFO - 'HOME': '/home/cltbld', 12:57:32 INFO - 'LANG': 'en_US.UTF-8', 12:57:32 INFO - 'LANGUAGE': 'en_US:en', 12:57:32 INFO - 'LOGNAME': 'cltbld', 12:57:32 INFO - 'MAIL': '/var/mail/cltbld', 12:57:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:57:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:32 INFO - 'MOZ_NO_REMOTE': '1', 12:57:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:57:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:32 INFO - 'NO_EM_RESTART': '1', 12:57:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:57:32 INFO - 'PWD': '/builds/slave/test-pgo', 12:57:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:57:32 INFO - 'SHELL': '/bin/bash', 12:57:32 INFO - 'SHLVL': '1', 12:57:32 INFO - 'TERM': 'linux', 12:57:32 INFO - 'TMOUT': '86400', 12:57:32 INFO - 'USER': 'cltbld', 12:57:32 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453323122.434493-2042910664', 12:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:32 INFO - '_': '/tools/buildbot/bin/python'} 12:57:32 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/kPWp9zfgTqGvJD34lcTwVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] with output_timeout 3600 12:57:32 INFO - mozversion INFO | application_buildid: 20160120103210 12:57:32 INFO - mozversion INFO | application_changeset: cf7672d6635465a2ae70b7de562abc30848768ca 12:57:32 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 12:57:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:57:32 INFO - mozversion INFO | application_name: Firefox 12:57:32 INFO - mozversion INFO | application_remotingname: firefox-dev 12:57:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:57:32 INFO - mozversion INFO | application_vendor: Mozilla 12:57:32 INFO - mozversion INFO | application_version: 45.0a2 12:57:32 INFO - mozversion INFO | platform_buildid: 20160120103210 12:57:32 INFO - mozversion INFO | platform_changeset: cf7672d6635465a2ae70b7de562abc30848768ca 12:57:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:57:32 INFO - mozversion INFO | platform_version: 45.0a2 12:57:32 INFO - 2016-01-20 12:57:32,701 DEBUG : using testdate: 1453323452 12:57:32 INFO - 2016-01-20 12:57:32,701 DEBUG : actual date: 1453323452 12:57:32 INFO - 2016-01-20 12:57:32,748 INFO : starting webserver on 'localhost:36400' 12:57:32 INFO - 2016-01-20 12:57:32,749 INFO : Starting test suite talos-linux64-ix-008 12:57:32 INFO - 2016-01-20 12:57:32,750 INFO : Starting test dromaeo_css 12:57:32 INFO - 2016-01-20 12:57:32,750 DEBUG : operating with platform_type : linux_ 12:57:32 INFO - 2016-01-20 12:57:32,750 INFO : Initialising browser for dromaeo_css test... 12:57:32 INFO - 2016-01-20 12:57:32,765 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpw0i1mv/profile http://localhost:36400/getInfo.html 12:57:36 INFO - 2016-01-20 12:57:36,810 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:57:36 INFO - 2016-01-20 12:57:36,811 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:57:36 INFO - 2016-01-20 12:57:36,811 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:57:36 INFO - 2016-01-20 12:57:36,811 DEBUG : BROWSER_OUTPUT: __metrics 12:57:36 INFO - 2016-01-20 12:57:36,968 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:57:37 INFO - 2016-01-20 12:57:37,770 INFO : Browser initialized. 12:57:37 INFO - 2016-01-20 12:57:37,770 INFO : Running cycle 1/1 for dromaeo_css test... 12:57:37 INFO - 2016-01-20 12:57:37,770 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpw0i1mv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:57:49 INFO - 2016-01-20 12:57:49,595 DEBUG : BROWSER_OUTPUT: RSS: Main: 136736768 12:57:49 INFO - 2016-01-20 12:57:49,596 DEBUG : BROWSER_OUTPUT: 12:58:40 INFO - 2016-01-20 12:58:40,392 DEBUG : BROWSER_OUTPUT: 1453323520389 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] 13:00:48 INFO - 2016-01-20 13:00:48,714 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36400/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36400/tests/dromaeo/cssquery-ext.html) 13:00:49 INFO - 2016-01-20 13:00:49,670 DEBUG : BROWSER_OUTPUT: RSS: Main: 219262976 13:00:49 INFO - 2016-01-20 13:00:49,670 DEBUG : BROWSER_OUTPUT: 13:03:51 INFO - 2016-01-20 13:03:51,919 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36400/tests/dromaeo/cssquery-ext.html (next: http://localhost:36400/tests/dromaeo/cssquery-jquery.html) 13:03:52 INFO - 2016-01-20 13:03:52,481 DEBUG : BROWSER_OUTPUT: RSS: Main: 225427456 13:03:52 INFO - 2016-01-20 13:03:52,481 DEBUG : BROWSER_OUTPUT: 13:06:54 INFO - 2016-01-20 13:06:54,331 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36400/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36400/tests/dromaeo/cssquery-mootools.html) 13:06:54 INFO - 2016-01-20 13:06:54,905 DEBUG : BROWSER_OUTPUT: RSS: Main: 219951104 13:06:54 INFO - 2016-01-20 13:06:54,905 DEBUG : BROWSER_OUTPUT: 13:09:56 INFO - 2016-01-20 13:09:56,674 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36400/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36400/tests/dromaeo/cssquery-prototype.html) 13:09:57 INFO - 2016-01-20 13:09:57,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 205119488 13:09:57 INFO - 2016-01-20 13:09:57,237 DEBUG : BROWSER_OUTPUT: 13:12:59 INFO - 2016-01-20 13:12:59,566 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36400/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36400/tests/dromaeo/cssquery-yui.html) 13:13:00 INFO - 2016-01-20 13:13:00,131 DEBUG : BROWSER_OUTPUT: RSS: Main: 206827520 13:13:00 INFO - 2016-01-20 13:13:00,132 DEBUG : BROWSER_OUTPUT: 13:16:02 INFO - 2016-01-20 13:16:02,207 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36400/tests/dromaeo/cssquery-yui.html (next: http://localhost:36400/tests/dromaeo/cssquery-dojo.html) 13:16:02 INFO - 2016-01-20 13:16:02,457 DEBUG : BROWSER_OUTPUT: RSS: Main: 240250880 13:16:02 INFO - 2016-01-20 13:16:02,458 DEBUG : BROWSER_OUTPUT: 13:16:02 INFO - 2016-01-20 13:16:02,459 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:16:02 INFO - 2016-01-20 13:16:02,459 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:16:02 INFO - 2016-01-20 13:16:02,459 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:16:02 INFO - 2016-01-20 13:16:02,459 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:16:02 INFO - 2016-01-20 13:16:02,459 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3286.622038465576;3331.6002079750433;3362.5292459055736;3367.2760356523345;3394.5756780402457;5408.891822163554;5444.754986025629;5492.423295553965;5493.066178749617;5501.0648189807725;5444.047291723942;5471.917921231185;5512.614117011811;5514.448555144493;5518.2826232589705;4874.2444921037295;4994.750262486861;5000.374953130859;5059.367579052619;5087.949120508784;5008.649394542384;5074.340335756347;5091.618128640348;5092.745362731867;5096.108181068316;4911.729854857981;4976.178930476467;5021.322121513585;5038.672486288379;5045.571126454256;4946.9752651236695;5038.974805125969;5076.873078173076;5078.568321692661;5081.771320290559;4789.928151077736;4893.486183950669;4921.335619691367;4922.384701912261;5032.924506132411;5148.665336753136;5208.583313334924;5219.530242278175;5271.86820329491;5347.59893008022;5828.679422631753;5854.736536855852;5864.354920958691;5866.76532938682;5889.528837692974;5882.911756323659;5911.083782013752;5912.970435147839;5913.408659134096;5920.585559010871;5342.412334643186;5437.157240627709;5510.035743744828;5516.9448305516435;5553.444655534414;5917.31950825652;5946.583739138218;5948.613340132878;5955;5983.132445795335;5602.831915042555;5727.05503591911;5731.828045158569;5738.225339579187;5741.024025915604;5723.7424315905055;5792.507636850914;5809.2738407699035;5821.7380217890295;5839.036558967808;5844.766209351664;5883.235179426732;5884.705764711747;5898.233229680114;5900.380460051719;5703.74333155009;5841.7371218295275;5890.440408161217;5891.175235467038;5897.734601942923;4384.298512238027;4448.043670610769;4456.153330867125;4479.641628669699;4498.302763071729;4112.506499220112;4113.321301985199;4117.75293482392;4139.3583994480905;4166.7708276045105;5420.322459692538;5511.724413779295;5699.316082070178;5700.515456186187;5715.628484148517;5756.107803290497;5837.591368604157;5864;5875.41245875409;5903.6457812530525;5594.104943209067;5594.216809646653;5594.412586678422;5599.272094627754;5617.38208797032;4975.527324904128;5078.974605127025;5091.847244582668;5156.046131465616;5166.81916132941;6068.969655151696;6070.423309785563;6072.180255665428;6102.938970610237;6103.725332360054;5892.469677729025;5896.262967129109;5899.321578018583;5907.202527658711;5912.201852749996;5742.397048309867;5797.420257974169;5974.790882319098;6032.939670603238;6091.299500557493;5705.686187259741;5708.771649133988;5718.742656580547;5718.914216286842;5802.448767367094;5685.090385538294;5722.284714410699;5749.252597162342;5753.8561535961935;5802.970985145047;5568.359638641608;5643.209950607001;5693.174489699053;5749.13762935563;5783.8554036149435;5643.717814109196;5647.943520564741;5656.37779844225;5665;5774.740136693775;5357.892842143213;5513.862153446196;5527.447255274601;5528.889422211614;5545.694986775766;5476.151196564539;5611.438856114356;5619.269494965628;5620.353659329229;5680.744366503434;5639.295088113986;5711.314642242957;5731;5756.251687280626;5756.453136951983 13:16:02 INFO - 2016-01-20 13:16:02,461 DEBUG : BROWSER_OUTPUT: |1;ext.html;608.9543284253681;619.7366119399255;622.9968850155755;625.9061140828875;630.9842253943651;39662.40506392403;40611.79694101525;40643.59356406439;40687.59312406875;40780.59219407805;44981.55018449815;45326.7733661332;45533.544664553345;45579.54420455803;45588.088238235214;7733.574653394061;7848.293653571178;9045.321600879928;9216.49309287989;10325.380477171357;10458.215633827454;10508.422036787973;10561.471926403687;10575.629852955148;10585.259031867772;10828.620998265062;10921.235513514057;10925.562977480931;10934.890651093507;10936.343819370823;8111.878321825177;8305.46014509055;10769.83845242322;11046.613368532062;11066.059384952288;10526.263161578692;10646.520906559223;10649.361038337725;10653.84019239712;10654.307470014424;41854.37218441726;42527.787361063;42557.36163957543;42589.36115958263;42704.35943460851;3760.1163726524246;3810.3522401191585;3816.179521402884;4015.4980627421573;4362.04035112278;31982;32260.83869580637;32281.51577726336;32295.192620184447;33514;3651.1602331463646;3660.3666349255454;3729.645683660048;3769.604191559874;3933.9213215735813;288280;291410;291850.54074729705;291976;292697;65725.67137164283;65891.67054164699;66004.66997665077;66181.6690916552;66224;68434.65782671055;69685;69821;69880.65059674771;70011.64994175099;16373.836261637469;16715.832841671672;16745.665086698442;16762.74855877163;16773.496795096165;12694.87305126937;12713.93643031779;12723.23660580368;12754.936225318814;12933.805992910115;20940.79059209419;21719.58822676521;21749.238776642742;21773.673394899088;21784.78215217859;8088.676452941934;8493.320534357237;8500.65997360111;8566.61450234741;8571.4000019998;1029.799189158107;1123.5225029362489;1136.9772604547863;1141.9771604567861;1144.7367105565766;29415.558766618517;30048.24879378033;30489.69510304913;30661.540076898866;30933.690663093083;1152.567787079845;1175.61204802415;1184.3308530680138;1224.6570960131178;1246.2273390497949;13303.201807891364;15441.845581544265;15465.458708945132;15773.29020194094;16064;271549;271718;271963;273442;274537;50101.49898501041;50890.236646450336;50912;51058;51105.48894511082;1269.1116218646985;1375.9931200343933;1448.2613866927943;1476.0405736271296;1483.970320593582;30446;30602.234944126576;30708.539371909887;31557.684423155475;31942.361152777277;40281.59718402896;49068.263976041104;50161.74919125381;50189.24716129334;50232.49767502278;214112;216698;216809;216941;283026;33199.33601328008;33872.15319617029;33998.83000584981;33999;34028.82985585056;45778.31332529948;46375.76812116053;46730.29904551367;46817.76591117022;47317.526824731314;38687.226255475296;39027.219455611295;39324;44597.77701111474;45106.77446612877;41008.79495602503;41759.58240417557;41763.450106741264;42043.57956420397;42200.78899605482;40051.399229011;40312.39531406973;44659.553404465536;44975.775121124185;45577;32271;34024.010848755424;34148.82925585356;34412.655873441945;34526.654733453346;26331.736682632927;26713.19860404191;26787.866060670352;26864;26910.461790763682 13:16:02 INFO - 2016-01-20 13:16:02,462 DEBUG : BROWSER_OUTPUT: |2;jquery.html;386.1601017786316;388.4852570344294;393.3922090370378;394.9348357521009;398.37256321293967;14211.218382988958;14417.78373324401;16554.255058522365;17506.824931750678;17517.124143792793;12872.935635321834;16764.748528772077;17042.062686552235;17159.82840171598;17167;5034.496550344973;5666.54667626591;5701.629394089392;5723.198752174699;5835.212246346731;3944.7633142011427;4030.2745505808944;5670.177824215486;5783;5809.448102430262;5740.425957404268;5782.739776710037;5783.10361893905;5796.594238403313;5804.506616937565;5754.942450575482;5889.734961926723;6240.188775459206;6259.436650701413;6270.310265870728;5571.944280557183;5592.636478628917;5596.468335508161;5597.384287728347;5604.915926261109;20721;21120.04959776814;21313.57372852534;21474;21540.892295538422;2199.065397206181;2219.422950033003;2222.122261706617;2236.7651396603287;2347.2371479269136;9875.950620246853;9961.40231586107;10156.492175391275;10267.640632577824;11609.303441793434;1789.5078853315313;1841.9723704144449;1852.3887117251409;1940.6991916253003;1965.282671824788;65556;66804.3319566803;68570.65714671394;69201;69759;10395.84406233907;10742.140628749681;10773.51519181623;10778.083862871743;10852.186086043579;13670.316484175752;13718.314084295745;13778.724425511433;13779.586612401645;13809.930950345184;7710.151883292833;7722.7297044603165;7737.187595302525;7741.8451630967065;7755.1469338372735;7331.523450975669;7355.301246381692;7392.186859445456;7393.297636724503;7401.296876796696;4750.12122757291;4784.736839473792;4786.832460863922;4799;4818.590419814285;1751.9690650147759;1806.1150036482293;1877.934272300463;1916.5400303927236;1950.7073938908993;899.8290324838259;979.4710856137748;1022.3405903192399;1042.0933787604831;1110.9611163609397;16083;16235.837641623433;16347.509574712778;16427.35482848774;16604.916975415046;877.1929824561419;967.1730670276953;1000.2098342309639;1001.290066488045;1005.7636455432968;9409.482478463613;9546.61813527465;9672;9690.854637180448;9884.406935583887;649229;659345;661649;667811;669696;88851;90425.54787226021;90616.54691726631;90944;92001;1244.9066320025854;1245.489349366737;1274.413769665964;1287.0861688201294;1310.6330227536305;16040.117793521002;16136.919315403347;16151.515454536382;16153.353865845706;16343.918280408521;39148.41277380899;39721.40417893792;39756.2048759029;39927.600723992386;40098.198036038535;50532.24201637052;51538.48461515337;54364.18453723118;54664.726676366365;56788.71605641946;9497.525123743924;9643.469609171283;9739.464329461664;9785.266105042008;9868.259880508847;11217.046551043253;11319.717007074889;15558.533244002245;17344.82655173432;17457;14313.785293220402;15140.394384224508;15172.696546068795;15386.692266154838;15431.922840385727;3179.713825755693;8079.87880181786;11243.494042767932;14870.107793532423;15155.621109472351;15558.75529957578;15980.920095399448;16120.032798032156;16142.919285403497;16504.25730842091;9572.473513956798;9765.707028789147;9989.850152247867;10298.794024119326;10325.483725813829;15161.620959476102;15408.460703875311;15473;15521;15668.843311567194 13:16:02 INFO - 2016-01-20 13:16:02,463 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1396.2460271453415;1539.3226980128745;1594.7926769519956;1777.351266787622;1873.5878106816497;7403.185649578542;8073.475224110429;8278.95860520698;8283.875741863862;8287.751367458979;8144.307733842616;8320.126386729396;8334.958325208365;8336.833263334729;8338.874916876237;2050.7436570428695;2084.5414008918087;2085.4369320283513;2293.908243670255;2346.272655476808;2190.3538456155393;2230.7769223077644;2233.9947023839254;2236.4856083100817;2238.3620668109593;2309.214866945238;2323.5469083528633;2374.465745207332;2376.192094687806;2377.4175327044813;2290.1640901071073;2298.5058212484314;2321.6749655048307;2382.309130352196;2386.916457923982;2356.2813341930705;2376.385975427034;2392.509535545209;2397.8920948557356;2420.7337192908767;8228.42401031928;8320.791980200484;8328.791780205484;8345.082040975487;8357.540335281557;4682.976585117052;4766.904661906742;4773.355596994396;4774.427068751772;4789.784459699322;2832.2352964699417;2935.486289899259;2956.39393924245;2991.880324787006;3003.6395632524236;889.9065598112235;896.3008853094597;903.4985583001431;936.9578368973345;966.0870477398861;11417.086633069335;11420.657380278604;11443.370614616193;11445.599404020819;11453.54185832574;4212;4240;4280.315149576115;4284.91430171401;4301.354796780508;9861.605535778488;9864.65473708431;9865.605375785031;9867.210623150275;9887.703368898945;4857.6599638025;4892.608591312686;4897.853064408074;4898.779554920037;4901.460839307673;4451.933221001687;4464.799084041226;4472.932906006413;4473.977630111829;4482.417285752831;3437.8968630941113;3476.7392445566684;3558.6619271169197;3748.1379282765115;3831.444440556104;1132.3828513460185;1139.4587570903755;1140.1448913315014;1150.3558007515817;1154.1978325064;1118.2060736876908;1119.3060302612269;1170.473287020844;1326.1512631915389;1401.8738313551626;7294.671739771723;7337.88993165103;7382.22486638906;7457.142428620669;7466;1132.1282612388416;1140.2531341970857;1141.537677240719;1152.181950814914;1160.4487868262509;5937.7921772737745;5966.791162309299;5986.670733109634;5990.940090599038;6008.459238668541;9515.096065873731;9869.753256168653;10006.949965250273;10035.749106272255;10045.296829221885;9724.076212759777;9760;9836.409815411098;9865.161461275871;9936.403815771077;7633.618319084024;7769.223077692299;7774.6890124394395;7885.250901164495;7895;7347.8163045924275;7421.666025028779;7436.070491188601;7459.701611935462;7465.253474652492;8589.184027517376;8699.347548933729;8735.1701588349;8945.73162805117;8978.595963181542;8788.516631585324;8865.512396818236;8902.154295341932;9095.636174552943;9582.856257156009;7442.962785186256;7464.514806537558;7485.925140748523;7502.549847009197;7530.171681115183;7272.163701174432;7297;7517.361024312994;7524.510906791041;8120.187981201832;7550;7619.466637335333;7644.388448923962;7660.119086304923;7698.461107722405;7509.699612015458;7541.849163016818;7559.584222867795;7599.962000189964;7639.885401718868;7312.232215617496;7510.737124200627;7511.586862722603;7514.62426878643;7520.774376768706;6869.862602748017;6881.965590172017;6897.586144831326;6921.2386637470845;6924.480663950325;6779.6271205084195;6799.354061364163;7023.929760702532;7031.226565077735;7032.1912980007955 13:16:02 INFO - 2016-01-20 13:16:02,463 DEBUG : BROWSER_OUTPUT: |4;prototype.html;361.9294237623663;362.12004828267305;365.37885594489376;370.33339988021555;374.19361276449246;6021.608595441298;6024.066269728188;6028.698565071745;6071.78748743794;6118.051701986188;5733.827985160452;5852.356240813507;5870.677112758807;6010.429009244115;6035.641980554384;4673.228917228653;4692.343071969927;4705.764711764416;4706.317583950326;4707.788149533262;4705.952940470585;4714.669973101884;4715.41057367829;4718.339432479455;4724.574788269055;4430.091831174602;4493.7977790999485;4560.2019646561885;4633.328167415722;4704.082703872747;4609.124266389375;4638.652101092432;4655.604273636745;4666.160091183586;4689.226277664181;4171.791410429497;4172.228137794487;4173.144505376391;4173.165366926627;4193.5387107418155;5688.146777983295;5751.539876809845;5773.624714393551;5789.305283365981;5799.884002319972;5423.810166644149;5484.177373393983;5486.341639003305;5487.368952570466;5487.972560137214;6353.5870168438905;6391.424771770517;6397.712102955378;6400.4559612432995;6409.647469389181;4611.608013318872;4613.584777370019;4615.376924115235;4620.283856002325;4626.727649896272;6522.902156467657;6652.434543063845;6671.833204169886;6675.899861502081;6686.899696504508;4743.407074115736;4766.046790641885;4766.785494652749;4771.498992605796;4776.068666610047;4827.565519103297;4834.105690447279;4834.178189707758;4836.177849765549;4841.298011788342;5465.07093794056;5465.453454654582;5467.07059799827;5478.45215478457;5479.123340265618;6357.11000459936;6411;6450.838729031718;6467;6470.6441145737435;1665.3088968078112;1693.3395975569538;1694.2718427204184;1694.466243133409;1695.6608678264397;1171.6426489920486;1171.9531218751154;1176.2413243457922;1189.893399138792;1199.7420554580808;6184.103305020747;6190.535709821781;6190.628562286277;6192.938070619236;6196.442320191204;6632.502562307846;6662.6668666566475;6666.533342666064;6666.933330666729;6667.533272670964;6136.78521251763;6189;6260.812175634738;6317.96841015792;6364.64994425311;3597.4963505109304;3614.8192590370377;3622.4385220290897;3626.6192049834385;3628.129248980226;6891.069705589681;6893.069435626227;6893.276205998398;6899.275576064541;6903.861922761516;6718.49611279156;6852.965735171392;6865.588064716033;6866.793996180123;6867.759628412981;6854.074699915547;6877.65611719412;6879.484038697117;6886.8622627548175;6889.104416425833;6619.018487294817;6700.128983232149;6708.362705542965;6711.530192886451;6721.22705888829;6588.472922166311;6592.505562082959;6593.736250549924;6600.636964966973;6608.900866487103;6870.038194652852;6871.072405225231;6880.380765731108;6881.93118068833;6890.8621827562165;4789.784459699392;4791.5687588117235;4793.209120495079;4794.520547945178;4801.303810947463;6562.081308616893;6617.966910165418;6687.765928192684;6693.665316734241;6697.464202863662;6523.543351965317;6524.608523488606;6540.50946179048;6544.44372228366;6549.345065493412;6425.132607098169;6518.348165183444;6524.543281970216;6530.67346632676;6534.738610455529;6392.52056095804;6408.423241908251;6411.679416029273;6411.711472983634;6415.582987105823;6536.640484773383;6543.051257567531;6543.967280163569;6544.411003009752;6545.21457425112;6252.9374706254175;6392.0731493934045;6397.616143031433;6402.647854368054;6411.262704789009 13:16:02 INFO - 2016-01-20 13:16:02,465 DEBUG : BROWSER_OUTPUT: |5;yui.html;739.6745432009915;783.8790529542754;813.085279061056;827.3174630929481;834.4617721569584;14025.719485610281;14361.784573231409;14395.568132956016;14412.855871441283;14436.855631443683;13799.448022079105;13849.376778044987;13872;13953.930230348835;13970.091944023632;731.228553875661;748.5396481164099;890.0698769785589;907.2288554728461;910.1671970147307;911.1571796088591;911.4075850697034;914.634146341462;917.5228880981886;919.8942121656029;764.1136281912982;785.3206975965805;941.6233506597382;946.1201082992814;948.7011591348703;932.1983094538691;954.2842867849148;954.8376775948105;957.760559860028;957.8084383123369;707.3209718670083;708.4049398505281;708.6881772020346;708.7483943200193;709.283623540223;13483.730325393535;14010.439582416691;14052.086614370033;14086.436542538286;14136.151830890076;13302.600921972356;13848.58454246364;13877.167369957835;13892;13922.930385348009;9845.409275443497;9933.850992235122;9969.152622027137;10090.445025523666;10126;3563.572371315433;3611.530501034849;3615.2950174715943;3617.5297211362617;3638.2905333459985;47589.28616070762;47898.99999999965;48144.759276203746;48392.51607483951;48540.27189592159;10014.79970400588;10028.348157369748;10173;10180.643677471253;10357.119644830274;19155.521111972033;19177.520561985784;19193.616127677367;19194;19207.711884321747;7482.6632801524065;7492.213317601573;7535.962320188473;7558.168601453835;7668.846623067619;3953.090789118519;4212.53662097169;4238.915221695549;4254.510731265882;4311.245532031882;3123.4846250368887;3143.182772479126;3149.401613693391;3149.811011339327;3150.102220867088;542.5713686187868;567.7473524281655;567.8835838653149;575.5740751843689;584.0829897061573;550.0676353580642;647.252423450915;661.7353058776432;665.5806841689802;699.7096205074939;8024.839503209903;8417.326613870999;8463.576821158917;8767.254783343487;8777.605007774539;545.2475583694555;615.1940957345892;656.8456412743002;674.9088873002082;696.1055044268193;3962.603739626072;4046.4537287466405;4092.324766413568;4126.711130220856;4226.978865105655;59572;60434.697826510586;60555.394446054976;60584;60611.69694151501;54413.37486313628;56026.71986640041;56617;56751;56910.7154464225;48407;48462.5153748465;48595.5140448591;49165.26252106221;49290.260646091054;8440.535770532433;8496.362772791941;8753.562321883754;9698.127168554864;9702.126808587262;38105.237895241386;38156;39396.21207575775;39507.209855802146;39642.80178599089;47448.525514745794;48712.75643621759;48874.266885996025;49025;49587.752061239466;11342.262752921033;11861.229020113666;11963.222390544586;12091.334976576372;12190.817137743119;13120.868791311965;13312.800307995194;13571.1857288563;13759.449622015007;13982.720345593234;11754.412279386168;12063.75872482563;12165.756684866075;12256.38718064111;12697.238165710087;12479.93760031194;12494.37528123572;12828.743425131632;12851.935740321238;12995.28525931083;11370.43147842588;11476.885231147915;11596;12215;12737.808932866199;9459.527023648652;9621.18219951284;9700.272479564203;9885.357451765612;9970.30207885441;9261.53692315395;9450.338476306593;10831.783364332827;10835.295705779099;10882.40146791934 13:16:02 INFO - 2016-01-20 13:16:02,465 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:16:02 INFO - 2016-01-20 13:16:02,465 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:16:02 INFO - 2016-01-20 13:16:02,465 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,676 13:16:02 INFO - 2016-01-20 13:16:02,465 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:16:02 INFO - 2016-01-20 13:16:02,465 DEBUG : BROWSER_OUTPUT: __startTimestamp1453324562458__endTimestamp 13:16:02 INFO - 2016-01-20 13:16:02,465 DEBUG : BROWSER_OUTPUT: 13:16:02 INFO - 2016-01-20 13:16:02,465 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:16:02 INFO - 2016-01-20 13:16:02,466 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:16:02 INFO - 2016-01-20 13:16:02,466 DEBUG : BROWSER_OUTPUT: 13:16:02 INFO - 2016-01-20 13:16:02,466 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5433.45 Median:5620.35 stddev:578.89 (10.3%) stddev-sans-first:555.63 13:16:02 INFO - 2016-01-20 13:16:02,466 DEBUG : BROWSER_OUTPUT: Values: 3286.6 3331.6 3362.5 3367.3 3394.6 5408.9 5444.8 5492.4 5493.1 5501.1 5444.0 5471.9 5512.6 5514.4 5518.3 4874.2 4994.8 5000.4 5059.4 5087.9 5008.6 5074.3 5091.6 5092.7 5096.1 4911.7 4976.2 5021.3 5038.7 5045.6 4947.0 5039.0 5076.9 5078.6 5081.8 4789.9 4893.5 4921.3 4922.4 5032.9 5148.7 5208.6 5219.5 5271.9 5347.6 5828.7 5854.7 5864.4 5866.8 5889.5 5882.9 5911.1 5913.0 5913.4 5920.6 5342.4 5437.2 5510.0 5516.9 5553.4 5917.3 5946.6 5948.6 5955.0 5983.1 5602.8 5727.1 5731.8 5738.2 5741.0 5723.7 5792.5 5809.3 5821.7 5839.0 5844.8 5883.2 5884.7 5898.2 5900.4 5703.7 5841.7 5890.4 5891.2 5897.7 4384.3 4448.0 4456.2 4479.6 4498.3 4112.5 4113.3 4117.8 4139.4 4166.8 5420.3 5511.7 5699.3 5700.5 5715.6 5756.1 5837.6 5864.0 5875.4 5903.6 5594.1 5594.2 5594.4 5599.3 5617.4 4975.5 5079.0 5091.8 5156.0 5166.8 6069.0 6070.4 6072.2 6102.9 6103.7 5892.5 5896.3 5899.3 5907.2 5912.2 5742.4 5797.4 5974.8 6032.9 6091.3 5705.7 5708.8 5718.7 5718.9 5802.4 5685.1 5722.3 5749.3 5753.9 5803.0 5568.4 5643.2 5693.2 5749.1 5783.9 5643.7 5647.9 5656.4 5665.0 5774.7 5357.9 5513.9 5527.4 5528.9 5545.7 5476.2 5611.4 5619.3 5620.4 5680.7 5639.3 5711.3 5731.0 5756.3 5756.5 13:16:02 INFO - 2016-01-20 13:16:02,466 DEBUG : BROWSER_OUTPUT: 13:16:02 INFO - 2016-01-20 13:16:02,466 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45962.98 Median:33693.08 stddev:69174.89 (205.3%) stddev-sans-first:69285.12 13:16:02 INFO - 2016-01-20 13:16:02,467 DEBUG : BROWSER_OUTPUT: Values: 609.0 619.7 623.0 625.9 631.0 39662.4 40611.8 40643.6 40687.6 40780.6 44981.6 45326.8 45533.5 45579.5 45588.1 7733.6 7848.3 9045.3 9216.5 10325.4 10458.2 10508.4 10561.5 10575.6 10585.3 10828.6 10921.2 10925.6 10934.9 10936.3 8111.9 8305.5 10769.8 11046.6 11066.1 10526.3 10646.5 10649.4 10653.8 10654.3 41854.4 42527.8 42557.4 42589.4 42704.4 3760.1 3810.4 3816.2 4015.5 4362.0 31982.0 32260.8 32281.5 32295.2 33514.0 3651.2 3660.4 3729.6 3769.6 3933.9 288280.0 291410.0 291850.5 291976.0 292697.0 65725.7 65891.7 66004.7 66181.7 66224.0 68434.7 69685.0 69821.0 69880.7 70011.6 16373.8 16715.8 16745.7 16762.7 16773.5 12694.9 12713.9 12723.2 12754.9 12933.8 20940.8 21719.6 21749.2 21773.7 21784.8 8088.7 8493.3 8500.7 8566.6 8571.4 1029.8 1123.5 1137.0 1142.0 1144.7 29415.6 30048.2 30489.7 30661.5 30933.7 1152.6 1175.6 1184.3 1224.7 1246.2 13303.2 15441.8 15465.5 15773.3 16064.0 271549.0 271718.0 271963.0 273442.0 274537.0 50101.5 50890.2 50912.0 51058.0 51105.5 1269.1 1376.0 1448.3 1476.0 1484.0 30446.0 30602.2 30708.5 31557.7 31942.4 40281.6 49068.3 50161.7 50189.2 50232.5 214112.0 216698.0 216809.0 216941.0 283026.0 33199.3 33872.2 33998.8 33999.0 34028.8 45778.3 46375.8 46730.3 46817.8 47317.5 38687.2 39027.2 39324.0 44597.8 45106.8 41008.8 41759.6 41763.5 42043.6 42200.8 40051.4 40312.4 44659.6 44975.8 45577.0 32271.0 34024.0 34148.8 34412.7 34526.7 26331.7 26713.2 26787.9 26864.0 26910.5 13:16:02 INFO - 2016-01-20 13:16:02,468 DEBUG : BROWSER_OUTPUT: 13:16:02 INFO - 2016-01-20 13:16:02,468 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:33134.94 Median:387.32 stddev:108190.05 (27932.8%) stddev-sans-first:108465.61 13:16:02 INFO - 2016-01-20 13:16:02,469 DEBUG : BROWSER_OUTPUT: Values: 386.2 388.5 393.4 394.9 398.4 14211.2 14417.8 16554.3 17506.8 17517.1 12872.9 16764.7 17042.1 17159.8 17167.0 5034.5 5666.5 5701.6 5723.2 5835.2 3944.8 4030.3 5670.2 5783.0 5809.4 5740.4 5782.7 5783.1 5796.6 5804.5 5754.9 5889.7 6240.2 6259.4 6270.3 5571.9 5592.6 5596.5 5597.4 5604.9 20721.0 21120.0 21313.6 21474.0 21540.9 2199.1 2219.4 2222.1 2236.8 2347.2 9876.0 9961.4 10156.5 10267.6 11609.3 1789.5 1842.0 1852.4 1940.7 1965.3 65556.0 66804.3 68570.7 69201.0 69759.0 10395.8 10742.1 10773.5 10778.1 10852.2 13670.3 13718.3 13778.7 13779.6 13809.9 7710.2 7722.7 7737.2 7741.8 7755.1 7331.5 7355.3 7392.2 7393.3 7401.3 4750.1 4784.7 4786.8 4799.0 4818.6 1752.0 1806.1 1877.9 1916.5 1950.7 899.8 979.5 1022.3 1042.1 1111.0 16083.0 16235.8 16347.5 16427.4 16604.9 877.2 967.2 1000.2 1001.3 1005.8 9409.5 9546.6 9672.0 9690.9 9884.4 649229.0 659345.0 661649.0 667811.0 669696.0 88851.0 90425.5 90616.5 90944.0 92001.0 1244.9 1245.5 1274.4 1287.1 1310.6 16040.1 16136.9 16151.5 16153.4 16343.9 39148.4 39721.4 39756.2 39927.6 40098.2 50532.2 51538.5 54364.2 54664.7 56788.7 9497.5 9643.5 9739.5 9785.3 9868.3 11217.0 11319.7 15558.5 17344.8 17457.0 14313.8 15140.4 15172.7 15386.7 15431.9 3179.7 8079.9 11243.5 14870.1 15155.6 15558.8 15980.9 16120.0 16142.9 16504.3 9572.5 9765.7 9989.9 10298.8 10325.5 15161.6 15408.5 15473.0 15521.0 15668.8 13:16:02 INFO - 2016-01-20 13:16:02,469 DEBUG : BROWSER_OUTPUT: 13:16:02 INFO - 2016-01-20 13:16:02,470 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5726.21 Median:6875.91 stddev:3042.94 (44.3%) stddev-sans-first:3034.07 13:16:02 INFO - 2016-01-20 13:16:02,470 DEBUG : BROWSER_OUTPUT: Values: 1396.2 1539.3 1594.8 1777.4 1873.6 7403.2 8073.5 8279.0 8283.9 8287.8 8144.3 8320.1 8335.0 8336.8 8338.9 2050.7 2084.5 2085.4 2293.9 2346.3 2190.4 2230.8 2234.0 2236.5 2238.4 2309.2 2323.5 2374.5 2376.2 2377.4 2290.2 2298.5 2321.7 2382.3 2386.9 2356.3 2376.4 2392.5 2397.9 2420.7 8228.4 8320.8 8328.8 8345.1 8357.5 4683.0 4766.9 4773.4 4774.4 4789.8 2832.2 2935.5 2956.4 2991.9 3003.6 889.9 896.3 903.5 937.0 966.1 11417.1 11420.7 11443.4 11445.6 11453.5 4212.0 4240.0 4280.3 4284.9 4301.4 9861.6 9864.7 9865.6 9867.2 9887.7 4857.7 4892.6 4897.9 4898.8 4901.5 4451.9 4464.8 4472.9 4474.0 4482.4 3437.9 3476.7 3558.7 3748.1 3831.4 1132.4 1139.5 1140.1 1150.4 1154.2 1118.2 1119.3 1170.5 1326.2 1401.9 7294.7 7337.9 7382.2 7457.1 7466.0 1132.1 1140.3 1141.5 1152.2 1160.4 5937.8 5966.8 5986.7 5990.9 6008.5 9515.1 9869.8 10006.9 10035.7 10045.3 9724.1 9760.0 9836.4 9865.2 9936.4 7633.6 7769.2 7774.7 7885.3 7895.0 7347.8 7421.7 7436.1 7459.7 7465.3 8589.2 8699.3 8735.2 8945.7 8978.6 8788.5 8865.5 8902.2 9095.6 9582.9 7443.0 7464.5 7485.9 7502.5 7530.2 7272.2 7297.0 7517.4 7524.5 8120.2 7550.0 7619.5 7644.4 7660.1 7698.5 7509.7 7541.8 7559.6 7600.0 7639.9 7312.2 7510.7 7511.6 7514.6 7520.8 6869.9 6882.0 6897.6 6921.2 6924.5 6779.6 6799.4 7023.9 7031.2 7032.2 13:16:02 INFO - 2016-01-20 13:16:02,470 DEBUG : BROWSER_OUTPUT: 13:16:02 INFO - 2016-01-20 13:16:02,470 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5435.87 Median:6160.44 stddev:1602.75 (26.0%) stddev-sans-first:1561.34 13:16:02 INFO - 2016-01-20 13:16:02,470 DEBUG : BROWSER_OUTPUT: Values: 361.9 362.1 365.4 370.3 374.2 6021.6 6024.1 6028.7 6071.8 6118.1 5733.8 5852.4 5870.7 6010.4 6035.6 4673.2 4692.3 4705.8 4706.3 4707.8 4706.0 4714.7 4715.4 4718.3 4724.6 4430.1 4493.8 4560.2 4633.3 4704.1 4609.1 4638.7 4655.6 4666.2 4689.2 4171.8 4172.2 4173.1 4173.2 4193.5 5688.1 5751.5 5773.6 5789.3 5799.9 5423.8 5484.2 5486.3 5487.4 5488.0 6353.6 6391.4 6397.7 6400.5 6409.6 4611.6 4613.6 4615.4 4620.3 4626.7 6522.9 6652.4 6671.8 6675.9 6686.9 4743.4 4766.0 4766.8 4771.5 4776.1 4827.6 4834.1 4834.2 4836.2 4841.3 5465.1 5465.5 5467.1 5478.5 5479.1 6357.1 6411.0 6450.8 6467.0 6470.6 1665.3 1693.3 1694.3 1694.5 1695.7 1171.6 1172.0 1176.2 1189.9 1199.7 6184.1 6190.5 6190.6 6192.9 6196.4 6632.5 6662.7 6666.5 6666.9 6667.5 6136.8 6189.0 6260.8 6318.0 6364.6 3597.5 3614.8 3622.4 3626.6 3628.1 6891.1 6893.1 6893.3 6899.3 6903.9 6718.5 6853.0 6865.6 6866.8 6867.8 6854.1 6877.7 6879.5 6886.9 6889.1 6619.0 6700.1 6708.4 6711.5 6721.2 6588.5 6592.5 6593.7 6600.6 6608.9 6870.0 6871.1 6880.4 6881.9 6890.9 4789.8 4791.6 4793.2 4794.5 4801.3 6562.1 6618.0 6687.8 6693.7 6697.5 6523.5 6524.6 6540.5 6544.4 6549.3 6425.1 6518.3 6524.5 6530.7 6534.7 6392.5 6408.4 6411.7 6411.7 6415.6 6536.6 6543.1 6544.0 6544.4 6545.2 6252.9 6392.1 6397.6 6402.6 6411.3 13:16:02 INFO - 2016-01-20 13:16:02,470 DEBUG : BROWSER_OUTPUT: 13:16:02 INFO - 2016-01-20 13:16:02,470 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14599.98 Median:48434.76 stddev:16974.30 (35.0%) stddev-sans-first:16990.01 13:16:02 INFO - 2016-01-20 13:16:02,470 DEBUG : BROWSER_OUTPUT: Values: 739.7 783.9 813.1 827.3 834.5 14025.7 14361.8 14395.6 14412.9 14436.9 13799.4 13849.4 13872.0 13953.9 13970.1 731.2 748.5 890.1 907.2 910.2 911.2 911.4 914.6 917.5 919.9 764.1 785.3 941.6 946.1 948.7 932.2 954.3 954.8 957.8 957.8 707.3 708.4 708.7 708.7 709.3 13483.7 14010.4 14052.1 14086.4 14136.2 13302.6 13848.6 13877.2 13892.0 13922.9 9845.4 9933.9 9969.2 10090.4 10126.0 3563.6 3611.5 3615.3 3617.5 3638.3 47589.3 47899.0 48144.8 48392.5 48540.3 10014.8 10028.3 10173.0 10180.6 10357.1 19155.5 19177.5 19193.6 19194.0 19207.7 7482.7 7492.2 7536.0 7558.2 7668.8 3953.1 4212.5 4238.9 4254.5 4311.2 3123.5 3143.2 3149.4 3149.8 3150.1 542.6 567.7 567.9 575.6 584.1 550.1 647.3 661.7 665.6 699.7 8024.8 8417.3 8463.6 8767.3 8777.6 545.2 615.2 656.8 674.9 696.1 3962.6 4046.5 4092.3 4126.7 4227.0 59572.0 60434.7 60555.4 60584.0 60611.7 54413.4 56026.7 56617.0 56751.0 56910.7 48407.0 48462.5 48595.5 49165.3 49290.3 8440.5 8496.4 8753.6 9698.1 9702.1 38105.2 38156.0 39396.2 39507.2 39642.8 47448.5 48712.8 48874.3 49025.0 49587.8 11342.3 11861.2 11963.2 12091.3 12190.8 13120.9 13312.8 13571.2 13759.4 13982.7 11754.4 12063.8 12165.8 12256.4 12697.2 12479.9 12494.4 12828.7 12851.9 12995.3 11370.4 11476.9 11596.0 12215.0 12737.8 9459.5 9621.2 9700.3 9885.4 9970.3 9261.5 9450.3 10831.8 10835.3 10882.4 13:16:02 INFO - 2016-01-20 13:16:02,471 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:16:02 INFO - 2016-01-20 13:16:02,471 DEBUG : BROWSER_OUTPUT: 13:16:03 INFO - 2016-01-20 13:16:03,132 INFO : Browser exited with error code: 0 13:16:03 INFO - 2016-01-20 13:16:03,151 INFO : Completed test dromaeo_css (00:18:30) 13:16:03 INFO - 2016-01-20 13:16:03,151 INFO : Starting test kraken 13:16:03 INFO - 2016-01-20 13:16:03,151 DEBUG : operating with platform_type : linux_ 13:16:03 INFO - 2016-01-20 13:16:03,151 INFO : Initialising browser for kraken test... 13:16:03 INFO - 2016-01-20 13:16:03,157 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRtsQc8/profile http://localhost:36400/getInfo.html 13:16:06 INFO - 2016-01-20 13:16:06,832 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:16:06 INFO - 2016-01-20 13:16:06,832 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:16:06 INFO - 2016-01-20 13:16:06,832 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:16:06 INFO - 2016-01-20 13:16:06,832 DEBUG : BROWSER_OUTPUT: __metrics 13:16:06 INFO - 2016-01-20 13:16:06,973 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:16:08 INFO - 2016-01-20 13:16:08,028 INFO : Browser initialized. 13:16:08 INFO - 2016-01-20 13:16:08,029 INFO : Running cycle 1/1 for kraken test... 13:16:08 INFO - 2016-01-20 13:16:08,029 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRtsQc8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:16:19 INFO - 2016-01-20 13:16:19,815 DEBUG : BROWSER_OUTPUT: RSS: Main: 137601024 13:16:19 INFO - 2016-01-20 13:16:19,815 DEBUG : BROWSER_OUTPUT: 13:16:22 INFO - 2016-01-20 13:16:22,290 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36400/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36400/tests/kraken/driver.html?testName=audio-beat-detection) 13:16:22 INFO - 2016-01-20 13:16:22,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 170438656 13:16:22 INFO - 2016-01-20 13:16:22,859 DEBUG : BROWSER_OUTPUT: 13:16:25 INFO - 2016-01-20 13:16:25,416 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36400/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36400/tests/kraken/driver.html?testName=audio-dft) 13:16:25 INFO - 2016-01-20 13:16:25,979 DEBUG : BROWSER_OUTPUT: RSS: Main: 168779776 13:16:25 INFO - 2016-01-20 13:16:25,979 DEBUG : BROWSER_OUTPUT: 13:16:28 INFO - 2016-01-20 13:16:28,764 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36400/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36400/tests/kraken/driver.html?testName=audio-fft) 13:16:29 INFO - 2016-01-20 13:16:29,330 DEBUG : BROWSER_OUTPUT: RSS: Main: 166408192 13:16:29 INFO - 2016-01-20 13:16:29,330 DEBUG : BROWSER_OUTPUT: 13:16:31 INFO - 2016-01-20 13:16:31,331 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36400/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36400/tests/kraken/driver.html?testName=audio-oscillator) 13:16:31 INFO - 2016-01-20 13:16:31,905 DEBUG : BROWSER_OUTPUT: RSS: Main: 166211584 13:16:31 INFO - 2016-01-20 13:16:31,906 DEBUG : BROWSER_OUTPUT: 13:16:34 INFO - 2016-01-20 13:16:34,105 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36400/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36400/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:16:34 INFO - 2016-01-20 13:16:34,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 165609472 13:16:34 INFO - 2016-01-20 13:16:34,666 DEBUG : BROWSER_OUTPUT: 13:16:37 INFO - 2016-01-20 13:16:37,547 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36400/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36400/tests/kraken/driver.html?testName=imaging-darkroom) 13:16:38 INFO - 2016-01-20 13:16:38,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 165453824 13:16:38 INFO - 2016-01-20 13:16:38,110 DEBUG : BROWSER_OUTPUT: 13:16:41 INFO - 2016-01-20 13:16:41,501 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36400/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36400/tests/kraken/driver.html?testName=imaging-desaturate) 13:16:42 INFO - 2016-01-20 13:16:42,069 DEBUG : BROWSER_OUTPUT: RSS: Main: 164782080 13:16:42 INFO - 2016-01-20 13:16:42,070 DEBUG : BROWSER_OUTPUT: 13:16:44 INFO - 2016-01-20 13:16:44,791 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36400/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36400/tests/kraken/driver.html?testName=json-parse-financial) 13:16:45 INFO - 2016-01-20 13:16:45,359 DEBUG : BROWSER_OUTPUT: RSS: Main: 164777984 13:16:45 INFO - 2016-01-20 13:16:45,359 DEBUG : BROWSER_OUTPUT: 13:16:46 INFO - 2016-01-20 13:16:46,934 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36400/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36400/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:16:47 INFO - 2016-01-20 13:16:47,496 DEBUG : BROWSER_OUTPUT: RSS: Main: 172142592 13:16:47 INFO - 2016-01-20 13:16:47,496 DEBUG : BROWSER_OUTPUT: 13:16:49 INFO - 2016-01-20 13:16:49,265 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36400/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36400/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:16:49 INFO - 2016-01-20 13:16:49,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 169406464 13:16:49 INFO - 2016-01-20 13:16:49,859 DEBUG : BROWSER_OUTPUT: 13:16:51 INFO - 2016-01-20 13:16:51,896 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36400/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36400/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:16:52 INFO - 2016-01-20 13:16:52,464 DEBUG : BROWSER_OUTPUT: RSS: Main: 180383744 13:16:52 INFO - 2016-01-20 13:16:52,464 DEBUG : BROWSER_OUTPUT: 13:16:54 INFO - 2016-01-20 13:16:54,842 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36400/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:16:55 INFO - 2016-01-20 13:16:55,423 DEBUG : BROWSER_OUTPUT: RSS: Main: 184320000 13:16:55 INFO - 2016-01-20 13:16:55,424 DEBUG : BROWSER_OUTPUT: 13:16:57 INFO - 2016-01-20 13:16:57,925 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:16:58 INFO - 2016-01-20 13:16:58,495 DEBUG : BROWSER_OUTPUT: RSS: Main: 181919744 13:16:58 INFO - 2016-01-20 13:16:58,495 DEBUG : BROWSER_OUTPUT: 13:17:00 INFO - 2016-01-20 13:17:00,184 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36400/tests/kraken/driver.html?testName=ai-astar) 13:17:00 INFO - 2016-01-20 13:17:00,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 242331648 13:17:00 INFO - 2016-01-20 13:17:00,434 DEBUG : BROWSER_OUTPUT: 13:17:00 INFO - 2016-01-20 13:17:00,438 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:17:00 INFO - 2016-01-20 13:17:00,438 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:17:00 INFO - 2016-01-20 13:17:00,438 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:17:00 INFO - 2016-01-20 13:17:00,438 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:17:00 INFO - 2016-01-20 13:17:00,438 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;111;104;109;110;111;99;110;110;110 13:17:00 INFO - 2016-01-20 13:17:00,438 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;145;121;158;162;121;146;147;121;157;121 13:17:00 INFO - 2016-01-20 13:17:00,438 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;160;159;161;162;160;162;160;162 13:17:00 INFO - 2016-01-20 13:17:00,439 DEBUG : BROWSER_OUTPUT: |3;audio-fft;77;72;71;143;74;73;73;73;159;73 13:17:00 INFO - 2016-01-20 13:17:00,439 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;140;92;94;92;148;93;93;134 13:17:00 INFO - 2016-01-20 13:17:00,439 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;109;109;109;109;110;109 13:17:00 INFO - 2016-01-20 13:17:00,439 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;144;145;145;145;144;145;145;145;145 13:17:00 INFO - 2016-01-20 13:17:00,439 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;95;94;94;96;96;96 13:17:00 INFO - 2016-01-20 13:17:00,439 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;57;59;59;58;58;57;61;55;57 13:17:00 INFO - 2016-01-20 13:17:00,439 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;65;64;64;64;64;64;65;64;65 13:17:00 INFO - 2016-01-20 13:17:00,440 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;80;83;82;84;90;82;91;83;84;82 13:17:00 INFO - 2016-01-20 13:17:00,440 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;127;111;112;123;108;114;119;114;113 13:17:00 INFO - 2016-01-20 13:17:00,440 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;150;138;148;146;146;135;139;146;144;136 13:17:00 INFO - 2016-01-20 13:17:00,440 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;69;66;66;68;64;64;67;67;66 13:17:00 INFO - 2016-01-20 13:17:00,440 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:17:00 INFO - 2016-01-20 13:17:00,440 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:17:00 INFO - 2016-01-20 13:17:00,440 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,893 13:17:00 INFO - 2016-01-20 13:17:00,441 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:17:00 INFO - 2016-01-20 13:17:00,441 DEBUG : BROWSER_OUTPUT: __startTimestamp1453324620435__endTimestamp 13:17:00 INFO - 2016-01-20 13:17:00,441 DEBUG : BROWSER_OUTPUT: 13:17:00 INFO - 2016-01-20 13:17:00,444 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:17:00 INFO - 2016-01-20 13:17:00,444 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:17:00 INFO - 2016-01-20 13:17:00,444 DEBUG : BROWSER_OUTPUT: 13:17:00 INFO - 2016-01-20 13:17:00,444 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.20 Median:110.00 stddev:3.82 (3.5%) stddev-sans-first:4.06 13:17:00 INFO - 2016-01-20 13:17:00,444 DEBUG : BROWSER_OUTPUT: Values: 108.0 111.0 104.0 109.0 110.0 111.0 99.0 110.0 110.0 110.0 13:17:00 INFO - 2016-01-20 13:17:00,444 DEBUG : BROWSER_OUTPUT: 13:17:00 INFO - 2016-01-20 13:17:00,445 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:139.90 Median:146.50 stddev:17.16 (11.7%) stddev-sans-first:18.10 13:17:00 INFO - 2016-01-20 13:17:00,445 DEBUG : BROWSER_OUTPUT: Values: 145.0 121.0 158.0 162.0 121.0 146.0 147.0 121.0 157.0 121.0 13:17:00 INFO - 2016-01-20 13:17:00,445 DEBUG : BROWSER_OUTPUT: 13:17:00 INFO - 2016-01-20 13:17:00,445 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 13:17:00 INFO - 2016-01-20 13:17:00,445 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 160.0 159.0 161.0 162.0 160.0 162.0 160.0 162.0 13:17:00 INFO - 2016-01-20 13:17:00,445 DEBUG : BROWSER_OUTPUT: 13:17:00 INFO - 2016-01-20 13:17:00,445 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.80 Median:73.00 stddev:33.03 (45.3%) stddev-sans-first:34.76 13:17:00 INFO - 2016-01-20 13:17:00,445 DEBUG : BROWSER_OUTPUT: Values: 77.0 72.0 71.0 143.0 74.0 73.0 73.0 73.0 159.0 73.0 13:17:00 INFO - 2016-01-20 13:17:00,445 DEBUG : BROWSER_OUTPUT: 13:17:00 INFO - 2016-01-20 13:17:00,445 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.20 Median:93.00 stddev:23.34 (25.1%) stddev-sans-first:24.18 13:17:00 INFO - 2016-01-20 13:17:00,445 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 140.0 92.0 94.0 92.0 148.0 93.0 93.0 134.0 13:17:00 INFO - 2016-01-20 13:17:00,445 DEBUG : BROWSER_OUTPUT: 13:17:00 INFO - 2016-01-20 13:17:00,445 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 13:17:00 INFO - 2016-01-20 13:17:00,445 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 13:17:00 INFO - 2016-01-20 13:17:00,445 DEBUG : BROWSER_OUTPUT: 13:17:00 INFO - 2016-01-20 13:17:00,446 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:144.80 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 13:17:00 INFO - 2016-01-20 13:17:00,446 DEBUG : BROWSER_OUTPUT: Values: 145.0 144.0 145.0 145.0 145.0 144.0 145.0 145.0 145.0 145.0 13:17:00 INFO - 2016-01-20 13:17:00,446 DEBUG : BROWSER_OUTPUT: 13:17:00 INFO - 2016-01-20 13:17:00,446 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.50 stddev:0.79 (0.8%) stddev-sans-first:0.83 13:17:00 INFO - 2016-01-20 13:17:00,446 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 95.0 94.0 94.0 96.0 96.0 96.0 13:17:00 INFO - 2016-01-20 13:17:00,446 DEBUG : BROWSER_OUTPUT: 13:17:00 INFO - 2016-01-20 13:17:00,446 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.00 stddev:1.84 (3.2%) stddev-sans-first:1.69 13:17:00 INFO - 2016-01-20 13:17:00,446 DEBUG : BROWSER_OUTPUT: Values: 55.0 57.0 59.0 59.0 58.0 58.0 57.0 61.0 55.0 57.0 13:17:00 INFO - 2016-01-20 13:17:00,447 DEBUG : BROWSER_OUTPUT: 13:17:00 INFO - 2016-01-20 13:17:00,447 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 13:17:00 INFO - 2016-01-20 13:17:00,447 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 64.0 64.0 64.0 64.0 64.0 65.0 64.0 65.0 13:17:00 INFO - 2016-01-20 13:17:00,447 DEBUG : BROWSER_OUTPUT: 13:17:00 INFO - 2016-01-20 13:17:00,447 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:83.50 stddev:3.57 (4.3%) stddev-sans-first:3.47 13:17:00 INFO - 2016-01-20 13:17:00,447 DEBUG : BROWSER_OUTPUT: Values: 80.0 83.0 82.0 84.0 90.0 82.0 91.0 83.0 84.0 82.0 13:17:00 INFO - 2016-01-20 13:17:00,447 DEBUG : BROWSER_OUTPUT: 13:17:00 INFO - 2016-01-20 13:17:00,447 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:115.70 Median:115.00 stddev:5.77 (5.0%) stddev-sans-first:6.12 13:17:00 INFO - 2016-01-20 13:17:00,447 DEBUG : BROWSER_OUTPUT: Values: 116.0 127.0 111.0 112.0 123.0 108.0 114.0 119.0 114.0 113.0 13:17:00 INFO - 2016-01-20 13:17:00,447 DEBUG : BROWSER_OUTPUT: 13:17:00 INFO - 2016-01-20 13:17:00,447 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.80 Median:146.00 stddev:5.33 (3.7%) stddev-sans-first:4.97 13:17:00 INFO - 2016-01-20 13:17:00,447 DEBUG : BROWSER_OUTPUT: Values: 150.0 138.0 148.0 146.0 146.0 135.0 139.0 146.0 144.0 136.0 13:17:00 INFO - 2016-01-20 13:17:00,447 DEBUG : BROWSER_OUTPUT: 13:17:00 INFO - 2016-01-20 13:17:00,447 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:1.65 (2.5%) stddev-sans-first:1.66 13:17:00 INFO - 2016-01-20 13:17:00,447 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 66.0 66.0 68.0 64.0 64.0 67.0 67.0 66.0 13:17:00 INFO - 2016-01-20 13:17:00,448 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:17:00 INFO - 2016-01-20 13:17:00,448 DEBUG : BROWSER_OUTPUT: 13:17:01 INFO - 2016-01-20 13:17:01,236 INFO : Browser exited with error code: 0 13:17:01 INFO - 2016-01-20 13:17:01,290 INFO : Completed test kraken (00:00:58) 13:17:01 INFO - 2016-01-20 13:17:01,290 INFO : Starting test v8_7 13:17:01 INFO - 2016-01-20 13:17:01,290 DEBUG : operating with platform_type : linux_ 13:17:01 INFO - 2016-01-20 13:17:01,290 INFO : Initialising browser for v8_7 test... 13:17:01 INFO - 2016-01-20 13:17:01,296 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1G2yYY/profile http://localhost:36400/getInfo.html 13:17:05 INFO - 2016-01-20 13:17:05,215 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:17:05 INFO - 2016-01-20 13:17:05,216 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:17:05 INFO - 2016-01-20 13:17:05,216 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:17:05 INFO - 2016-01-20 13:17:05,216 DEBUG : BROWSER_OUTPUT: __metrics 13:17:05 INFO - 2016-01-20 13:17:05,352 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:17:06 INFO - 2016-01-20 13:17:06,166 INFO : Browser initialized. 13:17:06 INFO - 2016-01-20 13:17:06,167 INFO : Running cycle 1/1 for v8_7 test... 13:17:06 INFO - 2016-01-20 13:17:06,167 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1G2yYY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:17:17 INFO - 2016-01-20 13:17:17,919 DEBUG : BROWSER_OUTPUT: RSS: Main: 137818112 13:17:17 INFO - 2016-01-20 13:17:17,919 DEBUG : BROWSER_OUTPUT: 13:17:39 INFO - 2016-01-20 13:17:39,260 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36400/tests/v8_7/run.html (next: http://localhost:36400/tests/v8_7/run.html) 13:17:39 INFO - 2016-01-20 13:17:39,506 DEBUG : BROWSER_OUTPUT: RSS: Main: 425918464 13:17:39 INFO - 2016-01-20 13:17:39,506 DEBUG : BROWSER_OUTPUT: 13:17:39 INFO - 2016-01-20 13:17:39,507 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:17:39 INFO - 2016-01-20 13:17:39,507 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:17:39 INFO - 2016-01-20 13:17:39,508 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:17:39 INFO - 2016-01-20 13:17:39,508 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:17:39 INFO - 2016-01-20 13:17:39,508 DEBUG : BROWSER_OUTPUT: |0;Richards;166.41704110500916 13:17:39 INFO - 2016-01-20 13:17:39,508 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;169.75046681378373 13:17:39 INFO - 2016-01-20 13:17:39,508 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.3296089385475 13:17:39 INFO - 2016-01-20 13:17:39,508 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5175.257731958763 13:17:39 INFO - 2016-01-20 13:17:39,508 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1013.1712259371834 13:17:39 INFO - 2016-01-20 13:17:39,509 DEBUG : BROWSER_OUTPUT: |5;Earley;556.4830272676684 13:17:39 INFO - 2016-01-20 13:17:39,509 DEBUG : BROWSER_OUTPUT: |6;Boyer;11076.923076923076 13:17:39 INFO - 2016-01-20 13:17:39,509 DEBUG : BROWSER_OUTPUT: |7;RegExp;24119.04761904762 13:17:39 INFO - 2016-01-20 13:17:39,509 DEBUG : BROWSER_OUTPUT: |8;Splay;525.7623554153523 13:17:39 INFO - 2016-01-20 13:17:39,509 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 13:17:39 INFO - 2016-01-20 13:17:39,510 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:17:39 INFO - 2016-01-20 13:17:39,510 DEBUG : BROWSER_OUTPUT: __startTimestamp1453324659506__endTimestamp 13:17:39 INFO - 2016-01-20 13:17:39,510 DEBUG : BROWSER_OUTPUT: 13:17:39 INFO - 2016-01-20 13:17:39,510 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:17:39 INFO - 2016-01-20 13:17:39,510 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:17:39 INFO - 2016-01-20 13:17:39,510 DEBUG : BROWSER_OUTPUT: 13:17:39 INFO - 2016-01-20 13:17:39,511 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.42 Median:166.42 stddev:0.00 (0.0%) 13:17:39 INFO - 2016-01-20 13:17:39,511 DEBUG : BROWSER_OUTPUT: Values: 166.4 13:17:39 INFO - 2016-01-20 13:17:39,511 DEBUG : BROWSER_OUTPUT: 13:17:39 INFO - 2016-01-20 13:17:39,511 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:169.75 Median:169.75 stddev:0.00 (0.0%) 13:17:39 INFO - 2016-01-20 13:17:39,511 DEBUG : BROWSER_OUTPUT: Values: 169.8 13:17:39 INFO - 2016-01-20 13:17:39,512 DEBUG : BROWSER_OUTPUT: 13:17:39 INFO - 2016-01-20 13:17:39,512 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.33 Median:279.33 stddev:0.00 (0.0%) 13:17:39 INFO - 2016-01-20 13:17:39,512 DEBUG : BROWSER_OUTPUT: Values: 279.3 13:17:39 INFO - 2016-01-20 13:17:39,512 DEBUG : BROWSER_OUTPUT: 13:17:39 INFO - 2016-01-20 13:17:39,513 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 13:17:39 INFO - 2016-01-20 13:17:39,514 DEBUG : BROWSER_OUTPUT: Values: 5175.3 13:17:39 INFO - 2016-01-20 13:17:39,514 DEBUG : BROWSER_OUTPUT: 13:17:39 INFO - 2016-01-20 13:17:39,514 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1013.17 Median:1013.17 stddev:0.00 (0.0%) 13:17:39 INFO - 2016-01-20 13:17:39,514 DEBUG : BROWSER_OUTPUT: Values: 1013.2 13:17:39 INFO - 2016-01-20 13:17:39,514 DEBUG : BROWSER_OUTPUT: 13:17:39 INFO - 2016-01-20 13:17:39,514 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:556.48 Median:556.48 stddev:0.00 (0.0%) 13:17:39 INFO - 2016-01-20 13:17:39,514 DEBUG : BROWSER_OUTPUT: Values: 556.5 13:17:39 INFO - 2016-01-20 13:17:39,514 DEBUG : BROWSER_OUTPUT: 13:17:39 INFO - 2016-01-20 13:17:39,515 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11076.92 Median:11076.92 stddev:0.00 (0.0%) 13:17:39 INFO - 2016-01-20 13:17:39,515 DEBUG : BROWSER_OUTPUT: Values: 11076.9 13:17:39 INFO - 2016-01-20 13:17:39,515 DEBUG : BROWSER_OUTPUT: 13:17:39 INFO - 2016-01-20 13:17:39,515 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24119.05 Median:24119.05 stddev:0.00 (0.0%) 13:17:39 INFO - 2016-01-20 13:17:39,515 DEBUG : BROWSER_OUTPUT: Values: 24119.0 13:17:39 INFO - 2016-01-20 13:17:39,515 DEBUG : BROWSER_OUTPUT: 13:17:39 INFO - 2016-01-20 13:17:39,515 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:525.76 Median:525.76 stddev:0.00 (0.0%) 13:17:39 INFO - 2016-01-20 13:17:39,516 DEBUG : BROWSER_OUTPUT: Values: 525.8 13:17:39 INFO - 2016-01-20 13:17:39,516 DEBUG : BROWSER_OUTPUT: 13:17:39 INFO - 2016-01-20 13:17:39,516 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 13:17:39 INFO - 2016-01-20 13:17:39,516 DEBUG : BROWSER_OUTPUT: Values: 4830.9 13:17:39 INFO - 2016-01-20 13:17:39,516 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:17:39 INFO - 2016-01-20 13:17:39,516 DEBUG : BROWSER_OUTPUT: 13:17:40 INFO - 2016-01-20 13:17:40,276 INFO : Browser exited with error code: 0 13:17:40 INFO - 2016-01-20 13:17:40,291 INFO : Completed test v8_7 (00:00:39) 13:17:40 INFO - 2016-01-20 13:17:40,569 INFO : Completed test suite (00:20:07) 13:17:40 INFO - 2016-01-20 13:17:40,569 DEBUG : Working with test: dromaeo_css 13:17:40 INFO - 2016-01-20 13:17:40,569 DEBUG : Generating results file: dromaeo_css 13:17:40 INFO - 2016-01-20 13:17:40,570 DEBUG : Working with test: kraken 13:17:40 INFO - 2016-01-20 13:17:40,570 DEBUG : Generating results file: kraken 13:17:40 INFO - 2016-01-20 13:17:40,571 INFO : javascript benchmark 13:17:40 INFO - 2016-01-20 13:17:40,571 DEBUG : Working with test: v8_7 13:17:40 INFO - 2016-01-20 13:17:40,571 DEBUG : Generating results file: v8_7 13:17:40 INFO - 2016-01-20 13:17:40,571 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:17:40 INFO - 2016-01-20 13:17:40,625 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 13:17:40 INFO - 2016-01-20 13:17:40,625 DEBUG : process_Request line: dromaeo_css 7290.37 graph.html#tests=[[72,52,35]] 13:17:40 INFO - 2016-01-20 13:17:40,625 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:17:40 INFO - 2016-01-20 13:17:40,657 DEBUG : process_Request line: kraken 1485.10 graph.html#tests=[[232,52,35]] 13:17:40 INFO - 2016-01-20 13:17:40,657 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:17:40 INFO - 2016-01-20 13:17:40,687 DEBUG : process_Request line: v8_7 22909.95 graph.html#tests=[[230,52,35]] 13:17:40 INFO - 2016-01-20 13:17:40,689 INFO : javascript benchmark 13:17:40 INFO - 2016-01-20 13:17:40,692 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3286.622038465576, 3331.6002079750433, 3362.5292459055736, 3367.2760356523345, 3394.5756780402457, 5408.891822163554, 5444.754986025629, 5492.423295553965, 5493.066178749617, 5501.0648189807725, 5444.047291723942, 5471.917921231185, 5512.614117011811, 5514.448555144493, 5518.2826232589705, 4874.2444921037295, 4994.750262486861, 5000.374953130859, 5059.367579052619, 5087.949120508784, 5008.649394542384, 5074.340335756347, 5091.618128640348, 5092.745362731867, 5096.108181068316, 4911.729854857981, 4976.178930476467, 5021.322121513585, 5038.672486288379, 5045.571126454256, 4946.9752651236695, 5038.974805125969, 5076.873078173076, 5078.568321692661, 5081.771320290559, 4789.928151077736, 4893.486183950669, 4921.335619691367, 4922.384701912261, 5032.924506132411, 5148.665336753136, 5208.583313334924, 5219.530242278175, 5271.86820329491, 5347.59893008022, 5828.679422631753, 5854.736536855852, 5864.354920958691, 5866.76532938682, 5889.528837692974, 5882.911756323659, 5911.083782013752, 5912.970435147839, 5913.408659134096, 5920.585559010871, 5342.412334643186, 5437.157240627709, 5510.035743744828, 5516.9448305516435, 5553.444655534414, 5917.31950825652, 5946.583739138218, 5948.613340132878, 5955.0, 5983.132445795335, 5602.831915042555, 5727.05503591911, 5731.828045158569, 5738.225339579187, 5741.024025915604, 5723.7424315905055, 5792.507636850914, 5809.2738407699035, 5821.7380217890295, 5839.036558967808, 5844.766209351664, 5883.235179426732, 5884.705764711747, 5898.233229680114, 5900.380460051719, 5703.74333155009, 5841.7371218295275, 5890.440408161217, 5891.175235467038, 5897.734601942923, 4384.298512238027, 4448.043670610769, 4456.153330867125, 4479.641628669699, 4498.302763071729, 4112.506499220112, 4113.321301985199, 4117.75293482392, 4139.3583994480905, 4166.7708276045105, 5420.322459692538, 5511.724413779295, 5699.316082070178, 5700.515456186187, 5715.628484148517, 5756.107803290497, 5837.591368604157, 5864.0, 5875.41245875409, 5903.6457812530525, 5594.104943209067, 5594.216809646653, 5594.412586678422, 5599.272094627754, 5617.38208797032, 4975.527324904128, 5078.974605127025, 5091.847244582668, 5156.046131465616, 5166.81916132941, 6068.969655151696, 6070.423309785563, 6072.180255665428, 6102.938970610237, 6103.725332360054, 5892.469677729025, 5896.262967129109, 5899.321578018583, 5907.202527658711, 5912.201852749996, 5742.397048309867, 5797.420257974169, 5974.790882319098, 6032.939670603238, 6091.299500557493, 5705.686187259741, 5708.771649133988, 5718.742656580547, 5718.914216286842, 5802.448767367094, 5685.090385538294, 5722.284714410699, 5749.252597162342, 5753.8561535961935, 5802.970985145047, 5568.359638641608, 5643.209950607001, 5693.174489699053, 5749.13762935563, 5783.8554036149435, 5643.717814109196, 5647.943520564741, 5656.37779844225, 5665.0, 5774.740136693775, 5357.892842143213, 5513.862153446196, 5527.447255274601, 5528.889422211614, 5545.694986775766, 5476.151196564539, 5611.438856114356, 5619.269494965628, 5620.353659329229, 5680.744366503434, 5639.295088113986, 5711.314642242957, 5731.0, 5756.251687280626, 5756.453136951983], "unit": "ms", "name": "dojo.html", "value": 5397.759874552094}, {"lowerIsBetter": false, "replicates": [608.9543284253681, 619.7366119399255, 622.9968850155755, 625.9061140828875, 630.9842253943651, 39662.40506392403, 40611.79694101525, 40643.59356406439, 40687.59312406875, 40780.59219407805, 44981.55018449815, 45326.7733661332, 45533.544664553345, 45579.54420455803, 45588.088238235214, 7733.574653394061, 7848.293653571178, 9045.321600879928, 9216.49309287989, 10325.380477171357, 10458.215633827454, 10508.422036787973, 10561.471926403687, 10575.629852955148, 10585.259031867772, 10828.620998265062, 10921.235513514057, 10925.562977480931, 10934.890651093507, 10936.343819370823, 8111.878321825177, 8305.46014509055, 10769.83845242322, 11046.613368532062, 11066.059384952288, 10526.263161578692, 10646.520906559223, 10649.361038337725, 10653.84019239712, 10654.307470014424, 41854.37218441726, 42527.787361063, 42557.36163957543, 42589.36115958263, 42704.35943460851, 3760.1163726524246, 3810.3522401191585, 3816.179521402884, 4015.4980627421573, 4362.04035112278, 31982.0, 32260.83869580637, 32281.51577726336, 32295.192620184447, 33514.0, 3651.1602331463646, 3660.3666349255454, 3729.645683660048, 3769.604191559874, 3933.9213215735813, 288280.0, 291410.0, 291850.54074729705, 291976.0, 292697.0, 65725.67137164283, 65891.67054164699, 66004.66997665077, 66181.6690916552, 66224.0, 68434.65782671055, 69685.0, 69821.0, 69880.65059674771, 70011.64994175099, 16373.836261637469, 16715.832841671672, 16745.665086698442, 16762.74855877163, 16773.496795096165, 12694.87305126937, 12713.93643031779, 12723.23660580368, 12754.936225318814, 12933.805992910115, 20940.79059209419, 21719.58822676521, 21749.238776642742, 21773.673394899088, 21784.78215217859, 8088.676452941934, 8493.320534357237, 8500.65997360111, 8566.61450234741, 8571.4000019998, 1029.799189158107, 1123.5225029362489, 1136.9772604547863, 1141.9771604567861, 1144.7367105565766, 29415.558766618517, 30048.24879378033, 30489.69510304913, 30661.540076898866, 30933.690663093083, 1152.567787079845, 1175.61204802415, 1184.3308530680138, 1224.6570960131178, 1246.2273390497949, 13303.201807891364, 15441.845581544265, 15465.458708945132, 15773.29020194094, 16064.0, 271549.0, 271718.0, 271963.0, 273442.0, 274537.0, 50101.49898501041, 50890.236646450336, 50912.0, 51058.0, 51105.48894511082, 1269.1116218646985, 1375.9931200343933, 1448.2613866927943, 1476.0405736271296, 1483.970320593582, 30446.0, 30602.234944126576, 30708.539371909887, 31557.684423155475, 31942.361152777277, 40281.59718402896, 49068.263976041104, 50161.74919125381, 50189.24716129334, 50232.49767502278, 214112.0, 216698.0, 216809.0, 216941.0, 283026.0, 33199.33601328008, 33872.15319617029, 33998.83000584981, 33999.0, 34028.82985585056, 45778.31332529948, 46375.76812116053, 46730.29904551367, 46817.76591117022, 47317.526824731314, 38687.226255475296, 39027.219455611295, 39324.0, 44597.77701111474, 45106.77446612877, 41008.79495602503, 41759.58240417557, 41763.450106741264, 42043.57956420397, 42200.78899605482, 40051.399229011, 40312.39531406973, 44659.553404465536, 44975.775121124185, 45577.0, 32271.0, 34024.010848755424, 34148.82925585356, 34412.655873441945, 34526.654733453346, 26331.736682632927, 26713.19860404191, 26787.866060670352, 26864.0, 26910.461790763682], "unit": "ms", "name": "ext.html", "value": 19891.607501195198}, {"lowerIsBetter": false, "replicates": [386.1601017786316, 388.4852570344294, 393.3922090370378, 394.9348357521009, 398.37256321293967, 14211.218382988958, 14417.78373324401, 16554.255058522365, 17506.824931750678, 17517.124143792793, 12872.935635321834, 16764.748528772077, 17042.062686552235, 17159.82840171598, 17167.0, 5034.496550344973, 5666.54667626591, 5701.629394089392, 5723.198752174699, 5835.212246346731, 3944.7633142011427, 4030.2745505808944, 5670.177824215486, 5783.0, 5809.448102430262, 5740.425957404268, 5782.739776710037, 5783.10361893905, 5796.594238403313, 5804.506616937565, 5754.942450575482, 5889.734961926723, 6240.188775459206, 6259.436650701413, 6270.310265870728, 5571.944280557183, 5592.636478628917, 5596.468335508161, 5597.384287728347, 5604.915926261109, 20721.0, 21120.04959776814, 21313.57372852534, 21474.0, 21540.892295538422, 2199.065397206181, 2219.422950033003, 2222.122261706617, 2236.7651396603287, 2347.2371479269136, 9875.950620246853, 9961.40231586107, 10156.492175391275, 10267.640632577824, 11609.303441793434, 1789.5078853315313, 1841.9723704144449, 1852.3887117251409, 1940.6991916253003, 1965.282671824788, 65556.0, 66804.3319566803, 68570.65714671394, 69201.0, 69759.0, 10395.84406233907, 10742.140628749681, 10773.51519181623, 10778.083862871743, 10852.186086043579, 13670.316484175752, 13718.314084295745, 13778.724425511433, 13779.586612401645, 13809.930950345184, 7710.151883292833, 7722.7297044603165, 7737.187595302525, 7741.8451630967065, 7755.1469338372735, 7331.523450975669, 7355.301246381692, 7392.186859445456, 7393.297636724503, 7401.296876796696, 4750.12122757291, 4784.736839473792, 4786.832460863922, 4799.0, 4818.590419814285, 1751.9690650147759, 1806.1150036482293, 1877.934272300463, 1916.5400303927236, 1950.7073938908993, 899.8290324838259, 979.4710856137748, 1022.3405903192399, 1042.0933787604831, 1110.9611163609397, 16083.0, 16235.837641623433, 16347.509574712778, 16427.35482848774, 16604.916975415046, 877.1929824561419, 967.1730670276953, 1000.2098342309639, 1001.290066488045, 1005.7636455432968, 9409.482478463613, 9546.61813527465, 9672.0, 9690.854637180448, 9884.406935583887, 649229.0, 659345.0, 661649.0, 667811.0, 669696.0, 88851.0, 90425.54787226021, 90616.54691726631, 90944.0, 92001.0, 1244.9066320025854, 1245.489349366737, 1274.413769665964, 1287.0861688201294, 1310.6330227536305, 16040.117793521002, 16136.919315403347, 16151.515454536382, 16153.353865845706, 16343.918280408521, 39148.41277380899, 39721.40417893792, 39756.2048759029, 39927.600723992386, 40098.198036038535, 50532.24201637052, 51538.48461515337, 54364.18453723118, 54664.726676366365, 56788.71605641946, 9497.525123743924, 9643.469609171283, 9739.464329461664, 9785.266105042008, 9868.259880508847, 11217.046551043253, 11319.717007074889, 15558.533244002245, 17344.82655173432, 17457.0, 14313.785293220402, 15140.394384224508, 15172.696546068795, 15386.692266154838, 15431.922840385727, 3179.713825755693, 8079.87880181786, 11243.494042767932, 14870.107793532423, 15155.621109472351, 15558.75529957578, 15980.920095399448, 16120.032798032156, 16142.919285403497, 16504.25730842091, 9572.473513956798, 9765.707028789147, 9989.850152247867, 10298.794024119326, 10325.483725813829, 15161.620959476102, 15408.460703875311, 15473.0, 15521.0, 15668.843311567194], "unit": "ms", "name": "jquery.html", "value": 9250.811182656134}, {"lowerIsBetter": false, "replicates": [1396.2460271453415, 1539.3226980128745, 1594.7926769519956, 1777.351266787622, 1873.5878106816497, 7403.185649578542, 8073.475224110429, 8278.95860520698, 8283.875741863862, 8287.751367458979, 8144.307733842616, 8320.126386729396, 8334.958325208365, 8336.833263334729, 8338.874916876237, 2050.7436570428695, 2084.5414008918087, 2085.4369320283513, 2293.908243670255, 2346.272655476808, 2190.3538456155393, 2230.7769223077644, 2233.9947023839254, 2236.4856083100817, 2238.3620668109593, 2309.214866945238, 2323.5469083528633, 2374.465745207332, 2376.192094687806, 2377.4175327044813, 2290.1640901071073, 2298.5058212484314, 2321.6749655048307, 2382.309130352196, 2386.916457923982, 2356.2813341930705, 2376.385975427034, 2392.509535545209, 2397.8920948557356, 2420.7337192908767, 8228.42401031928, 8320.791980200484, 8328.791780205484, 8345.082040975487, 8357.540335281557, 4682.976585117052, 4766.904661906742, 4773.355596994396, 4774.427068751772, 4789.784459699322, 2832.2352964699417, 2935.486289899259, 2956.39393924245, 2991.880324787006, 3003.6395632524236, 889.9065598112235, 896.3008853094597, 903.4985583001431, 936.9578368973345, 966.0870477398861, 11417.086633069335, 11420.657380278604, 11443.370614616193, 11445.599404020819, 11453.54185832574, 4212.0, 4240.0, 4280.315149576115, 4284.91430171401, 4301.354796780508, 9861.605535778488, 9864.65473708431, 9865.605375785031, 9867.210623150275, 9887.703368898945, 4857.6599638025, 4892.608591312686, 4897.853064408074, 4898.779554920037, 4901.460839307673, 4451.933221001687, 4464.799084041226, 4472.932906006413, 4473.977630111829, 4482.417285752831, 3437.8968630941113, 3476.7392445566684, 3558.6619271169197, 3748.1379282765115, 3831.444440556104, 1132.3828513460185, 1139.4587570903755, 1140.1448913315014, 1150.3558007515817, 1154.1978325064, 1118.2060736876908, 1119.3060302612269, 1170.473287020844, 1326.1512631915389, 1401.8738313551626, 7294.671739771723, 7337.88993165103, 7382.22486638906, 7457.142428620669, 7466.0, 1132.1282612388416, 1140.2531341970857, 1141.537677240719, 1152.181950814914, 1160.4487868262509, 5937.7921772737745, 5966.791162309299, 5986.670733109634, 5990.940090599038, 6008.459238668541, 9515.096065873731, 9869.753256168653, 10006.949965250273, 10035.749106272255, 10045.296829221885, 9724.076212759777, 9760.0, 9836.409815411098, 9865.161461275871, 9936.403815771077, 7633.618319084024, 7769.223077692299, 7774.6890124394395, 7885.250901164495, 7895.0, 7347.8163045924275, 7421.666025028779, 7436.070491188601, 7459.701611935462, 7465.253474652492, 8589.184027517376, 8699.347548933729, 8735.1701588349, 8945.73162805117, 8978.595963181542, 8788.516631585324, 8865.512396818236, 8902.154295341932, 9095.636174552943, 9582.856257156009, 7442.962785186256, 7464.514806537558, 7485.925140748523, 7502.549847009197, 7530.171681115183, 7272.163701174432, 7297.0, 7517.361024312994, 7524.510906791041, 8120.187981201832, 7550.0, 7619.466637335333, 7644.388448923962, 7660.119086304923, 7698.461107722405, 7509.699612015458, 7541.849163016818, 7559.584222867795, 7599.962000189964, 7639.885401718868, 7312.232215617496, 7510.737124200627, 7511.586862722603, 7514.62426878643, 7520.774376768706, 6869.862602748017, 6881.965590172017, 6897.586144831326, 6921.2386637470845, 6924.480663950325, 6779.6271205084195, 6799.354061364163, 7023.929760702532, 7031.226565077735, 7032.1912980007955], "unit": "ms", "name": "mootools.html", "value": 4647.673471558355}, {"lowerIsBetter": false, "replicates": [361.9294237623663, 362.12004828267305, 365.37885594489376, 370.33339988021555, 374.19361276449246, 6021.608595441298, 6024.066269728188, 6028.698565071745, 6071.78748743794, 6118.051701986188, 5733.827985160452, 5852.356240813507, 5870.677112758807, 6010.429009244115, 6035.641980554384, 4673.228917228653, 4692.343071969927, 4705.764711764416, 4706.317583950326, 4707.788149533262, 4705.952940470585, 4714.669973101884, 4715.41057367829, 4718.339432479455, 4724.574788269055, 4430.091831174602, 4493.7977790999485, 4560.2019646561885, 4633.328167415722, 4704.082703872747, 4609.124266389375, 4638.652101092432, 4655.604273636745, 4666.160091183586, 4689.226277664181, 4171.791410429497, 4172.228137794487, 4173.144505376391, 4173.165366926627, 4193.5387107418155, 5688.146777983295, 5751.539876809845, 5773.624714393551, 5789.305283365981, 5799.884002319972, 5423.810166644149, 5484.177373393983, 5486.341639003305, 5487.368952570466, 5487.972560137214, 6353.5870168438905, 6391.424771770517, 6397.712102955378, 6400.4559612432995, 6409.647469389181, 4611.608013318872, 4613.584777370019, 4615.376924115235, 4620.283856002325, 4626.727649896272, 6522.902156467657, 6652.434543063845, 6671.833204169886, 6675.899861502081, 6686.899696504508, 4743.407074115736, 4766.046790641885, 4766.785494652749, 4771.498992605796, 4776.068666610047, 4827.565519103297, 4834.105690447279, 4834.178189707758, 4836.177849765549, 4841.298011788342, 5465.07093794056, 5465.453454654582, 5467.07059799827, 5478.45215478457, 5479.123340265618, 6357.11000459936, 6411.0, 6450.838729031718, 6467.0, 6470.6441145737435, 1665.3088968078112, 1693.3395975569538, 1694.2718427204184, 1694.466243133409, 1695.6608678264397, 1171.6426489920486, 1171.9531218751154, 1176.2413243457922, 1189.893399138792, 1199.7420554580808, 6184.103305020747, 6190.535709821781, 6190.628562286277, 6192.938070619236, 6196.442320191204, 6632.502562307846, 6662.6668666566475, 6666.533342666064, 6666.933330666729, 6667.533272670964, 6136.78521251763, 6189.0, 6260.812175634738, 6317.96841015792, 6364.64994425311, 3597.4963505109304, 3614.8192590370377, 3622.4385220290897, 3626.6192049834385, 3628.129248980226, 6891.069705589681, 6893.069435626227, 6893.276205998398, 6899.275576064541, 6903.861922761516, 6718.49611279156, 6852.965735171392, 6865.588064716033, 6866.793996180123, 6867.759628412981, 6854.074699915547, 6877.65611719412, 6879.484038697117, 6886.8622627548175, 6889.104416425833, 6619.018487294817, 6700.128983232149, 6708.362705542965, 6711.530192886451, 6721.22705888829, 6588.472922166311, 6592.505562082959, 6593.736250549924, 6600.636964966973, 6608.900866487103, 6870.038194652852, 6871.072405225231, 6880.380765731108, 6881.93118068833, 6890.8621827562165, 4789.784459699392, 4791.5687588117235, 4793.209120495079, 4794.520547945178, 4801.303810947463, 6562.081308616893, 6617.966910165418, 6687.765928192684, 6693.665316734241, 6697.464202863662, 6523.543351965317, 6524.608523488606, 6540.50946179048, 6544.44372228366, 6549.345065493412, 6425.132607098169, 6518.348165183444, 6524.543281970216, 6530.67346632676, 6534.738610455529, 6392.52056095804, 6408.423241908251, 6411.679416029273, 6411.711472983634, 6415.582987105823, 6536.640484773383, 6543.051257567531, 6543.967280163569, 6544.411003009752, 6545.21457425112, 6252.9374706254175, 6392.0731493934045, 6397.616143031433, 6402.647854368054, 6411.262704789009], "unit": "ms", "name": "prototype.html", "value": 4927.172462508129}, {"lowerIsBetter": false, "replicates": [739.6745432009915, 783.8790529542754, 813.085279061056, 827.3174630929481, 834.4617721569584, 14025.719485610281, 14361.784573231409, 14395.568132956016, 14412.855871441283, 14436.855631443683, 13799.448022079105, 13849.376778044987, 13872.0, 13953.930230348835, 13970.091944023632, 731.228553875661, 748.5396481164099, 890.0698769785589, 907.2288554728461, 910.1671970147307, 911.1571796088591, 911.4075850697034, 914.634146341462, 917.5228880981886, 919.8942121656029, 764.1136281912982, 785.3206975965805, 941.6233506597382, 946.1201082992814, 948.7011591348703, 932.1983094538691, 954.2842867849148, 954.8376775948105, 957.760559860028, 957.8084383123369, 707.3209718670083, 708.4049398505281, 708.6881772020346, 708.7483943200193, 709.283623540223, 13483.730325393535, 14010.439582416691, 14052.086614370033, 14086.436542538286, 14136.151830890076, 13302.600921972356, 13848.58454246364, 13877.167369957835, 13892.0, 13922.930385348009, 9845.409275443497, 9933.850992235122, 9969.152622027137, 10090.445025523666, 10126.0, 3563.572371315433, 3611.530501034849, 3615.2950174715943, 3617.5297211362617, 3638.2905333459985, 47589.28616070762, 47898.99999999965, 48144.759276203746, 48392.51607483951, 48540.27189592159, 10014.79970400588, 10028.348157369748, 10173.0, 10180.643677471253, 10357.119644830274, 19155.521111972033, 19177.520561985784, 19193.616127677367, 19194.0, 19207.711884321747, 7482.6632801524065, 7492.213317601573, 7535.962320188473, 7558.168601453835, 7668.846623067619, 3953.090789118519, 4212.53662097169, 4238.915221695549, 4254.510731265882, 4311.245532031882, 3123.4846250368887, 3143.182772479126, 3149.401613693391, 3149.811011339327, 3150.102220867088, 542.5713686187868, 567.7473524281655, 567.8835838653149, 575.5740751843689, 584.0829897061573, 550.0676353580642, 647.252423450915, 661.7353058776432, 665.5806841689802, 699.7096205074939, 8024.839503209903, 8417.326613870999, 8463.576821158917, 8767.254783343487, 8777.605007774539, 545.2475583694555, 615.1940957345892, 656.8456412743002, 674.9088873002082, 696.1055044268193, 3962.603739626072, 4046.4537287466405, 4092.324766413568, 4126.711130220856, 4226.978865105655, 59572.0, 60434.697826510586, 60555.394446054976, 60584.0, 60611.69694151501, 54413.37486313628, 56026.71986640041, 56617.0, 56751.0, 56910.7154464225, 48407.0, 48462.5153748465, 48595.5140448591, 49165.26252106221, 49290.260646091054, 8440.535770532433, 8496.362772791941, 8753.562321883754, 9698.127168554864, 9702.126808587262, 38105.237895241386, 38156.0, 39396.21207575775, 39507.209855802146, 39642.80178599089, 47448.525514745794, 48712.75643621759, 48874.266885996025, 49025.0, 49587.752061239466, 11342.262752921033, 11861.229020113666, 11963.222390544586, 12091.334976576372, 12190.817137743119, 13120.868791311965, 13312.800307995194, 13571.1857288563, 13759.449622015007, 13982.720345593234, 11754.412279386168, 12063.75872482563, 12165.756684866075, 12256.38718064111, 12697.238165710087, 12479.93760031194, 12494.37528123572, 12828.743425131632, 12851.935740321238, 12995.28525931083, 11370.43147842588, 11476.885231147915, 11596.0, 12215.0, 12737.808932866199, 9459.527023648652, 9621.18219951284, 9700.272479564203, 9885.357451765612, 9970.30207885441, 9261.53692315395, 9450.338476306593, 10831.783364332827, 10835.295705779099, 10882.40146791934], "unit": "ms", "name": "yui.html", "value": 6600.259369153315}], "name": "dromaeo_css", "value": 7290.368321475004}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 111.0, 104.0, 109.0, 110.0, 111.0, 99.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [145.0, 121.0, 158.0, 162.0, 121.0, 146.0, 147.0, 121.0, 157.0, 121.0], "unit": "ms", "name": "audio-beat-detection", "value": 139.9}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 159.0, 161.0, 162.0, 160.0, 162.0, 160.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [77.0, 72.0, 71.0, 143.0, 74.0, 73.0, 73.0, 73.0, 159.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 88.8}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 140.0, 92.0, 94.0, 92.0, 148.0, 93.0, 93.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 107.2}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [145.0, 144.0, 145.0, 145.0, 145.0, 144.0, 145.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 144.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 94.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [55.0, 57.0, 59.0, 59.0, 58.0, 58.0, 57.0, 61.0, 55.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.3}, {"lowerIsBetter": true, "replicates": [80.0, 83.0, 82.0, 84.0, 90.0, 82.0, 91.0, 83.0, 84.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.1}, {"lowerIsBetter": true, "replicates": [116.0, 127.0, 111.0, 112.0, 123.0, 108.0, 114.0, 119.0, 114.0, 113.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 115.7}, {"lowerIsBetter": true, "replicates": [150.0, 138.0, 148.0, 146.0, 146.0, 135.0, 139.0, 146.0, 144.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.8}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 66.0, 66.0, 68.0, 64.0, 64.0, 67.0, 67.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1485.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.41704110500916], "unit": "score", "name": "Richards", "value": 212.1297179999999}, {"lowerIsBetter": false, "replicates": [169.75046681378373], "unit": "score", "name": "DeltaBlue", "value": 389.5011380000001}, {"lowerIsBetter": false, "replicates": [279.3296089385475], "unit": "score", "name": "Encrypt", "value": 952.9279799999998}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1013.1712259371834], "unit": "score", "name": "RayTrace", "value": 730.3691430000001}, {"lowerIsBetter": false, "replicates": [556.4830272676684], "unit": "score", "name": "Earley", "value": 1197.6340109999996}, {"lowerIsBetter": false, "replicates": [11076.923076923076], "unit": "score", "name": "Boyer", "value": 60.16679861111106}, {"lowerIsBetter": false, "replicates": [24119.04761904762], "unit": "score", "name": "RegExp", "value": 37.77035538005923}, {"lowerIsBetter": false, "replicates": [525.7623554153523], "unit": "score", "name": "Splay", "value": 154.995882}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 22909.953343770812}]} 13:17:40 INFO - RETURN: dromaeo_css: 7290.37 13:17:40 INFO - RETURN: kraken: 1485.10 13:17:40 INFO - RETURN: v8_7: 22909.95 13:17:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "22909.95"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1485.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7290.37"}}} 13:17:40 INFO - Return code: 0 13:17:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:17:40 INFO - # TBPL SUCCESS # 13:17:40 INFO - Running post-action listener: _resource_record_post_action 13:17:40 INFO - Running post-run listener: _resource_record_post_run 13:17:41 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 262144; Write bytes: 514383872; Read time: 16; Write time: 427208 13:17:41 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 249106432; Read time: 0; Write time: 279780 13:17:41 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 262144; Write bytes: 265277440; Read time: 16; Write time: 147428 13:17:41 INFO - Running post-run listener: _upload_blobber_files 13:17:41 INFO - Blob upload gear active. 13:17:41 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:17:41 INFO - Copying logs to upload dir... 13:17:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1262.381189 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-01-20 13:17:41.496547) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-20 13:17:41.499774) ========= 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=32c5991c409366f7fec8a718000001d2-1453323122.434493-2042910664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/kPWp9zfgTqGvJD34lcTwVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010093 build_url: 'https://queue.taskcluster.net/v1/task/kPWp9zfgTqGvJD34lcTwVQ/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 2016-01-20 13:17:41.550502) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 13:17:41.550824) ========= 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=32c5991c409366f7fec8a718000001d2-1453323122.434493-2042910664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 13:17:41.601604) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 13:17:41.601911) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 13:17:41.602206) ========= ========= Total master_lag: 0.28 =========