builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-054 starttime: 1453509459.1 results: success (0) buildid: 20160122140553 builduid: 4dc614e7ca3642e89df580e2d6ed592b revision: 1fa9b8e51c285b27bf7730655d7c0385d83383f8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:39.099101) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:39.099675) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:39.101373) ========= 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=cbe409c6de289db6ac707de3000001d4-1453508479.483616-2145164124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006462 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:39.127503) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:39.130883) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:39.159397) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:39.159751) ========= 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=cbe409c6de289db6ac707de3000001d4-1453508479.483616-2145164124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004681 ========= master_lag: 0.36 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:39.522897) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:39.523308) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:39.523735) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:39.524049) ========= 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=cbe409c6de289db6ac707de3000001d4-1453508479.483616-2145164124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-22 16:37:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.0M=0s 2016-01-22 16:37:40 (35.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161049 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:39.705449) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:39.706201) ========= 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=cbe409c6de289db6ac707de3000001d4-1453508479.483616-2145164124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017124 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:39.755910) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:39.756462) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1fa9b8e51c285b27bf7730655d7c0385d83383f8 --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 1fa9b8e51c285b27bf7730655d7c0385d83383f8 --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=cbe409c6de289db6ac707de3000001d4-1453508479.483616-2145164124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-22 16:37:40,630 truncating revision to first 12 chars 2016-01-22 16:37:40,630 Setting DEBUG logging. 2016-01-22 16:37:40,630 attempt 1/10 2016-01-22 16:37:40,630 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1fa9b8e51c28?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-22 16:37:40,866 unpacking tar archive at: mozilla-aurora-1fa9b8e51c28/testing/mozharness/ program finished with exit code 0 elapsedTime=0.509629 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:40.280381) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:40.280779) ========= echo 1fa9b8e51c285b27bf7730655d7c0385d83383f8 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1fa9b8e51c285b27bf7730655d7c0385d83383f8'] 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=cbe409c6de289db6ac707de3000001d4-1453508479.483616-2145164124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 1fa9b8e51c285b27bf7730655d7c0385d83383f8 program finished with exit code 0 elapsedTime=0.004629 script_repo_revision: '1fa9b8e51c285b27bf7730655d7c0385d83383f8' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:40.333883) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:40.334458) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:40.346154) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-01-22 16:37:40.346669) ========= /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=cbe409c6de289db6ac707de3000001d4-1453508479.483616-2145164124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:37:41 INFO - MultiFileLogger online at 20160122 16:37:41 in /builds/slave/test-pgo 16:37:41 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 16:37:41 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:37:41 INFO - {'append_to_log': False, 16:37:41 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:37:41 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:37:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:37:41 INFO - 'branch': 'Mozilla-Aurora', 16:37:41 INFO - 'buildbot_json_path': 'buildprops.json', 16:37:41 INFO - 'config_files': ('talos/linux_config.py',), 16:37:41 INFO - 'default_actions': ('clobber', 16:37:41 INFO - 'read-buildbot-config', 16:37:41 INFO - 'download-and-extract', 16:37:41 INFO - 'populate-webroot', 16:37:41 INFO - 'create-virtualenv', 16:37:41 INFO - 'install', 16:37:41 INFO - 'run-tests'), 16:37:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:37:41 INFO - 'download_minidump_stackwalk': True, 16:37:41 INFO - 'download_symbols': 'ondemand', 16:37:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:37:41 INFO - 'tooltool.py': '/tools/tooltool.py', 16:37:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:37:41 INFO - '/tools/misc-python/virtualenv.py')}, 16:37:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:37:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:37:41 INFO - 'installer_path': 'installer.exe', 16:37:41 INFO - 'log_level': 'info', 16:37:41 INFO - 'log_name': 'talos', 16:37:41 INFO - 'log_to_console': True, 16:37:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:37:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:37:41 INFO - 'opt_config_files': (), 16:37:41 INFO - 'pip_index': False, 16:37:41 INFO - 'sps_profile': False, 16:37:41 INFO - 'sps_profile_interval': 0, 16:37:41 INFO - 'suite': 'dromaeojs', 16:37:41 INFO - 'system_bits': '32', 16:37:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:37:41 INFO - 'title': 'talos-linux64-ix-054', 16:37:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:37:41 INFO - 'use_talos_json': True, 16:37:41 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:37:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:37:41 INFO - 'work_dir': 'build'} 16:37:41 INFO - ##### 16:37:41 INFO - ##### Running clobber step. 16:37:41 INFO - ##### 16:37:41 INFO - Running pre-action listener: _resource_record_pre_action 16:37:41 INFO - Running main action method: clobber 16:37:41 INFO - rmtree: /builds/slave/test-pgo/build 16:37:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:37:41 INFO - Running post-action listener: _resource_record_post_action 16:37:41 INFO - ##### 16:37:41 INFO - ##### Running read-buildbot-config step. 16:37:41 INFO - ##### 16:37:41 INFO - Running pre-action listener: _resource_record_pre_action 16:37:41 INFO - Running main action method: read_buildbot_config 16:37:41 INFO - Using buildbot properties: 16:37:41 INFO - { 16:37:41 INFO - "properties": { 16:37:41 INFO - "buildnumber": 214, 16:37:41 INFO - "product": "firefox", 16:37:41 INFO - "script_repo_revision": "production", 16:37:41 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 16:37:41 INFO - "repository": "", 16:37:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 16:37:41 INFO - "buildid": "20160122140553", 16:37:41 INFO - "slavename": "talos-linux64-ix-054", 16:37:41 INFO - "pgo_build": "True", 16:37:41 INFO - "basedir": "/builds/slave/test-pgo", 16:37:41 INFO - "project": "", 16:37:41 INFO - "platform": "ubuntu64_hw", 16:37:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:37:41 INFO - "slavebuilddir": "test", 16:37:41 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:37:41 INFO - "branch": "mozilla-aurora", 16:37:41 INFO - "repo_path": "releases/mozilla-aurora", 16:37:41 INFO - "stage_platform": "linux64-pgo", 16:37:41 INFO - "builduid": "4dc614e7ca3642e89df580e2d6ed592b", 16:37:41 INFO - "revision": "1fa9b8e51c285b27bf7730655d7c0385d83383f8" 16:37:41 INFO - }, 16:37:41 INFO - "sourcestamp": { 16:37:41 INFO - "repository": "", 16:37:41 INFO - "hasPatch": false, 16:37:41 INFO - "project": "", 16:37:41 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 16:37:41 INFO - "changes": [ 16:37:41 INFO - { 16:37:41 INFO - "category": null, 16:37:41 INFO - "files": [ 16:37:41 INFO - { 16:37:41 INFO - "url": null, 16:37:41 INFO - "name": "https://queue.taskcluster.net/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 16:37:41 INFO - } 16:37:41 INFO - ], 16:37:41 INFO - "repository": "", 16:37:41 INFO - "rev": "1fa9b8e51c285b27bf7730655d7c0385d83383f8", 16:37:41 INFO - "who": "eakhgari@mozilla.com", 16:37:41 INFO - "when": 1453509401, 16:37:41 INFO - "number": 7503740, 16:37:41 INFO - "comments": "Bug 1240916 - Part 2: Update the en-US dictionary to SCOWL 2016.01.19 a=sylvestre\n", 16:37:41 INFO - "project": "", 16:37:41 INFO - "at": "Fri 22 Jan 2016 16:36:41", 16:37:41 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 16:37:41 INFO - "revlink": "", 16:37:41 INFO - "properties": [ 16:37:41 INFO - [ 16:37:41 INFO - "buildid", 16:37:41 INFO - "20160122140553", 16:37:41 INFO - "Change" 16:37:41 INFO - ], 16:37:41 INFO - [ 16:37:41 INFO - "builduid", 16:37:41 INFO - "4dc614e7ca3642e89df580e2d6ed592b", 16:37:41 INFO - "Change" 16:37:41 INFO - ], 16:37:41 INFO - [ 16:37:41 INFO - "pgo_build", 16:37:41 INFO - "True", 16:37:41 INFO - "Change" 16:37:41 INFO - ] 16:37:41 INFO - ], 16:37:41 INFO - "revision": "1fa9b8e51c285b27bf7730655d7c0385d83383f8" 16:37:41 INFO - } 16:37:41 INFO - ], 16:37:41 INFO - "revision": "1fa9b8e51c285b27bf7730655d7c0385d83383f8" 16:37:41 INFO - } 16:37:41 INFO - } 16:37:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 16:37:41 INFO - Running post-action listener: _resource_record_post_action 16:37:41 INFO - ##### 16:37:41 INFO - ##### Running download-and-extract step. 16:37:41 INFO - ##### 16:37:41 INFO - Running pre-action listener: _resource_record_pre_action 16:37:41 INFO - Running main action method: download_and_extract 16:37:41 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:41 INFO - https://queue.taskcluster.net/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:37:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/test_packages.json 16:37:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/test_packages.json 16:37:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:37:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:37:42 INFO - Downloaded 1302 bytes. 16:37:42 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:37:42 INFO - Using the following test package requirements: 16:37:42 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 16:37:42 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:37:42 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:37:42 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:37:42 INFO - u'jsshell-linux-x86_64.zip'], 16:37:42 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:37:42 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:37:42 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 16:37:42 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:37:42 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:37:42 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:37:42 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:37:42 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:37:42 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:37:42 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 16:37:42 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:37:42 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:37:42 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:42 INFO - https://queue.taskcluster.net/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:37:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:37:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:37:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:37:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:37:43 INFO - Downloaded 23159542 bytes. 16:37:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:37:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:37:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:37:44 INFO - Return code: 0 16:37:44 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:37:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:44 INFO - https://queue.taskcluster.net/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:37:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:37:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:37:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:37:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:37:46 INFO - Downloaded 23159542 bytes. 16:37:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:37:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:37:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:37:48 INFO - Return code: 0 16:37:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:48 INFO - https://queue.taskcluster.net/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:37:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 16:37:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 16:37:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 16:37:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:37:49 INFO - Downloaded 11132038 bytes. 16:37:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 16:37:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 16:37:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 16:37:49 INFO - Return code: 0 16:37: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')]} 16:37:49 INFO - https://queue.taskcluster.net/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:37:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:37:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:37:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:37:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:37:50 INFO - Downloaded 58024011 bytes. 16:37:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:37:50 INFO - mkdir: /builds/slave/test-pgo/properties 16:37:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:37:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:37:50 INFO - Contents: 16:37:50 INFO - build_url:https://queue.taskcluster.net/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:37:50 INFO - Running post-action listener: _resource_record_post_action 16:37:50 INFO - Running post-action listener: set_extra_try_arguments 16:37:50 INFO - ##### 16:37:50 INFO - ##### Running populate-webroot step. 16:37:50 INFO - ##### 16:37:50 INFO - Running pre-action listener: _resource_record_pre_action 16:37:50 INFO - Running main action method: populate_webroot 16:37:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:37:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:37:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:37:50 INFO - '--tppagecycles', 16:37:50 INFO - '7'], 16:37:50 INFO - 'tests': ['tsvgm']}}, 16:37:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:37:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:37:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:37:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:37:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:37:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:37:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:37:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:50 INFO - 'talos_options': ['--e10s'], 16:37:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:37:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:50 INFO - 'tests': ['damp', 'tps']}, 16:37:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:50 INFO - 'talos_options': ['--e10s'], 16:37:50 INFO - 'tests': ['damp', 'tps']}, 16:37:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:37:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:37:50 INFO - 'other': {'tests': ['a11yr', 16:37:50 INFO - 'ts_paint', 16:37:50 INFO - 'tpaint', 16:37:50 INFO - 'sessionrestore', 16:37:50 INFO - 'sessionrestore_no_auto_restore']}, 16:37:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:37:50 INFO - 'tests': ['a11yr', 16:37:50 INFO - 'ts_paint', 16:37:50 INFO - 'tpaint', 16:37:50 INFO - 'sessionrestore', 16:37:50 INFO - 'sessionrestore_no_auto_restore']}, 16:37:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:37:50 INFO - 'tests': ['a11yr', 16:37:50 INFO - 'ts_paint', 16:37:50 INFO - 'tpaint', 16:37:50 INFO - 'sessionrestore', 16:37:50 INFO - 'sessionrestore_no_auto_restore']}, 16:37:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:37:50 INFO - 'tests': ['a11yr', 16:37:50 INFO - 'ts_paint', 16:37:50 INFO - 'tpaint', 16:37:50 INFO - 'sessionrestore', 16:37:50 INFO - 'sessionrestore_no_auto_restore']}, 16:37:50 INFO - 'other_l64': {'tests': ['a11yr', 16:37:50 INFO - 'ts_paint', 16:37:50 INFO - 'tpaint', 16:37:50 INFO - 'sessionrestore', 16:37:50 INFO - 'sessionrestore_no_auto_restore']}, 16:37:50 INFO - 'other_nol64': {'tests': ['a11yr', 16:37:50 INFO - 'ts_paint', 16:37:50 INFO - 'tpaint', 16:37:50 INFO - 'sessionrestore', 16:37:50 INFO - 'sessionrestore_no_auto_restore']}, 16:37:50 INFO - 'svgr': {'tests': ['tsvgx', 16:37:50 INFO - 'tsvgr_opacity', 16:37:50 INFO - 'tart', 16:37:50 INFO - 'tscrollx', 16:37:50 INFO - 'cart']}, 16:37:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:37:50 INFO - 'tests': ['tsvgx', 16:37:50 INFO - 'tsvgr_opacity', 16:37:50 INFO - 'tart', 16:37:50 INFO - 'tscrollx', 16:37:50 INFO - 'cart']}, 16:37:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:50 INFO - 'tests': ['tp5o']}, 16:37:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:50 INFO - 'talos_options': ['--e10s'], 16:37:50 INFO - 'tests': ['tp5o']}, 16:37:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:50 INFO - 'talos_options': ['--xperf_path', 16:37:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:37:50 INFO - 'tests': ['tp5n']}, 16:37:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:50 INFO - 'talos_options': ['--e10s', 16:37:50 INFO - '--xperf_path', 16:37:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:37:50 INFO - 'tests': ['tp5n']}}, 16:37:50 INFO - 'talos.zip': {'path': '', 16:37:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:37:50 INFO - Running post-action listener: _resource_record_post_action 16:37:50 INFO - ##### 16:37:50 INFO - ##### Running create-virtualenv step. 16:37:50 INFO - ##### 16:37:50 INFO - Running pre-action listener: _resource_record_pre_action 16:37:50 INFO - Running main action method: create_virtualenv 16:37:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:37:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 16:37:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:37:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:37:50 INFO - Using real prefix '/usr' 16:37:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:37:51 INFO - Installing distribute.............................................................................................................................................................................................done. 16:37:53 INFO - Installing pip.................done. 16:37:53 INFO - Return code: 0 16:37:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:53 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 0x7ff4245f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f07600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f96350>, '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 0x1f97250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f976e0>, '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': 'cbe409c6de289db6ac707de3000001d4-1453508479.483616-2145164124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:37:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 16:37:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:37:53 INFO - Using env: {'DISPLAY': ':0', 16:37:53 INFO - 'HOME': '/home/cltbld', 16:37:53 INFO - 'LANG': 'en_US.UTF-8', 16:37:53 INFO - 'LANGUAGE': 'en_US:en', 16:37:53 INFO - 'LOGNAME': 'cltbld', 16:37:53 INFO - 'MAIL': '/var/mail/cltbld', 16:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:53 INFO - 'MOZ_NO_REMOTE': '1', 16:37:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:53 INFO - 'NO_EM_RESTART': '1', 16:37:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:37:53 INFO - 'PWD': '/builds/slave/test-pgo', 16:37:53 INFO - 'SHELL': '/bin/bash', 16:37:53 INFO - 'SHLVL': '1', 16:37:53 INFO - 'TERM': 'linux', 16:37:53 INFO - 'TMOUT': '86400', 16:37:53 INFO - 'USER': 'cltbld', 16:37:53 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453508479.483616-2145164124', 16:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:53 INFO - '_': '/tools/buildbot/bin/python'} 16:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:37:53 INFO - Cleaning up... 16:37:53 INFO - Return code: 0 16:37:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:53 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 0x7ff4245f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f07600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f96350>, '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 0x1f97250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f976e0>, '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': 'cbe409c6de289db6ac707de3000001d4-1453508479.483616-2145164124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:37:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 16:37:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:37:53 INFO - Using env: {'DISPLAY': ':0', 16:37:53 INFO - 'HOME': '/home/cltbld', 16:37:53 INFO - 'LANG': 'en_US.UTF-8', 16:37:53 INFO - 'LANGUAGE': 'en_US:en', 16:37:53 INFO - 'LOGNAME': 'cltbld', 16:37:53 INFO - 'MAIL': '/var/mail/cltbld', 16:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:53 INFO - 'MOZ_NO_REMOTE': '1', 16:37:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:53 INFO - 'NO_EM_RESTART': '1', 16:37:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:37:53 INFO - 'PWD': '/builds/slave/test-pgo', 16:37:53 INFO - 'SHELL': '/bin/bash', 16:37:53 INFO - 'SHLVL': '1', 16:37:53 INFO - 'TERM': 'linux', 16:37:53 INFO - 'TMOUT': '86400', 16:37:53 INFO - 'USER': 'cltbld', 16:37:53 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453508479.483616-2145164124', 16:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:53 INFO - '_': '/tools/buildbot/bin/python'} 16:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:53 INFO - Downloading/unpacking psutil>=0.7.1 16:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:37:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:37:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:37:55 INFO - Installing collected packages: psutil 16:37:55 INFO - Running setup.py install for psutil 16:37:55 INFO - building 'psutil._psutil_linux' extension 16:37:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:37:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:37:56 INFO - building 'psutil._psutil_posix' extension 16:37:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:37:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:37:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:37:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:37:56 INFO - Successfully installed psutil 16:37:56 INFO - Cleaning up... 16:37:56 INFO - Return code: 0 16:37:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:37: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')]} 16:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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')]} 16:37:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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', '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 0x7ff4245f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f07600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f96350>, '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 0x1f97250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f976e0>, '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': 'cbe409c6de289db6ac707de3000001d4-1453508479.483616-2145164124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:37: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 16:37: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 mozsystemmonitor==0.0.0 16:37:56 INFO - Using env: {'DISPLAY': ':0', 16:37:56 INFO - 'HOME': '/home/cltbld', 16:37:56 INFO - 'LANG': 'en_US.UTF-8', 16:37:56 INFO - 'LANGUAGE': 'en_US:en', 16:37:56 INFO - 'LOGNAME': 'cltbld', 16:37:56 INFO - 'MAIL': '/var/mail/cltbld', 16:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:56 INFO - 'MOZ_NO_REMOTE': '1', 16:37:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:56 INFO - 'NO_EM_RESTART': '1', 16:37:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:37:56 INFO - 'PWD': '/builds/slave/test-pgo', 16:37:56 INFO - 'SHELL': '/bin/bash', 16:37:56 INFO - 'SHLVL': '1', 16:37:56 INFO - 'TERM': 'linux', 16:37:56 INFO - 'TMOUT': '86400', 16:37:56 INFO - 'USER': 'cltbld', 16:37:56 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453508479.483616-2145164124', 16:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:56 INFO - '_': '/tools/buildbot/bin/python'} 16:37:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:37:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:37:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:37:58 INFO - Installing collected packages: mozsystemmonitor 16:37:58 INFO - Running setup.py install for mozsystemmonitor 16:37:58 INFO - Successfully installed mozsystemmonitor 16:37:58 INFO - Cleaning up... 16:37:58 INFO - Return code: 0 16:37:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:37: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')]} 16:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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')]} 16:37:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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', '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 0x7ff4245f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f07600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f96350>, '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 0x1f97250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f976e0>, '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': 'cbe409c6de289db6ac707de3000001d4-1453508479.483616-2145164124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:37: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 16:37: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 blobuploader==1.2.4 16:37:58 INFO - Using env: {'DISPLAY': ':0', 16:37:58 INFO - 'HOME': '/home/cltbld', 16:37:58 INFO - 'LANG': 'en_US.UTF-8', 16:37:58 INFO - 'LANGUAGE': 'en_US:en', 16:37:58 INFO - 'LOGNAME': 'cltbld', 16:37:58 INFO - 'MAIL': '/var/mail/cltbld', 16:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:58 INFO - 'MOZ_NO_REMOTE': '1', 16:37:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:58 INFO - 'NO_EM_RESTART': '1', 16:37:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:37:58 INFO - 'PWD': '/builds/slave/test-pgo', 16:37:58 INFO - 'SHELL': '/bin/bash', 16:37:58 INFO - 'SHLVL': '1', 16:37:58 INFO - 'TERM': 'linux', 16:37:58 INFO - 'TMOUT': '86400', 16:37:58 INFO - 'USER': 'cltbld', 16:37:58 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453508479.483616-2145164124', 16:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:58 INFO - '_': '/tools/buildbot/bin/python'} 16:37:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:58 INFO - Downloading/unpacking blobuploader==1.2.4 16:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:00 INFO - Downloading blobuploader-1.2.4.tar.gz 16:38:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:38:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:38:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:38: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 16:38: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 16:38: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 16:38: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 16:38: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 16:38: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 16:38:01 INFO - Downloading docopt-0.6.1.tar.gz 16:38:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:38:01 INFO - Installing collected packages: blobuploader, requests, docopt 16:38:01 INFO - Running setup.py install for blobuploader 16:38:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:38:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:38:01 INFO - Running setup.py install for requests 16:38:01 INFO - Running setup.py install for docopt 16:38:01 INFO - Successfully installed blobuploader requests docopt 16:38:01 INFO - Cleaning up... 16:38:01 INFO - Return code: 0 16:38:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:38:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:01 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 0x7ff4245f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f07600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f96350>, '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 0x1f97250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f976e0>, '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': 'cbe409c6de289db6ac707de3000001d4-1453508479.483616-2145164124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:38:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:38:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:38:01 INFO - Using env: {'DISPLAY': ':0', 16:38:01 INFO - 'HOME': '/home/cltbld', 16:38:01 INFO - 'LANG': 'en_US.UTF-8', 16:38:01 INFO - 'LANGUAGE': 'en_US:en', 16:38:01 INFO - 'LOGNAME': 'cltbld', 16:38:01 INFO - 'MAIL': '/var/mail/cltbld', 16:38:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:01 INFO - 'MOZ_NO_REMOTE': '1', 16:38:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:01 INFO - 'NO_EM_RESTART': '1', 16:38:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:38:01 INFO - 'PWD': '/builds/slave/test-pgo', 16:38:01 INFO - 'SHELL': '/bin/bash', 16:38:01 INFO - 'SHLVL': '1', 16:38:01 INFO - 'TERM': 'linux', 16:38:01 INFO - 'TMOUT': '86400', 16:38:01 INFO - 'USER': 'cltbld', 16:38:01 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453508479.483616-2145164124', 16:38:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:01 INFO - '_': '/tools/buildbot/bin/python'} 16:38:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:38:02 INFO - Running setup.py (path:/tmp/pip-69MB0y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:38:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:38:02 INFO - Running setup.py (path:/tmp/pip-4lCASS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:38:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:38:02 INFO - Running setup.py (path:/tmp/pip-22rqOe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:38:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:38:02 INFO - Running setup.py (path:/tmp/pip-xK1qgO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:38:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:38:02 INFO - Running setup.py (path:/tmp/pip-iCkm1A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:38:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:38:02 INFO - Running setup.py (path:/tmp/pip-GnwoXB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:38:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:38:02 INFO - Running setup.py (path:/tmp/pip-bsKk3T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:38:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:38:02 INFO - Running setup.py (path:/tmp/pip-np0fo_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:38:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:38:02 INFO - Running setup.py (path:/tmp/pip-jC0AhE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:38:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:38:02 INFO - Running setup.py (path:/tmp/pip-ZzCjeM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:38:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:38:02 INFO - Running setup.py (path:/tmp/pip-yXtyvi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:38:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:38:02 INFO - Running setup.py (path:/tmp/pip-6pHU9v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:38:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:38:02 INFO - Running setup.py (path:/tmp/pip-065JG7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:38:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:38:03 INFO - Running setup.py (path:/tmp/pip-xtAzsG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:38:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:38:03 INFO - Running setup.py (path:/tmp/pip-8akFGd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:38:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:38:03 INFO - Running setup.py (path:/tmp/pip-TGVpmF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:38:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:38:03 INFO - Running setup.py (path:/tmp/pip-KkcjYG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:38:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:38:03 INFO - Running setup.py install for manifestparser 16:38:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:38:03 INFO - Running setup.py install for mozcrash 16:38:03 INFO - Running setup.py install for mozdebug 16:38:03 INFO - Running setup.py install for mozdevice 16:38:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:38:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:38:03 INFO - Running setup.py install for mozfile 16:38:03 INFO - Running setup.py install for mozhttpd 16:38:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:38:03 INFO - Running setup.py install for mozinfo 16:38:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:38:04 INFO - Running setup.py install for mozInstall 16:38:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:38:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:38:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:38:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:38:04 INFO - Running setup.py install for mozleak 16:38:04 INFO - Running setup.py install for mozlog 16:38:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:38:04 INFO - Running setup.py install for moznetwork 16:38:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:38:04 INFO - Running setup.py install for mozprocess 16:38:04 INFO - Running setup.py install for mozprofile 16:38:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:38:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:38:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:38:04 INFO - Running setup.py install for mozrunner 16:38:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:38:04 INFO - Running setup.py install for mozscreenshot 16:38:04 INFO - Running setup.py install for moztest 16:38:04 INFO - Running setup.py install for mozversion 16:38:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:38:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:38:05 INFO - Cleaning up... 16:38:05 INFO - Return code: 0 16:38:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:05 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 0x7ff4245f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f07600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f96350>, '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 0x1f97250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f976e0>, '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': 'cbe409c6de289db6ac707de3000001d4-1453508479.483616-2145164124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:38:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:38:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:38:05 INFO - Using env: {'DISPLAY': ':0', 16:38:05 INFO - 'HOME': '/home/cltbld', 16:38:05 INFO - 'LANG': 'en_US.UTF-8', 16:38:05 INFO - 'LANGUAGE': 'en_US:en', 16:38:05 INFO - 'LOGNAME': 'cltbld', 16:38:05 INFO - 'MAIL': '/var/mail/cltbld', 16:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:05 INFO - 'MOZ_NO_REMOTE': '1', 16:38:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:05 INFO - 'NO_EM_RESTART': '1', 16:38:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:38:05 INFO - 'PWD': '/builds/slave/test-pgo', 16:38:05 INFO - 'SHELL': '/bin/bash', 16:38:05 INFO - 'SHLVL': '1', 16:38:05 INFO - 'TERM': 'linux', 16:38:05 INFO - 'TMOUT': '86400', 16:38:05 INFO - 'USER': 'cltbld', 16:38:05 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453508479.483616-2145164124', 16:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:05 INFO - '_': '/tools/buildbot/bin/python'} 16:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:38:05 INFO - Running setup.py (path:/tmp/pip-GYFvDI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:38:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 16:38:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:38:05 INFO - Running setup.py (path:/tmp/pip-IJsFTg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:38:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:38:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:38:05 INFO - Running setup.py (path:/tmp/pip-RQ2iw3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:38:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 16:38:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:38:05 INFO - Running setup.py (path:/tmp/pip-dbI7Tl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:38:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:38:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:38:05 INFO - Running setup.py (path:/tmp/pip-gU11P2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:38:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 16:38:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:38:05 INFO - Running setup.py (path:/tmp/pip-LNbRED-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:38:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 16:38:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:38:05 INFO - Running setup.py (path:/tmp/pip-SYthJN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:38:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 16:38:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:38:05 INFO - Running setup.py (path:/tmp/pip-7sMuVI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:38:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 16:38:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:38:05 INFO - Running setup.py (path:/tmp/pip-JlMp98-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:38:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 16:38:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:38:05 INFO - Running setup.py (path:/tmp/pip-dvVWRM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:38:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:38:06 INFO - Running setup.py (path:/tmp/pip-2XCkJ_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 16:38:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:38:06 INFO - Running setup.py (path:/tmp/pip-Mo9z2x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 16:38:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:38:06 INFO - Running setup.py (path:/tmp/pip-n4ALZ6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 16:38:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:38:06 INFO - Running setup.py (path:/tmp/pip-XdJehk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 16:38:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:38:06 INFO - Running setup.py (path:/tmp/pip-KuQ5gi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 16:38:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:38:06 INFO - Running setup.py (path:/tmp/pip-XEMTc1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 16:38:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:38:06 INFO - Running setup.py (path:/tmp/pip-E2kMWj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 16:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 16:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:38:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:08 INFO - Downloading blessings-1.6.tar.gz 16:38:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:38:08 INFO - Installing collected packages: blessings 16:38:08 INFO - Running setup.py install for blessings 16:38:08 INFO - Successfully installed blessings 16:38:08 INFO - Cleaning up... 16:38:08 INFO - Return code: 0 16:38:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:38:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:38:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:38:08 INFO - Reading from file tmpfile_stdout 16:38:08 INFO - Current package versions: 16:38:08 INFO - argparse == 1.2.1 16:38:08 INFO - blessings == 1.6 16:38:08 INFO - blobuploader == 1.2.4 16:38:08 INFO - docopt == 0.6.1 16:38:08 INFO - manifestparser == 1.1 16:38:08 INFO - mozInstall == 1.12 16:38:08 INFO - mozcrash == 0.16 16:38:08 INFO - mozdebug == 0.1 16:38:08 INFO - mozdevice == 0.47 16:38:08 INFO - mozfile == 1.2 16:38:08 INFO - mozhttpd == 0.7 16:38:08 INFO - mozinfo == 0.9 16:38:08 INFO - mozleak == 0.1 16:38:08 INFO - mozlog == 3.1 16:38:08 INFO - moznetwork == 0.27 16:38:08 INFO - mozprocess == 0.22 16:38:08 INFO - mozprofile == 0.27 16:38:08 INFO - mozrunner == 6.11 16:38:08 INFO - mozscreenshot == 0.1 16:38:08 INFO - mozsystemmonitor == 0.0 16:38:08 INFO - moztest == 0.7 16:38:08 INFO - mozversion == 1.4 16:38:08 INFO - psutil == 3.1.1 16:38:08 INFO - requests == 1.2.3 16:38:08 INFO - wsgiref == 0.1.2 16:38:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:08 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 0x7ff4245f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f07600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f96350>, '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 0x1f97250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f976e0>, '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': 'cbe409c6de289db6ac707de3000001d4-1453508479.483616-2145164124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:38:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 16:38:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:38:08 INFO - Using env: {'DISPLAY': ':0', 16:38:08 INFO - 'HOME': '/home/cltbld', 16:38:08 INFO - 'LANG': 'en_US.UTF-8', 16:38:08 INFO - 'LANGUAGE': 'en_US:en', 16:38:08 INFO - 'LOGNAME': 'cltbld', 16:38:08 INFO - 'MAIL': '/var/mail/cltbld', 16:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:08 INFO - 'MOZ_NO_REMOTE': '1', 16:38:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:08 INFO - 'NO_EM_RESTART': '1', 16:38:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:38:08 INFO - 'PWD': '/builds/slave/test-pgo', 16:38:08 INFO - 'SHELL': '/bin/bash', 16:38:08 INFO - 'SHLVL': '1', 16:38:08 INFO - 'TERM': 'linux', 16:38:08 INFO - 'TMOUT': '86400', 16:38:08 INFO - 'USER': 'cltbld', 16:38:08 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453508479.483616-2145164124', 16:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:08 INFO - '_': '/tools/buildbot/bin/python'} 16:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 16:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 16:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 16:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 16:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 16:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 16:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 16:38: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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:38: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 mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 16:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:38:08 INFO - Cleaning up... 16:38:08 INFO - Return code: 0 16:38:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:08 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 0x7ff4245f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f07600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f96350>, '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 0x1f97250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f976e0>, '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': 'cbe409c6de289db6ac707de3000001d4-1453508479.483616-2145164124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:38:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 16:38:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:38:08 INFO - Using env: {'DISPLAY': ':0', 16:38:08 INFO - 'HOME': '/home/cltbld', 16:38:08 INFO - 'LANG': 'en_US.UTF-8', 16:38:08 INFO - 'LANGUAGE': 'en_US:en', 16:38:08 INFO - 'LOGNAME': 'cltbld', 16:38:08 INFO - 'MAIL': '/var/mail/cltbld', 16:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:08 INFO - 'MOZ_NO_REMOTE': '1', 16:38:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:08 INFO - 'NO_EM_RESTART': '1', 16:38:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:38:08 INFO - 'PWD': '/builds/slave/test-pgo', 16:38:08 INFO - 'SHELL': '/bin/bash', 16:38:08 INFO - 'SHLVL': '1', 16:38:08 INFO - 'TERM': 'linux', 16:38:08 INFO - 'TMOUT': '86400', 16:38:08 INFO - 'USER': 'cltbld', 16:38:08 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453508479.483616-2145164124', 16:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:08 INFO - '_': '/tools/buildbot/bin/python'} 16:38:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:09 INFO - Downloading/unpacking jsonschema 16:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:38:11 INFO - Downloading/unpacking functools32 (from jsonschema) 16:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:11 INFO - Downloading functools32-3.2.3-2.tar.gz 16:38:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:38:11 INFO - warning: no files found matching '*.txt' 16:38:11 INFO - no previously-included directories found matching 'build' 16:38:11 INFO - no previously-included directories found matching 'dist' 16:38:11 INFO - no previously-included directories found matching '.git*' 16:38:11 INFO - Installing collected packages: jsonschema, functools32 16:38:11 INFO - Running setup.py install for functools32 16:38:11 INFO - warning: no files found matching '*.txt' 16:38:11 INFO - no previously-included directories found matching 'build' 16:38:11 INFO - no previously-included directories found matching 'dist' 16:38:11 INFO - no previously-included directories found matching '.git*' 16:38:11 INFO - Successfully installed jsonschema functools32 16:38:11 INFO - Cleaning up... 16:38:11 INFO - Return code: 0 16:38:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4245f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f07600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f96350>, '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 0x1f97250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f976e0>, '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': 'cbe409c6de289db6ac707de3000001d4-1453508479.483616-2145164124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:38: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', 'flake8'] in /builds/slave/test-pgo/build 16:38: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 flake8 16:38:11 INFO - Using env: {'DISPLAY': ':0', 16:38:11 INFO - 'HOME': '/home/cltbld', 16:38:11 INFO - 'LANG': 'en_US.UTF-8', 16:38:11 INFO - 'LANGUAGE': 'en_US:en', 16:38:11 INFO - 'LOGNAME': 'cltbld', 16:38:11 INFO - 'MAIL': '/var/mail/cltbld', 16:38:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:11 INFO - 'MOZ_NO_REMOTE': '1', 16:38:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:11 INFO - 'NO_EM_RESTART': '1', 16:38:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:38:11 INFO - 'PWD': '/builds/slave/test-pgo', 16:38:11 INFO - 'SHELL': '/bin/bash', 16:38:11 INFO - 'SHLVL': '1', 16:38:11 INFO - 'TERM': 'linux', 16:38:11 INFO - 'TMOUT': '86400', 16:38:11 INFO - 'USER': 'cltbld', 16:38:11 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453508479.483616-2145164124', 16:38:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:11 INFO - '_': '/tools/buildbot/bin/python'} 16:38:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:11 INFO - Downloading/unpacking flake8 16:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:38:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:38: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 16:38: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 16:38: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 16:38: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 16:38: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 16:38: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 16:38:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:38:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:38: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 16:38: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 16:38: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 16:38: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 16:38: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 16:38: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 16:38:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:38: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 16:38: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 16:38: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 16:38: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 16:38: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 16:38: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 16:38:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:38:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:38:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:38:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:38:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:38:14 INFO - no previously-included directories found matching 'docs/_build' 16:38:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:38:14 INFO - Running setup.py install for pep8 16:38:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:38:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:38:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:38:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:38:14 INFO - no previously-included directories found matching 'docs/_build' 16:38:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:38:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:38:14 INFO - Cleaning up... 16:38:14 INFO - Return code: 0 16:38:14 INFO - Running post-action listener: _resource_record_post_action 16:38:14 INFO - Running post-action listener: _start_resource_monitoring 16:38:14 INFO - Starting resource monitoring. 16:38:14 INFO - ##### 16:38:14 INFO - ##### Running install step. 16:38:14 INFO - ##### 16:38:14 INFO - Running pre-action listener: _resource_record_pre_action 16:38:14 INFO - Running main action method: install 16:38:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:38:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:38:14 INFO - Reading from file tmpfile_stdout 16:38:14 INFO - Detecting whether we're running mozinstall >=1.0... 16:38:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:38:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:38:14 INFO - Reading from file tmpfile_stdout 16:38:14 INFO - Output received: 16:38:14 INFO - Usage: mozinstall [options] installer 16:38:14 INFO - Options: 16:38:14 INFO - -h, --help show this help message and exit 16:38:14 INFO - -d DEST, --destination=DEST 16:38:14 INFO - Directory to install application into. [default: 16:38:14 INFO - "/builds/slave/test-pgo"] 16:38:14 INFO - --app=APP Application being installed. [default: firefox] 16:38:14 INFO - mkdir: /builds/slave/test-pgo/build/application 16:38:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 16:38:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 16:38:29 INFO - Reading from file tmpfile_stdout 16:38:29 INFO - Output received: 16:38:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:38:29 INFO - Running post-action listener: _resource_record_post_action 16:38:29 INFO - ##### 16:38:29 INFO - ##### Running run-tests step. 16:38:29 INFO - ##### 16:38:29 INFO - Running pre-action listener: _resource_record_pre_action 16:38:29 INFO - Running main action method: run_tests 16:38:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:38:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:38:29 INFO - Python 2.7.3 16:38:29 INFO - Return code: 0 16:38:29 INFO - grabbing minidump binary from tooltool 16:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:29 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 0x1f96350>, '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 0x1f97250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f976e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:38:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 16:38:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:38:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:38:29 INFO - Return code: 0 16:38:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:38:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:38:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:38:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:38:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:38:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:38:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:38:31 INFO - Return code: 0 16:38:31 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/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 16:38:31 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/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost 16:38:31 INFO - Using env: {'DISPLAY': ':0', 16:38:31 INFO - 'HOME': '/home/cltbld', 16:38:31 INFO - 'LANG': 'en_US.UTF-8', 16:38:31 INFO - 'LANGUAGE': 'en_US:en', 16:38:31 INFO - 'LOGNAME': 'cltbld', 16:38:31 INFO - 'MAIL': '/var/mail/cltbld', 16:38:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:38:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:38:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:31 INFO - 'MOZ_NO_REMOTE': '1', 16:38:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:38:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:31 INFO - 'NO_EM_RESTART': '1', 16:38:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:38:31 INFO - 'PWD': '/builds/slave/test-pgo', 16:38:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:38:31 INFO - 'SHELL': '/bin/bash', 16:38:31 INFO - 'SHLVL': '1', 16:38:31 INFO - 'TERM': 'linux', 16:38:31 INFO - 'TMOUT': '86400', 16:38:31 INFO - 'USER': 'cltbld', 16:38:31 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1453508479.483616-2145164124', 16:38:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:31 INFO - '_': '/tools/buildbot/bin/python'} 16:38:31 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/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost'] with output_timeout 3600 16:38:31 INFO - mozversion INFO | application_buildid: 20160122140553 16:38:31 INFO - mozversion INFO | application_changeset: 1fa9b8e51c285b27bf7730655d7c0385d83383f8 16:38:31 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 16:38:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:38:31 INFO - mozversion INFO | application_name: Firefox 16:38:31 INFO - mozversion INFO | application_remotingname: firefox-dev 16:38:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:38:31 INFO - mozversion INFO | application_vendor: Mozilla 16:38:31 INFO - mozversion INFO | application_version: 45.0a2 16:38:31 INFO - mozversion INFO | platform_buildid: 20160122140553 16:38:31 INFO - mozversion INFO | platform_changeset: 1fa9b8e51c285b27bf7730655d7c0385d83383f8 16:38:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:38:31 INFO - mozversion INFO | platform_version: 45.0a2 16:38:31 INFO - 2016-01-22 16:38:31,247 DEBUG : using testdate: 1453509511 16:38:31 INFO - 2016-01-22 16:38:31,247 DEBUG : actual date: 1453509511 16:38:31 INFO - 2016-01-22 16:38:31,256 INFO : starting webserver on 'localhost:36521' 16:38:31 INFO - 2016-01-22 16:38:31,257 INFO : Starting test suite talos-linux64-ix-054 16:38:31 INFO - 2016-01-22 16:38:31,257 INFO : Starting test dromaeo_css 16:38:31 INFO - 2016-01-22 16:38:31,257 DEBUG : operating with platform_type : linux_ 16:38:31 INFO - 2016-01-22 16:38:31,258 INFO : Initialising browser for dromaeo_css test... 16:38:31 INFO - 2016-01-22 16:38:31,274 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpq0rloi/profile http://localhost:36521/getInfo.html 16:38:35 INFO - 2016-01-22 16:38:35,420 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:38:35 INFO - 2016-01-22 16:38:35,420 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:38:35 INFO - 2016-01-22 16:38:35,420 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:38:35 INFO - 2016-01-22 16:38:35,420 DEBUG : BROWSER_OUTPUT: __metrics 16:38:35 INFO - 2016-01-22 16:38:35,590 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] 16:38:36 INFO - 2016-01-22 16:38:36,392 INFO : Browser initialized. 16:38:36 INFO - 2016-01-22 16:38:36,392 INFO : Running cycle 1/1 for dromaeo_css test... 16:38:36 INFO - 2016-01-22 16:38:36,393 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpq0rloi/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:38:48 INFO - 2016-01-22 16:38:48,223 DEBUG : BROWSER_OUTPUT: RSS: Main: 137117696 16:38:48 INFO - 2016-01-22 16:38:48,224 DEBUG : BROWSER_OUTPUT: 16:39:39 INFO - 2016-01-22 16:39:39,796 DEBUG : BROWSER_OUTPUT: 1453509579793 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:41:47 INFO - 2016-01-22 16:41:47,189 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36521/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36521/tests/dromaeo/cssquery-ext.html) 16:41:48 INFO - 2016-01-22 16:41:48,304 DEBUG : BROWSER_OUTPUT: RSS: Main: 248795136 16:41:48 INFO - 2016-01-22 16:41:48,304 DEBUG : BROWSER_OUTPUT: 16:44:50 INFO - 2016-01-22 16:44:50,469 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36521/tests/dromaeo/cssquery-ext.html (next: http://localhost:36521/tests/dromaeo/cssquery-jquery.html) 16:44:51 INFO - 2016-01-22 16:44:51,034 DEBUG : BROWSER_OUTPUT: RSS: Main: 214474752 16:44:51 INFO - 2016-01-22 16:44:51,035 DEBUG : BROWSER_OUTPUT: 16:47:52 INFO - 2016-01-22 16:47:52,824 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36521/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36521/tests/dromaeo/cssquery-mootools.html) 16:47:53 INFO - 2016-01-22 16:47:53,386 DEBUG : BROWSER_OUTPUT: RSS: Main: 213942272 16:47:53 INFO - 2016-01-22 16:47:53,386 DEBUG : BROWSER_OUTPUT: 16:50:55 INFO - 2016-01-22 16:50:55,169 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36521/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36521/tests/dromaeo/cssquery-prototype.html) 16:50:55 INFO - 2016-01-22 16:50:55,738 DEBUG : BROWSER_OUTPUT: RSS: Main: 199634944 16:50:55 INFO - 2016-01-22 16:50:55,738 DEBUG : BROWSER_OUTPUT: 16:53:58 INFO - 2016-01-22 16:53:58,122 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36521/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36521/tests/dromaeo/cssquery-yui.html) 16:53:58 INFO - 2016-01-22 16:53:58,704 DEBUG : BROWSER_OUTPUT: RSS: Main: 200916992 16:53:58 INFO - 2016-01-22 16:53:58,704 DEBUG : BROWSER_OUTPUT: 16:57:00 INFO - 2016-01-22 16:57:00,919 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36521/tests/dromaeo/cssquery-yui.html (next: http://localhost:36521/tests/dromaeo/cssquery-dojo.html) 16:57:01 INFO - 2016-01-22 16:57:01,169 DEBUG : BROWSER_OUTPUT: RSS: Main: 241954816 16:57:01 INFO - 2016-01-22 16:57:01,170 DEBUG : BROWSER_OUTPUT: 16:57:01 INFO - 2016-01-22 16:57:01,171 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:57:01 INFO - 2016-01-22 16:57:01,171 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:57:01 INFO - 2016-01-22 16:57:01,171 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:57:01 INFO - 2016-01-22 16:57:01,171 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:57:01 INFO - 2016-01-22 16:57:01,173 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3167.588213532241;3221.8550165242564;3255.4465740824057;3259.3481303739245;3274.3614995075955;5360.517553420192;5394.946050539504;5400.810971615994;5409.540189083923;5435.673859568428;5496.587755918302;5517.36550296716;5520.861978450541;5531.585131115163;5548.528375088113;4992.700437973715;5036.899262014757;5070.1380765269805;5102.260172275018;5104.617153713468;5017.147084995559;5036.697798132123;5046.369203849519;5107.361579802525;5123.385193776752;5070.340855688755;5148.613853960968;5152.768125434346;5154.175331946889;5158.896822063556;5053.216751403538;5117.334746482933;5125.077486052509;5154.4587818278915;5199.792008319662;4840.419149702023;4849.903001939977;4954.405471343462;4960.553550180465;5033.245013248005;5397.082495975694;5398.028354896117;5398.811041613564;5401.432849550819;5402.027635025694;5959.0763431668165;6019.879602407971;6023.608465449732;6024.578279520435;6045;5805.303363596396;5836.708164591753;5872.324682661506;5898.233229680114;5951.3751056139345;5540.556755459554;5542.889142217214;5543.501084902378;5546.251256080418;5574.777008919638;5825.854353641193;6086.573939824169;6093.6039157454625;6095.2685677718955;6096.603720758137;5754.5971781975695;5774.971125144431;5821.039528477839;5821.621594596338;5858.121281807677;5866.853328666817;5870.236869207061;5871.706414679335;5881.735321910439;5972.104184372379;5693.28833895763;5793.333766616893;5847.152162936351;5850.268716410449;5860.736266868002;5892.6759028253855;5956.940430595725;5958.880822383528;5967.76128954837;6001.789937352259;4540.568645978627;4547.454305483297;4587;4587.197240482902;4614.653900957442;4001.9799901000893;4015.678745700337;4086.570910054461;4092.3656833190903;4104.384342348671;5601.355844077902;5689;5708.971455142698;5711.7144142792695;5718.828435146952;6038.698065096728;6068.089786531968;6068.150458935665;6084.30030546484;6087.69561521931;5422.8915421691345;5524.502794748411;5603.299587551556;5629.4652008059165;5684.204211410406;5266.21006848968;5296;5296.735163241822;5297.867553311198;5302.151655735064;6188.381161883865;6192.783252586138;6193.102000209944;6195.039768835838;6207.5654704171175;5719.685417302088;5802.6808525531505;6005.219321488178;6085.878282434415;6108.786192483241;6157.730091652496;6166.938330616816;6169.2288463942;6177.505799535937;6181.690915454119;5660.490555849993;5977.565384307822;5999.310079340931;6000.129981152621;6030.849228769316;5840.94159058404;5907.822765317047;5921.7631294747725;5934.525237980864;5958.702064896825;5864.296284445893;5905.793297234576;5906.852328691817;5914.172015917861;5963.612365196248;5732.082866741302;5834.649921004753;5899.764009439746;5900.085486749561;5911.7635294587735;5729.799457018984;5791.536677065909;5821.476067153976;5822.446867547576;5830.62100963436;5881.705914704162;5913.852153696192;5919;5920.79277225295;5929.762809487572;5560.360558535658;5744.339400968942;5782.45066718661;5784.595078344475;5814.767409303749 16:57:01 INFO - 2016-01-22 16:57:01,174 DEBUG : BROWSER_OUTPUT: |1;ext.html;598.2521847690386;632.149758574717;636.0237036149512;644.6390021587911;647.488484097563;33497;34523.65476345236;34531.654683453155;38756.418653720146;39648.405273920915;45678.54321456784;46033.53966460334;46281.768591157;46356.768216158955;46364;8981.461112333282;9196.816063678756;9217.216536594398;9217.493037882947;9220.815583688322;8250.958745206266;8421.747347579552;10808.135349172047;11020.063294619968;11041.503132359063;10786.298890572127;10835.349879007246;10909.945450272737;10910.890891091067;10923.126149908028;8212.46618969765;8349.707760228363;10536.209784266171;10568.841467377995;10571.577136914515;10707.304025238334;10966.342019478856;10967.561297548169;10968.067714244298;10978;42548.14903701909;42927;43015.35476967848;43031;43047.56952430467;3095.9690403095906;3136.2002689314077;3161.65221825599;3178.2372230664473;3179.666135055809;32301;32422.6757732422;32449.6755032449;32594.674053259638;32710.836445817855;3091.984540077308;3100.224943764059;3112.7588136541654;3123.687631236881;3141.9528707069185;297414;298226;298972;299012;299184.5040774804;56603;57875;62659.37340626626;62918;63068.68465657642;70906.64546677233;71261;71631.64184179046;71881.6405917967;71937.28062719411;16470.505884823473;16578.253978570992;16727.749083763752;16774.83225167757;16952.74570881438;12034.759304813855;12102.213356131822;12107.091968102428;12197.573084941985;12211.450484728031;19971.900140499205;20268.59462810765;20308.08613612391;20398.796012039988;20442.897785510977;8073.273405393543;8341.791455213546;8395.496270223684;8439.662413503514;8481.872771908425;1042.7862288231047;1066.973325666849;1104.679642903565;1141.5034460009922;1144.1247445704043;29217.561736573967;29747;29751.70248297489;30049.248768780955;30182.09453716392;1030.299396410433;1070.6734445994045;1091.912646988239;1111.2110401614782;1181.4092953523239;13732.86267137316;13953.581392558239;14025.929870350583;15892.602684932737;16671.99968001924;339653;344439;345174;345658;348615;56700.716496417255;56976.71511642415;57104;57124.71437642868;57196.71401642965;1437.3388241409068;1442.7186698593673;1459.9416023358947;1462.385797964836;1479.4747864507945;29952.70047299499;30011.099667010025;30587.54118688177;30836.69163308338;30947.535786962762;48606;49009.50990490049;49036.75481622569;49053.264201037724;49111.75444122757;316166;316778;317884;318490;318796;29650.258743531584;50142.24786628276;50440;50962.74518627383;51649.225261620355;49159.26261106015;50148;50699;51320.74339628278;51448;40997.59002409938;41542.37686434646;41594.168116636894;42008.78995605002;42464.36303455512;35859.46210806788;41682.58317416787;41953;44166;45782.771086144356;41405;41982.37026444667;45772.7711361441;45988;46165.76917115393;36518;37109.25781484301;37327;38836;39300.2139957205;27902.30244243829;28751.281217969718;28830.279243018253;29073.7092629071;29085.7091429083 16:57:01 INFO - 2016-01-22 16:57:01,175 DEBUG : BROWSER_OUTPUT: |2;jquery.html;389.4314301120364;390.4670125278993;394.24502078519635;396.99206015879685;398.509832905526;13907.1295728439;17770.289188432445;17892.821071789294;19241.903790481047;19252.13365398557;17332.913335433335;17776.11119444029;17805.287788488444;17807;18133.546661333472;5070.619703522232;5167.276581278624;5176.948230517703;5184.611154163434;5191.351081114861;4019.839206431739;4126.546079931205;5108.310378098946;5537.252470916415;5763.596548241625;5684.4315568443035;5687.118496633028;5696.829095127132;5706.3722990471015;5744.741486633091;5827.242458480391;6247.5939063960695;6269;6272.937270627281;6274.623522588659;5567.415421380737;5651.886962260732;5653.293338332708;5669;5684.602077854552;13851.51519696816;13875.375608097558;17263.482095537154;22337.32988010362;22582.096716131335;2250.696156018933;2319.8028167605603;2335.718479742838;2374.3233178544206;2385.2367242482414;10001.949990250076;10272.794544109076;10282.177425805918;10294.7426314342;10323.432211228379;1910.522369407648;1942.4464027752165;1942.7765806932243;1943.9708404373946;1994.4914046918088;65368.34631653718;66174.66912665454;66998.66500667515;68078.65960670165;68866;10787.352758834495;10954.287971281841;10980.725481862857;11027.44862756859;11045.447727613588;14534.636634084021;14750.778738318933;14763;14782.26088695561;14803.851961480463;7825.843483130419;7834.804129896685;7988;8038;8051.718189863327;7434;7485.625718714043;7516.962415187889;7524.209957954446;7535.660895259726;4672.275797251432;4713.74074425903;4718.95281047192;4729.172394830891;4767.833125840648;1697.2787393747387;1792.345793785259;1895.4218963216351;1940.0590713503939;1940.3596813051659;485.9684120532154;894.9731508054768;1041.0162396535202;1082.6643740440331;1122.1583812140893;9805.460699661444;10559.313644613076;10992.17558683102;11054.889451105546;11120.38837863909;469.53985094607475;472.17605278788045;473.5288388053908;477.7658947115888;492.78071258290436;6181.567290289637;6265.342139075423;6351.110844481776;6410.262819775786;6421.197350331208;643216;649762;654226;664742;680372;77860;78114;87101;87101.12898871057;87624;1175.5767923547517;1189.8420347792417;1195.3963248559596;1206.1617176062553;1210.0501106631252;16514.489483159836;16564.503064908073;16581.253843576826;16647.334106636084;16841.9894806312;37159.81420092882;37214.62785372112;37291.44062839005;37417.625823741415;37888.24223515459;48269.275960859915;50248;53155.202671960724;53703.19445208247;55268.44731552633;9483.383580067273;9552.522373881417;9714.75713107178;9752.756181095529;9833.754156146153;11580.88419115798;11818.290902545874;14345;17697.115144242995;18085.186166622796;14715.264236787903;14978.700425991638;15082.17048062367;15329.156896370807;15382.92308538495;14659.267036648338;14803.481878134213;14976;15387.61530961735;15402.69194616079;15253.16107614092;15330;15575;15579.298931548334;15941.521754347388;9879.851802223116;10355.94822025885;10386.532606032897;10658.467076646291;10751.731206719895;10642.73393165177;14841;14885.106893586419;14887.925560372129;15280.388784448498 16:57:01 INFO - 2016-01-22 16:57:01,177 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1366.2758737868933;1500.1824005916774;1510.1090356689551;1825.6622524832908;1825.99087004565;7192.856142877139;8181.3045891099255;8336.791580210498;8357.038940521841;8358.205970432815;8276.131006244348;8407.495550266989;8448.493090414579;8449.155084491547;8463.788405289872;2056.2083597814876;2088.112552165331;2324.744278129413;2409.6265078912797;2441.9633705494343;2387.5224955009066;2391.6412538119334;2392.425817803732;2393.9162129325478;2394.760523947609;2358.469344397505;2403.567357875582;2420.5884999550117;2423;2425.527022230666;2388.080588973249;2396.2571602803187;2428.2351059416314;2429.307647320523;2431.161249368965;2422.563938491071;2447.229122826304;2451.82837201396;2453.3498622864954;2478.1698131126095;8386.3710221733;8399.496030238144;8463.915360846375;8481.19428654283;8489.575521223976;5013.774380152902;5086.262491938648;5113.744312784346;5124.359455068116;5132.794688212467;3201.15169480088;3219.645838957713;3274.9672503275137;3308.040668206217;3308.4044871923043;1018.6332920148741;1019.4851599941982;1034.0383443397636;1037.165082108902;1037.362022356253;11602.825957610643;11630.360330181837;11636.94181529087;11643.53425862973;11660.591879284184;4579.793909274091;4623.653226008063;4646.581807637262;4670.299455081697;4681.976590117028;9877.950610246902;9894.455804930654;9900.900990990142;9907.80184396308;9922.454265015349;5143.12566863634;5146.176611742103;5149.7940082397035;5161.535461808456;5169.68981861082;4589.311603259538;4638.744869032235;4641.675082744243;4646.233371493733;4653.022865198279;3414.778039427429;3464.272502774395;3924.843006279774;3976.1053762903693;4000;1272.8599854016052;1278.9744205115846;1291.599604122725;1304.3478260869565;1316.440512782083;1103.6302838549016;1103.7626910214342;1330.6141219046563;1370.2326697049684;1401.516476815497;7898.091719452336;8011.118776934532;8017.078036025931;8023;8029.156938521488;1136.1762722026465;1143.5825923537848;1144.7882141803793;1147.5639257082423;1152.4871432212753;6183.81448556535;6255.437010669061;6266.49868010558;6271.247450305901;6279.152314437584;9719.56261968213;10137.391756494486;10140.847887281696;10141.340812847142;10225.744356391;9838.557264923096;9966.20270378368;10102.898971010343;10111.292209545261;10124.088832005154;7888.053433588007;7957.920420795718;7978.122406535276;7980.561069141137;7982.401319901031;7477.887831682638;7566.735164269224;7567.508111972704;7569.697212111454;7592.8861067082935;8728.869066963875;8840.115988401109;9040.547972601475;9052.547372631474;9069.319801015083;9118.589663465293;9171.724848254564;9290.6283748652;9297.628094876129;9456.2907781918;6391.936080639134;7190.784276471714;7290.854182916418;7292.453066019963;7295.379892709179;7540.9622951884885;7603.391728661583;7777.883331750141;7797.220277972384;7797.454178207471;7285.125784905846;7556.206598307319;7558.886616700644;7619.199984001822;7665.271799179069;7443.404527637885;7488.925110749041;7493.400527957641;7520.962395187989;7556.055493063367;7448.590327532038;7466.962665186639;7489.962550187214;7505.924940750522;7526.397888169043;6696.19645642526;6725.092112564741;6747.696353663999;6756.966215168893;6757.86484270302;6638.701258443478;6861.485388595976;6862.451003919774;6863.347981941708;6878.484113691593 16:57:01 INFO - 2016-01-22 16:57:01,177 DEBUG : BROWSER_OUTPUT: |4;prototype.html;375.3862434918907;380.4179605204039;381.6469765466944;384.9018500282427;388.0299251870324;6026.608270462417;6068.059450785136;6079.996800527908;6081.4222648848345;6088.995315772892;5782.710864456771;5850.970745146268;5896.646201227929;5986.970065149668;6000.789972350958;4702.05958808238;4724.5984091352275;4734.668573199878;4746.810127594892;4758.310045043467;4505.617022553087;4731.101090792756;4732.077244937239;4732.550407711262;4742.027884283731;4541.114482675879;4573.131105090039;4645.628349732014;4653.929596192877;4670.042641258551;4620.122176786416;4669.136209801164;4698.38920940279;4699.389079419688;4713.198756211452;4181.310083836163;4183.309753890604;4184.7070705050655;4188.4136220929095;4190.874273771761;5684.261046064026;5741.3110426748635;5741.511971482429;5750.108733146369;5750.2237197978575;5501.202325662756;5505.3393592768725;5507.697076660782;5507.834764957058;5509.972450137764;6457.935420645827;6460.3862633049785;6467.159269294962;6468.417842394207;6468.547201695883;4627.976860115711;4629.86110416688;4631.791569379386;4637.350770892078;4644.8374306899095;6499.155109835739;6593.835154121138;6646.936490161551;6647.800565983028;6652.600843949379;4792.9281060784115;4815.7351345676325;4818.831340903052;4822.397200349957;4823.614110871122;4873.342098816685;4875.68308059975;4879.26810978349;4881.682690625169;4887.462379138292;5424.457554244544;5493.423190565013;5501.229827824108;5501.724913754297;5503.532199763065;6456.903146452807;6478.805635830932;6482;6485.67571621417;6486.091947127406;1699.7110491216522;1715.5110793423814;1716.0132923568997;1716.5451155443818;1716.7339062445092;1175.3946717440524;1181.9645410637695;1187.9940600296943;1190.6428071578491;1206.9758604827855;6255.749770009149;6256.155419018465;6257.124002639634;6276.529260305404;6278.874422511524;6497.740090396425;6682.164729408824;6691.698873550702;6691.7323307068145;6693.564918280296;6204;6237.251529816361;6324.841878953063;6327.272363678236;6350.4284614384005;3599.3161299353037;3623.547056617923;3633.255182687543;3636.818159092035;3641.7268704847243;6733.494987875831;6886.758963436256;6887.690053947585;6891.448684105259;6902.654867256617;6874.759383421556;6883.070785443901;6884.208316043619;6887.758928437581;6896.931030689629;6764.019217213575;6768.289329620417;6769.492288078413;6771.864562708817;6782.084418603524;6617.106690596708;6712.6979285931275;6727.428168605723;6729.394354507922;6735.292794256533;6571.145751052332;6631.137952066393;6631.568948018364;6636.43590294811;6638.767643132467;6833.555818871758;6869.072675188786;6871.690773915286;6877.071595334566;6887.414569761627;4700.153972285021;4780.4741478436645;4785.545373189541;4791.784369703441;4794.496577859414;6724.991251312146;6731.427828634425;6734.831629209309;6740.528163028541;6743.629100399525;6490.837729056811;6506.284308726131;6548.410643041959;6556.147700798866;6565;6445.2265728112925;6534.150560427114;6541.378569035934;6542.149520562297;6543.345665433419;6423.807285781434;6426.582272152295;6430.131932189094;6434.420902118832;6444.806655800334;6557;6561.475081993524;6561.540692151503;6563.704633291609;6567.277599464151;6319.715612797343;6406.327335629691;6410.262819775786;6417.582857114273;6421.261554921244 16:57:01 INFO - 2016-01-22 16:57:01,178 DEBUG : BROWSER_OUTPUT: |5;yui.html;713.3971793834211;775.5966897213449;787.858185526605;790.9485883417574;804.2520455975941;13467.259300738455;13790.103643263194;13791.862081379184;13823.65440863979;13828.792568111487;12349.62951111466;12910.419031143598;12915.870841291608;12921.935390323035;12931.676708082303;769.8229407236339;772.5210369570846;912.1061359867334;912.8219997100568;936.129399658321;927.5686805635378;928.7399528132133;933.9486328251943;934.5093825741507;934.7102398256562;781.238292664653;964.1033838530165;964.4502633498909;968.7335982604804;969.1616751509964;768.4006474949548;769.4882902869585;770.0759089093111;770.8920751094823;943.8725772020758;715.8174665460326;722.50869408802;722.6350692900104;722.8373615936425;724.380654540371;12543.372831358487;12673.683157921034;12715.618531444072;12723.872761272454;12727.681807954783;12387.62837114888;12936.935315323362;13123.803142952864;13149.60551183466;13188.340582970814;10122.645707400206;10186.439745813977;10223.897761022368;10316.58733650653;10389.79220415595;3731.328360895038;3807.695384369244;3815.6947444204675;3817.618238176188;3819.579846216914;48549.27176092361;49268.75365623149;50046;50566;50584;9652.90347096534;9725.513724313756;9745.65890193854;9762.75593110178;9765.853512197322;18980.43058708241;19173.233070677295;19180.904095479433;19219.32732354361;19317.61364772697;7418.480706350504;7614.885776713354;7642.312191902755;7711.845763084707;7902.3678105751405;4530.524294948983;4566.337881007235;4581.931271030937;4642.9535704643195;4664.323673067454;3224.951625725616;3238.8380580970856;3245.8701651933657;3254.23525471514;3261.608606967179;567.7133047810829;577.2899333819341;583.5156819839523;591.4026832898803;593.890130325891;563.2086917880384;572.2389222334285;595.0093094996869;613.6440864298696;618.8731310081422;8835.614384116381;8863.822723545492;9056.683016094405;9118;9268.25853931684;493.76546140583656;609.6981993913041;614.4776939601393;617.4720613875072;642.5254041973682;3831.4635950966886;3853.6917046636204;3860.1507668312925;3916;3936.9295925874353;63302.366976330566;64734.676326618064;64888.35111648823;64922;64962;55646.72176639172;56322;57208.42791572114;57322.14016789668;57472.137917931264;50828.49171508312;50924.47226583208;51037;51204;51626.74186629118;7949.165337639464;7991.84016319682;8069.435139540411;8126.553039582644;8288.544130072663;34061.65938340585;34705;35644;35669;36375.272494549434;43600;44106.11787764291;48753;49511.25733114078;50068.24897626611;9679.225661946886;10022;10069.546870390703;10150.238732094975;10486.37081775096;12648.936755316165;12826.74346513046;12977.610671679487;13020.544280950122;13430.328483575977;10942.343459392461;11610;11763.176577639826;11880.702982425508;12157.08821838348;10472.895271047497;10493.370397776158;10907.509162087566;11409.315441073562;11853.407329633656;10767.515461804081;10903.618373356894;11204.551817927191;11214.495347709535;11355.48900299472;9365.157135857806;9400.576974036321;9487.57305921249;9513.381630194015;10163.44101074448;9604.85592716096;9649.662261821084;9781.608735650494;9796.559154838193;9846 16:57:01 INFO - 2016-01-22 16:57:01,178 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:57:01 INFO - 2016-01-22 16:57:01,178 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:57:01 INFO - 2016-01-22 16:57:01,178 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,868 16:57:01 INFO - 2016-01-22 16:57:01,178 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:57:01 INFO - 2016-01-22 16:57:01,178 DEBUG : BROWSER_OUTPUT: __startTimestamp1453510621170__endTimestamp 16:57:01 INFO - 2016-01-22 16:57:01,178 DEBUG : BROWSER_OUTPUT: 16:57:01 INFO - 2016-01-22 16:57:01,178 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:57:01 INFO - 2016-01-22 16:57:01,179 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:57:01 INFO - 2016-01-22 16:57:01,179 DEBUG : BROWSER_OUTPUT: 16:57:01 INFO - 2016-01-22 16:57:01,179 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5528.75 Median:5754.60 stddev:626.96 (10.9%) stddev-sans-first:600.90 16:57:01 INFO - 2016-01-22 16:57:01,179 DEBUG : BROWSER_OUTPUT: Values: 3167.6 3221.9 3255.4 3259.3 3274.4 5360.5 5394.9 5400.8 5409.5 5435.7 5496.6 5517.4 5520.9 5531.6 5548.5 4992.7 5036.9 5070.1 5102.3 5104.6 5017.1 5036.7 5046.4 5107.4 5123.4 5070.3 5148.6 5152.8 5154.2 5158.9 5053.2 5117.3 5125.1 5154.5 5199.8 4840.4 4849.9 4954.4 4960.6 5033.2 5397.1 5398.0 5398.8 5401.4 5402.0 5959.1 6019.9 6023.6 6024.6 6045.0 5805.3 5836.7 5872.3 5898.2 5951.4 5540.6 5542.9 5543.5 5546.3 5574.8 5825.9 6086.6 6093.6 6095.3 6096.6 5754.6 5775.0 5821.0 5821.6 5858.1 5866.9 5870.2 5871.7 5881.7 5972.1 5693.3 5793.3 5847.2 5850.3 5860.7 5892.7 5956.9 5958.9 5967.8 6001.8 4540.6 4547.5 4587.0 4587.2 4614.7 4002.0 4015.7 4086.6 4092.4 4104.4 5601.4 5689.0 5709.0 5711.7 5718.8 6038.7 6068.1 6068.2 6084.3 6087.7 5422.9 5524.5 5603.3 5629.5 5684.2 5266.2 5296.0 5296.7 5297.9 5302.2 6188.4 6192.8 6193.1 6195.0 6207.6 5719.7 5802.7 6005.2 6085.9 6108.8 6157.7 6166.9 6169.2 6177.5 6181.7 5660.5 5977.6 5999.3 6000.1 6030.8 5840.9 5907.8 5921.8 5934.5 5958.7 5864.3 5905.8 5906.9 5914.2 5963.6 5732.1 5834.6 5899.8 5900.1 5911.8 5729.8 5791.5 5821.5 5822.4 5830.6 5881.7 5913.9 5919.0 5920.8 5929.8 5560.4 5744.3 5782.5 5784.6 5814.8 16:57:01 INFO - 2016-01-22 16:57:01,179 DEBUG : BROWSER_OUTPUT: 16:57:01 INFO - 2016-01-22 16:57:01,179 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:51165.10 Median:32652.76 stddev:83801.75 (256.6%) stddev-sans-first:83950.83 16:57:01 INFO - 2016-01-22 16:57:01,179 DEBUG : BROWSER_OUTPUT: Values: 598.3 632.1 636.0 644.6 647.5 33497.0 34523.7 34531.7 38756.4 39648.4 45678.5 46033.5 46281.8 46356.8 46364.0 8981.5 9196.8 9217.2 9217.5 9220.8 8251.0 8421.7 10808.1 11020.1 11041.5 10786.3 10835.3 10909.9 10910.9 10923.1 8212.5 8349.7 10536.2 10568.8 10571.6 10707.3 10966.3 10967.6 10968.1 10978.0 42548.1 42927.0 43015.4 43031.0 43047.6 3096.0 3136.2 3161.7 3178.2 3179.7 32301.0 32422.7 32449.7 32594.7 32710.8 3092.0 3100.2 3112.8 3123.7 3142.0 297414.0 298226.0 298972.0 299012.0 299184.5 56603.0 57875.0 62659.4 62918.0 63068.7 70906.6 71261.0 71631.6 71881.6 71937.3 16470.5 16578.3 16727.7 16774.8 16952.7 12034.8 12102.2 12107.1 12197.6 12211.5 19971.9 20268.6 20308.1 20398.8 20442.9 8073.3 8341.8 8395.5 8439.7 8481.9 1042.8 1067.0 1104.7 1141.5 1144.1 29217.6 29747.0 29751.7 30049.2 30182.1 1030.3 1070.7 1091.9 1111.2 1181.4 13732.9 13953.6 14025.9 15892.6 16672.0 339653.0 344439.0 345174.0 345658.0 348615.0 56700.7 56976.7 57104.0 57124.7 57196.7 1437.3 1442.7 1459.9 1462.4 1479.5 29952.7 30011.1 30587.5 30836.7 30947.5 48606.0 49009.5 49036.8 49053.3 49111.8 316166.0 316778.0 317884.0 318490.0 318796.0 29650.3 50142.2 50440.0 50962.7 51649.2 49159.3 50148.0 50699.0 51320.7 51448.0 40997.6 41542.4 41594.2 42008.8 42464.4 35859.5 41682.6 41953.0 44166.0 45782.8 41405.0 41982.4 45772.8 45988.0 46165.8 36518.0 37109.3 37327.0 38836.0 39300.2 27902.3 28751.3 28830.3 29073.7 29085.7 16:57:01 INFO - 2016-01-22 16:57:01,179 DEBUG : BROWSER_OUTPUT: 16:57:01 INFO - 2016-01-22 16:57:01,179 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32584.67 Median:19772.53 stddev:107618.33 (544.3%) stddev-sans-first:107893.07 16:57:01 INFO - 2016-01-22 16:57:01,180 DEBUG : BROWSER_OUTPUT: Values: 389.4 390.5 394.2 397.0 398.5 13907.1 17770.3 17892.8 19241.9 19252.1 17332.9 17776.1 17805.3 17807.0 18133.5 5070.6 5167.3 5176.9 5184.6 5191.4 4019.8 4126.5 5108.3 5537.3 5763.6 5684.4 5687.1 5696.8 5706.4 5744.7 5827.2 6247.6 6269.0 6272.9 6274.6 5567.4 5651.9 5653.3 5669.0 5684.6 13851.5 13875.4 17263.5 22337.3 22582.1 2250.7 2319.8 2335.7 2374.3 2385.2 10001.9 10272.8 10282.2 10294.7 10323.4 1910.5 1942.4 1942.8 1944.0 1994.5 65368.3 66174.7 66998.7 68078.7 68866.0 10787.4 10954.3 10980.7 11027.4 11045.4 14534.6 14750.8 14763.0 14782.3 14803.9 7825.8 7834.8 7988.0 8038.0 8051.7 7434.0 7485.6 7517.0 7524.2 7535.7 4672.3 4713.7 4719.0 4729.2 4767.8 1697.3 1792.3 1895.4 1940.1 1940.4 486.0 895.0 1041.0 1082.7 1122.2 9805.5 10559.3 10992.2 11054.9 11120.4 469.5 472.2 473.5 477.8 492.8 6181.6 6265.3 6351.1 6410.3 6421.2 643216.0 649762.0 654226.0 664742.0 680372.0 77860.0 78114.0 87101.0 87101.1 87624.0 1175.6 1189.8 1195.4 1206.2 1210.1 16514.5 16564.5 16581.3 16647.3 16842.0 37159.8 37214.6 37291.4 37417.6 37888.2 48269.3 50248.0 53155.2 53703.2 55268.4 9483.4 9552.5 9714.8 9752.8 9833.8 11580.9 11818.3 14345.0 17697.1 18085.2 14715.3 14978.7 15082.2 15329.2 15382.9 14659.3 14803.5 14976.0 15387.6 15402.7 15253.2 15330.0 15575.0 15579.3 15941.5 9879.9 10355.9 10386.5 10658.5 10751.7 10642.7 14841.0 14885.1 14887.9 15280.4 16:57:01 INFO - 2016-01-22 16:57:01,181 DEBUG : BROWSER_OUTPUT: 16:57:01 INFO - 2016-01-22 16:57:01,181 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5839.71 Median:5165.61 stddev:3048.51 (59.0%) stddev-sans-first:3038.51 16:57:01 INFO - 2016-01-22 16:57:01,181 DEBUG : BROWSER_OUTPUT: Values: 1366.3 1500.2 1510.1 1825.7 1826.0 7192.9 8181.3 8336.8 8357.0 8358.2 8276.1 8407.5 8448.5 8449.2 8463.8 2056.2 2088.1 2324.7 2409.6 2442.0 2387.5 2391.6 2392.4 2393.9 2394.8 2358.5 2403.6 2420.6 2423.0 2425.5 2388.1 2396.3 2428.2 2429.3 2431.2 2422.6 2447.2 2451.8 2453.3 2478.2 8386.4 8399.5 8463.9 8481.2 8489.6 5013.8 5086.3 5113.7 5124.4 5132.8 3201.2 3219.6 3275.0 3308.0 3308.4 1018.6 1019.5 1034.0 1037.2 1037.4 11602.8 11630.4 11636.9 11643.5 11660.6 4579.8 4623.7 4646.6 4670.3 4682.0 9878.0 9894.5 9900.9 9907.8 9922.5 5143.1 5146.2 5149.8 5161.5 5169.7 4589.3 4638.7 4641.7 4646.2 4653.0 3414.8 3464.3 3924.8 3976.1 4000.0 1272.9 1279.0 1291.6 1304.3 1316.4 1103.6 1103.8 1330.6 1370.2 1401.5 7898.1 8011.1 8017.1 8023.0 8029.2 1136.2 1143.6 1144.8 1147.6 1152.5 6183.8 6255.4 6266.5 6271.2 6279.2 9719.6 10137.4 10140.8 10141.3 10225.7 9838.6 9966.2 10102.9 10111.3 10124.1 7888.1 7957.9 7978.1 7980.6 7982.4 7477.9 7566.7 7567.5 7569.7 7592.9 8728.9 8840.1 9040.5 9052.5 9069.3 9118.6 9171.7 9290.6 9297.6 9456.3 6391.9 7190.8 7290.9 7292.5 7295.4 7541.0 7603.4 7777.9 7797.2 7797.5 7285.1 7556.2 7558.9 7619.2 7665.3 7443.4 7488.9 7493.4 7521.0 7556.1 7448.6 7467.0 7490.0 7505.9 7526.4 6696.2 6725.1 6747.7 6757.0 6757.9 6638.7 6861.5 6862.5 6863.3 6878.5 16:57:01 INFO - 2016-01-22 16:57:01,181 DEBUG : BROWSER_OUTPUT: 16:57:01 INFO - 2016-01-22 16:57:01,181 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5451.57 Median:6220.63 stddev:1600.84 (25.7%) stddev-sans-first:1559.33 16:57:01 INFO - 2016-01-22 16:57:01,181 DEBUG : BROWSER_OUTPUT: Values: 375.4 380.4 381.6 384.9 388.0 6026.6 6068.1 6080.0 6081.4 6089.0 5782.7 5851.0 5896.6 5987.0 6000.8 4702.1 4724.6 4734.7 4746.8 4758.3 4505.6 4731.1 4732.1 4732.6 4742.0 4541.1 4573.1 4645.6 4653.9 4670.0 4620.1 4669.1 4698.4 4699.4 4713.2 4181.3 4183.3 4184.7 4188.4 4190.9 5684.3 5741.3 5741.5 5750.1 5750.2 5501.2 5505.3 5507.7 5507.8 5510.0 6457.9 6460.4 6467.2 6468.4 6468.5 4628.0 4629.9 4631.8 4637.4 4644.8 6499.2 6593.8 6646.9 6647.8 6652.6 4792.9 4815.7 4818.8 4822.4 4823.6 4873.3 4875.7 4879.3 4881.7 4887.5 5424.5 5493.4 5501.2 5501.7 5503.5 6456.9 6478.8 6482.0 6485.7 6486.1 1699.7 1715.5 1716.0 1716.5 1716.7 1175.4 1182.0 1188.0 1190.6 1207.0 6255.7 6256.2 6257.1 6276.5 6278.9 6497.7 6682.2 6691.7 6691.7 6693.6 6204.0 6237.3 6324.8 6327.3 6350.4 3599.3 3623.5 3633.3 3636.8 3641.7 6733.5 6886.8 6887.7 6891.4 6902.7 6874.8 6883.1 6884.2 6887.8 6896.9 6764.0 6768.3 6769.5 6771.9 6782.1 6617.1 6712.7 6727.4 6729.4 6735.3 6571.1 6631.1 6631.6 6636.4 6638.8 6833.6 6869.1 6871.7 6877.1 6887.4 4700.2 4780.5 4785.5 4791.8 4794.5 6725.0 6731.4 6734.8 6740.5 6743.6 6490.8 6506.3 6548.4 6556.1 6565.0 6445.2 6534.2 6541.4 6542.1 6543.3 6423.8 6426.6 6430.1 6434.4 6444.8 6557.0 6561.5 6561.5 6563.7 6567.3 6319.7 6406.3 6410.3 6417.6 6421.3 16:57:01 INFO - 2016-01-22 16:57:01,181 DEBUG : BROWSER_OUTPUT: 16:57:01 INFO - 2016-01-22 16:57:01,181 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14426.99 Median:50706.25 stddev:17399.45 (34.3%) stddev-sans-first:17417.79 16:57:01 INFO - 2016-01-22 16:57:01,182 DEBUG : BROWSER_OUTPUT: Values: 713.4 775.6 787.9 790.9 804.3 13467.3 13790.1 13791.9 13823.7 13828.8 12349.6 12910.4 12915.9 12921.9 12931.7 769.8 772.5 912.1 912.8 936.1 927.6 928.7 933.9 934.5 934.7 781.2 964.1 964.5 968.7 969.2 768.4 769.5 770.1 770.9 943.9 715.8 722.5 722.6 722.8 724.4 12543.4 12673.7 12715.6 12723.9 12727.7 12387.6 12936.9 13123.8 13149.6 13188.3 10122.6 10186.4 10223.9 10316.6 10389.8 3731.3 3807.7 3815.7 3817.6 3819.6 48549.3 49268.8 50046.0 50566.0 50584.0 9652.9 9725.5 9745.7 9762.8 9765.9 18980.4 19173.2 19180.9 19219.3 19317.6 7418.5 7614.9 7642.3 7711.8 7902.4 4530.5 4566.3 4581.9 4643.0 4664.3 3225.0 3238.8 3245.9 3254.2 3261.6 567.7 577.3 583.5 591.4 593.9 563.2 572.2 595.0 613.6 618.9 8835.6 8863.8 9056.7 9118.0 9268.3 493.8 609.7 614.5 617.5 642.5 3831.5 3853.7 3860.2 3916.0 3936.9 63302.4 64734.7 64888.4 64922.0 64962.0 55646.7 56322.0 57208.4 57322.1 57472.1 50828.5 50924.5 51037.0 51204.0 51626.7 7949.2 7991.8 8069.4 8126.6 8288.5 34061.7 34705.0 35644.0 35669.0 36375.3 43600.0 44106.1 48753.0 49511.3 50068.2 9679.2 10022.0 10069.5 10150.2 10486.4 12648.9 12826.7 12977.6 13020.5 13430.3 10942.3 11610.0 11763.2 11880.7 12157.1 10472.9 10493.4 10907.5 11409.3 11853.4 10767.5 10903.6 11204.6 11214.5 11355.5 9365.2 9400.6 9487.6 9513.4 10163.4 9604.9 9649.7 9781.6 9796.6 9846.0 16:57:01 INFO - 2016-01-22 16:57:01,182 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:57:01 INFO - 2016-01-22 16:57:01,182 DEBUG : BROWSER_OUTPUT: 16:57:01 INFO - 2016-01-22 16:57:01,861 INFO : Browser exited with error code: 0 16:57:01 INFO - 2016-01-22 16:57:01,878 INFO : Completed test dromaeo_css (00:18:30) 16:57:01 INFO - 2016-01-22 16:57:01,878 INFO : Starting test kraken 16:57:01 INFO - 2016-01-22 16:57:01,878 DEBUG : operating with platform_type : linux_ 16:57:01 INFO - 2016-01-22 16:57:01,878 INFO : Initialising browser for kraken test... 16:57:01 INFO - 2016-01-22 16:57:01,884 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKqeTxi/profile http://localhost:36521/getInfo.html 16:57:05 INFO - 2016-01-22 16:57:05,602 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:57:05 INFO - 2016-01-22 16:57:05,602 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:57:05 INFO - 2016-01-22 16:57:05,602 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:57:05 INFO - 2016-01-22 16:57:05,602 DEBUG : BROWSER_OUTPUT: __metrics 16:57:05 INFO - 2016-01-22 16:57:05,747 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] 16:57:06 INFO - 2016-01-22 16:57:06,755 INFO : Browser initialized. 16:57:06 INFO - 2016-01-22 16:57:06,755 INFO : Running cycle 1/1 for kraken test... 16:57:06 INFO - 2016-01-22 16:57:06,756 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKqeTxi/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:57:18 INFO - 2016-01-22 16:57:18,483 DEBUG : BROWSER_OUTPUT: RSS: Main: 137162752 16:57:18 INFO - 2016-01-22 16:57:18,483 DEBUG : BROWSER_OUTPUT: 16:57:20 INFO - 2016-01-22 16:57:20,925 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36521/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36521/tests/kraken/driver.html?testName=audio-beat-detection) 16:57:21 INFO - 2016-01-22 16:57:21,495 DEBUG : BROWSER_OUTPUT: RSS: Main: 168710144 16:57:21 INFO - 2016-01-22 16:57:21,495 DEBUG : BROWSER_OUTPUT: 16:57:24 INFO - 2016-01-22 16:57:24,057 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36521/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36521/tests/kraken/driver.html?testName=audio-dft) 16:57:24 INFO - 2016-01-22 16:57:24,630 DEBUG : BROWSER_OUTPUT: RSS: Main: 165449728 16:57:24 INFO - 2016-01-22 16:57:24,630 DEBUG : BROWSER_OUTPUT: 16:57:27 INFO - 2016-01-22 16:57:27,435 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36521/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36521/tests/kraken/driver.html?testName=audio-fft) 16:57:28 INFO - 2016-01-22 16:57:28,001 DEBUG : BROWSER_OUTPUT: RSS: Main: 164003840 16:57:28 INFO - 2016-01-22 16:57:28,001 DEBUG : BROWSER_OUTPUT: 16:57:30 INFO - 2016-01-22 16:57:30,006 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36521/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36521/tests/kraken/driver.html?testName=audio-oscillator) 16:57:30 INFO - 2016-01-22 16:57:30,573 DEBUG : BROWSER_OUTPUT: RSS: Main: 164200448 16:57:30 INFO - 2016-01-22 16:57:30,573 DEBUG : BROWSER_OUTPUT: 16:57:32 INFO - 2016-01-22 16:57:32,772 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36521/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36521/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:57:33 INFO - 2016-01-22 16:57:33,334 DEBUG : BROWSER_OUTPUT: RSS: Main: 164409344 16:57:33 INFO - 2016-01-22 16:57:33,334 DEBUG : BROWSER_OUTPUT: 16:57:36 INFO - 2016-01-22 16:57:36,197 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36521/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36521/tests/kraken/driver.html?testName=imaging-darkroom) 16:57:36 INFO - 2016-01-22 16:57:36,763 DEBUG : BROWSER_OUTPUT: RSS: Main: 163926016 16:57:36 INFO - 2016-01-22 16:57:36,763 DEBUG : BROWSER_OUTPUT: 16:57:40 INFO - 2016-01-22 16:57:40,073 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36521/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36521/tests/kraken/driver.html?testName=imaging-desaturate) 16:57:40 INFO - 2016-01-22 16:57:40,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 163266560 16:57:40 INFO - 2016-01-22 16:57:40,639 DEBUG : BROWSER_OUTPUT: 16:57:43 INFO - 2016-01-22 16:57:43,336 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36521/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36521/tests/kraken/driver.html?testName=json-parse-financial) 16:57:43 INFO - 2016-01-22 16:57:43,902 DEBUG : BROWSER_OUTPUT: RSS: Main: 164626432 16:57:43 INFO - 2016-01-22 16:57:43,902 DEBUG : BROWSER_OUTPUT: 16:57:45 INFO - 2016-01-22 16:57:45,435 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36521/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36521/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:57:45 INFO - 2016-01-22 16:57:45,996 DEBUG : BROWSER_OUTPUT: RSS: Main: 170336256 16:57:45 INFO - 2016-01-22 16:57:45,997 DEBUG : BROWSER_OUTPUT: 16:57:47 INFO - 2016-01-22 16:57:47,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36521/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36521/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:57:48 INFO - 2016-01-22 16:57:48,363 DEBUG : BROWSER_OUTPUT: RSS: Main: 170295296 16:57:48 INFO - 2016-01-22 16:57:48,364 DEBUG : BROWSER_OUTPUT: 16:57:50 INFO - 2016-01-22 16:57:50,356 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36521/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36521/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:57:50 INFO - 2016-01-22 16:57:50,922 DEBUG : BROWSER_OUTPUT: RSS: Main: 178507776 16:57:50 INFO - 2016-01-22 16:57:50,922 DEBUG : BROWSER_OUTPUT: 16:57:53 INFO - 2016-01-22 16:57:53,338 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36521/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36521/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:57:53 INFO - 2016-01-22 16:57:53,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 183422976 16:57:53 INFO - 2016-01-22 16:57:53,920 DEBUG : BROWSER_OUTPUT: 16:57:56 INFO - 2016-01-22 16:57:56,420 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36521/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36521/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:57:56 INFO - 2016-01-22 16:57:56,993 DEBUG : BROWSER_OUTPUT: RSS: Main: 183758848 16:57:56 INFO - 2016-01-22 16:57:56,993 DEBUG : BROWSER_OUTPUT: 16:57:58 INFO - 2016-01-22 16:57:58,648 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36521/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36521/tests/kraken/driver.html?testName=ai-astar) 16:57:58 INFO - 2016-01-22 16:57:58,898 DEBUG : BROWSER_OUTPUT: RSS: Main: 240693248 16:57:58 INFO - 2016-01-22 16:57:58,898 DEBUG : BROWSER_OUTPUT: 16:57:58 INFO - 2016-01-22 16:57:58,902 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:57:58 INFO - 2016-01-22 16:57:58,902 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:57:58 INFO - 2016-01-22 16:57:58,902 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:57:58 INFO - 2016-01-22 16:57:58,902 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:57:58 INFO - 2016-01-22 16:57:58,902 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;109;105;107;109;108;97;108;110;108 16:57:58 INFO - 2016-01-22 16:57:58,903 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;129;148;167;125;143;152;122;163;122 16:57:58 INFO - 2016-01-22 16:57:58,903 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;160;160;162;162;161;160;158;159 16:57:58 INFO - 2016-01-22 16:57:58,903 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;72;160;70;71;70;73;159;72 16:57:58 INFO - 2016-01-22 16:57:58,903 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;93;152;93;93;94;146;93;93;136 16:57:58 INFO - 2016-01-22 16:57:58,903 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;109;109;109;109;109;109 16:57:58 INFO - 2016-01-22 16:57:58,903 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;146;147;145;145;145;147;145;146 16:57:58 INFO - 2016-01-22 16:57:58,903 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;96;96;95;96;95;95;95 16:57:58 INFO - 2016-01-22 16:57:58,903 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;56;58;56;60;55;57;57;56;53 16:57:58 INFO - 2016-01-22 16:57:58,904 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;64;64;65;64;67;64;66;65;65 16:57:58 INFO - 2016-01-22 16:57:58,904 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;79;80;81;81;80;81;81;81;82;89 16:57:58 INFO - 2016-01-22 16:57:58,904 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;110;122;112;119;121;115;119;111;121 16:57:58 INFO - 2016-01-22 16:57:58,904 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;136;146;146;145;137;148;149;142;133 16:57:58 INFO - 2016-01-22 16:57:58,904 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;65;67;65;67;66;64;65;66;65 16:57:58 INFO - 2016-01-22 16:57:58,904 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:57:58 INFO - 2016-01-22 16:57:58,904 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:57:58 INFO - 2016-01-22 16:57:58,905 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,894 16:57:58 INFO - 2016-01-22 16:57:58,905 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:57:58 INFO - 2016-01-22 16:57:58,905 DEBUG : BROWSER_OUTPUT: __startTimestamp1453510678900__endTimestamp 16:57:58 INFO - 2016-01-22 16:57:58,905 DEBUG : BROWSER_OUTPUT: 16:57:58 INFO - 2016-01-22 16:57:58,906 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:57:58 INFO - 2016-01-22 16:57:58,906 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:57:58 INFO - 2016-01-22 16:57:58,906 DEBUG : BROWSER_OUTPUT: 16:57:58 INFO - 2016-01-22 16:57:58,906 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.90 Median:108.50 stddev:3.73 (3.4%) stddev-sans-first:3.93 16:57:58 INFO - 2016-01-22 16:57:58,907 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 105.0 107.0 109.0 108.0 97.0 108.0 110.0 108.0 16:57:58 INFO - 2016-01-22 16:57:58,907 DEBUG : BROWSER_OUTPUT: 16:57:58 INFO - 2016-01-22 16:57:58,907 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.00 Median:148.50 stddev:16.70 (11.2%) stddev-sans-first:17.52 16:57:58 INFO - 2016-01-22 16:57:58,907 DEBUG : BROWSER_OUTPUT: Values: 149.0 129.0 148.0 167.0 125.0 143.0 152.0 122.0 163.0 122.0 16:57:58 INFO - 2016-01-22 16:57:58,907 DEBUG : BROWSER_OUTPUT: 16:57:58 INFO - 2016-01-22 16:57:58,907 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:1.26 (0.8%) stddev-sans-first:1.32 16:57:58 INFO - 2016-01-22 16:57:58,907 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 160.0 160.0 162.0 162.0 161.0 160.0 158.0 159.0 16:57:58 INFO - 2016-01-22 16:57:58,907 DEBUG : BROWSER_OUTPUT: 16:57:58 INFO - 2016-01-22 16:57:58,907 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.20 Median:72.00 stddev:37.07 (51.5%) stddev-sans-first:38.85 16:57:58 INFO - 2016-01-22 16:57:58,907 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 72.0 160.0 70.0 71.0 70.0 73.0 159.0 72.0 16:57:58 INFO - 2016-01-22 16:57:58,907 DEBUG : BROWSER_OUTPUT: 16:57:58 INFO - 2016-01-22 16:57:58,908 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:108.70 Median:93.00 stddev:25.11 (27.0%) stddev-sans-first:26.07 16:57:58 INFO - 2016-01-22 16:57:58,908 DEBUG : BROWSER_OUTPUT: Values: 94.0 93.0 152.0 93.0 93.0 94.0 146.0 93.0 93.0 136.0 16:57:58 INFO - 2016-01-22 16:57:58,908 DEBUG : BROWSER_OUTPUT: 16:57:58 INFO - 2016-01-22 16:57:58,908 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 16:57:58 INFO - 2016-01-22 16:57:58,908 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 16:57:58 INFO - 2016-01-22 16:57:58,908 DEBUG : BROWSER_OUTPUT: 16:57:58 INFO - 2016-01-22 16:57:58,908 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 16:57:58 INFO - 2016-01-22 16:57:58,908 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 146.0 147.0 145.0 145.0 145.0 147.0 145.0 146.0 16:57:58 INFO - 2016-01-22 16:57:58,908 DEBUG : BROWSER_OUTPUT: 16:57:58 INFO - 2016-01-22 16:57:58,908 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 16:57:58 INFO - 2016-01-22 16:57:58,909 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 16:57:58 INFO - 2016-01-22 16:57:58,909 DEBUG : BROWSER_OUTPUT: 16:57:58 INFO - 2016-01-22 16:57:58,909 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.50 stddev:1.89 (3.3%) stddev-sans-first:1.94 16:57:58 INFO - 2016-01-22 16:57:58,909 DEBUG : BROWSER_OUTPUT: Values: 55.0 56.0 58.0 56.0 60.0 55.0 57.0 57.0 56.0 53.0 16:57:58 INFO - 2016-01-22 16:57:58,909 DEBUG : BROWSER_OUTPUT: 16:57:58 INFO - 2016-01-22 16:57:58,909 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:1.03 (1.6%) stddev-sans-first:1.05 16:57:58 INFO - 2016-01-22 16:57:58,909 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 64.0 65.0 64.0 67.0 64.0 66.0 65.0 65.0 16:57:58 INFO - 2016-01-22 16:57:58,910 DEBUG : BROWSER_OUTPUT: 16:57:58 INFO - 2016-01-22 16:57:58,910 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:81.00 stddev:2.76 (3.4%) stddev-sans-first:2.77 16:57:58 INFO - 2016-01-22 16:57:58,910 DEBUG : BROWSER_OUTPUT: Values: 79.0 80.0 81.0 81.0 80.0 81.0 81.0 81.0 82.0 89.0 16:57:58 INFO - 2016-01-22 16:57:58,910 DEBUG : BROWSER_OUTPUT: 16:57:58 INFO - 2016-01-22 16:57:58,910 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:116.80 Median:119.00 stddev:4.47 (3.8%) stddev-sans-first:4.72 16:57:58 INFO - 2016-01-22 16:57:58,910 DEBUG : BROWSER_OUTPUT: Values: 118.0 110.0 122.0 112.0 119.0 121.0 115.0 119.0 111.0 121.0 16:57:58 INFO - 2016-01-22 16:57:58,910 DEBUG : BROWSER_OUTPUT: 16:57:58 INFO - 2016-01-22 16:57:58,910 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.00 Median:145.50 stddev:5.62 (3.9%) stddev-sans-first:5.77 16:57:58 INFO - 2016-01-22 16:57:58,910 DEBUG : BROWSER_OUTPUT: Values: 138.0 136.0 146.0 146.0 145.0 137.0 148.0 149.0 142.0 133.0 16:57:58 INFO - 2016-01-22 16:57:58,910 DEBUG : BROWSER_OUTPUT: 16:57:58 INFO - 2016-01-22 16:57:58,912 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.50 stddev:0.97 (1.5%) stddev-sans-first:1.01 16:57:58 INFO - 2016-01-22 16:57:58,912 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 67.0 65.0 67.0 66.0 64.0 65.0 66.0 65.0 16:57:58 INFO - 2016-01-22 16:57:58,912 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:57:58 INFO - 2016-01-22 16:57:58,912 DEBUG : BROWSER_OUTPUT: 16:57:59 INFO - 2016-01-22 16:57:59,786 INFO : Browser exited with error code: 0 16:57:59 INFO - 2016-01-22 16:57:59,834 INFO : Completed test kraken (00:00:57) 16:57:59 INFO - 2016-01-22 16:57:59,834 INFO : Starting test v8_7 16:57:59 INFO - 2016-01-22 16:57:59,834 DEBUG : operating with platform_type : linux_ 16:57:59 INFO - 2016-01-22 16:57:59,834 INFO : Initialising browser for v8_7 test... 16:57:59 INFO - 2016-01-22 16:57:59,841 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZ3GvPA/profile http://localhost:36521/getInfo.html 16:58:03 INFO - 2016-01-22 16:58:03,948 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:58:03 INFO - 2016-01-22 16:58:03,948 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:58:03 INFO - 2016-01-22 16:58:03,948 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:58:03 INFO - 2016-01-22 16:58:03,948 DEBUG : BROWSER_OUTPUT: __metrics 16:58:04 INFO - 2016-01-22 16:58:04,110 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] 16:58:04 INFO - 2016-01-22 16:58:04,845 INFO : Browser initialized. 16:58:04 INFO - 2016-01-22 16:58:04,846 INFO : Running cycle 1/1 for v8_7 test... 16:58:04 INFO - 2016-01-22 16:58:04,846 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZ3GvPA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:58:16 INFO - 2016-01-22 16:58:16,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 137740288 16:58:16 INFO - 2016-01-22 16:58:16,641 DEBUG : BROWSER_OUTPUT: 16:58:37 INFO - 2016-01-22 16:58:37,972 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36521/tests/v8_7/run.html (next: http://localhost:36521/tests/v8_7/run.html) 16:58:38 INFO - 2016-01-22 16:58:38,222 DEBUG : BROWSER_OUTPUT: RSS: Main: 425955328 16:58:38 INFO - 2016-01-22 16:58:38,223 DEBUG : BROWSER_OUTPUT: 16:58:38 INFO - 2016-01-22 16:58:38,223 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:58:38 INFO - 2016-01-22 16:58:38,223 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:58:38 INFO - 2016-01-22 16:58:38,223 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:58:38 INFO - 2016-01-22 16:58:38,223 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:58:38 INFO - 2016-01-22 16:58:38,223 DEBUG : BROWSER_OUTPUT: |0;Richards;164.9620587264929 16:58:38 INFO - 2016-01-22 16:58:38,223 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;173.58097552508247 16:58:38 INFO - 2016-01-22 16:58:38,223 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.17364600781684 16:58:38 INFO - 2016-01-22 16:58:38,224 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 16:58:38 INFO - 2016-01-22 16:58:38,224 DEBUG : BROWSER_OUTPUT: |4;RayTrace;957.8544061302682 16:58:38 INFO - 2016-01-22 16:58:38,224 DEBUG : BROWSER_OUTPUT: |5;Earley;558.3472920156337 16:58:38 INFO - 2016-01-22 16:58:38,224 DEBUG : BROWSER_OUTPUT: |6;Boyer;11109.89010989011 16:58:38 INFO - 2016-01-22 16:58:38,224 DEBUG : BROWSER_OUTPUT: |7;RegExp;24439.024390243903 16:58:38 INFO - 2016-01-22 16:58:38,224 DEBUG : BROWSER_OUTPUT: |8;Splay;525.4860746190226 16:58:38 INFO - 2016-01-22 16:58:38,224 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 16:58:38 INFO - 2016-01-22 16:58:38,225 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:58:38 INFO - 2016-01-22 16:58:38,225 DEBUG : BROWSER_OUTPUT: __startTimestamp1453510718219__endTimestamp 16:58:38 INFO - 2016-01-22 16:58:38,225 DEBUG : BROWSER_OUTPUT: 16:58:38 INFO - 2016-01-22 16:58:38,225 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:58:38 INFO - 2016-01-22 16:58:38,225 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:58:38 INFO - 2016-01-22 16:58:38,225 DEBUG : BROWSER_OUTPUT: 16:58:38 INFO - 2016-01-22 16:58:38,225 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.96 Median:164.96 stddev:0.00 (0.0%) 16:58:38 INFO - 2016-01-22 16:58:38,226 DEBUG : BROWSER_OUTPUT: Values: 165.0 16:58:38 INFO - 2016-01-22 16:58:38,226 DEBUG : BROWSER_OUTPUT: 16:58:38 INFO - 2016-01-22 16:58:38,226 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:173.58 Median:173.58 stddev:0.00 (0.0%) 16:58:38 INFO - 2016-01-22 16:58:38,226 DEBUG : BROWSER_OUTPUT: Values: 173.6 16:58:38 INFO - 2016-01-22 16:58:38,226 DEBUG : BROWSER_OUTPUT: 16:58:38 INFO - 2016-01-22 16:58:38,226 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.17 Median:279.17 stddev:0.00 (0.0%) 16:58:38 INFO - 2016-01-22 16:58:38,226 DEBUG : BROWSER_OUTPUT: Values: 279.2 16:58:38 INFO - 2016-01-22 16:58:38,226 DEBUG : BROWSER_OUTPUT: 16:58:38 INFO - 2016-01-22 16:58:38,227 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 16:58:38 INFO - 2016-01-22 16:58:38,227 DEBUG : BROWSER_OUTPUT: Values: 5181.3 16:58:38 INFO - 2016-01-22 16:58:38,227 DEBUG : BROWSER_OUTPUT: 16:58:38 INFO - 2016-01-22 16:58:38,227 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:957.85 Median:957.85 stddev:0.00 (0.0%) 16:58:38 INFO - 2016-01-22 16:58:38,227 DEBUG : BROWSER_OUTPUT: Values: 957.9 16:58:38 INFO - 2016-01-22 16:58:38,227 DEBUG : BROWSER_OUTPUT: 16:58:38 INFO - 2016-01-22 16:58:38,227 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:558.35 Median:558.35 stddev:0.00 (0.0%) 16:58:38 INFO - 2016-01-22 16:58:38,228 DEBUG : BROWSER_OUTPUT: Values: 558.3 16:58:38 INFO - 2016-01-22 16:58:38,228 DEBUG : BROWSER_OUTPUT: 16:58:38 INFO - 2016-01-22 16:58:38,228 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11109.89 Median:11109.89 stddev:0.00 (0.0%) 16:58:38 INFO - 2016-01-22 16:58:38,228 DEBUG : BROWSER_OUTPUT: Values: 11109.9 16:58:38 INFO - 2016-01-22 16:58:38,228 DEBUG : BROWSER_OUTPUT: 16:58:38 INFO - 2016-01-22 16:58:38,228 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24439.02 Median:24439.02 stddev:0.00 (0.0%) 16:58:38 INFO - 2016-01-22 16:58:38,228 DEBUG : BROWSER_OUTPUT: Values: 24439.0 16:58:38 INFO - 2016-01-22 16:58:38,228 DEBUG : BROWSER_OUTPUT: 16:58:38 INFO - 2016-01-22 16:58:38,229 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:525.49 Median:525.49 stddev:0.00 (0.0%) 16:58:38 INFO - 2016-01-22 16:58:38,229 DEBUG : BROWSER_OUTPUT: Values: 525.5 16:58:38 INFO - 2016-01-22 16:58:38,229 DEBUG : BROWSER_OUTPUT: 16:58:38 INFO - 2016-01-22 16:58:38,229 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 16:58:38 INFO - 2016-01-22 16:58:38,229 DEBUG : BROWSER_OUTPUT: Values: 4826.9 16:58:38 INFO - 2016-01-22 16:58:38,229 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:58:38 INFO - 2016-01-22 16:58:38,229 DEBUG : BROWSER_OUTPUT: 16:58:39 INFO - 2016-01-22 16:58:39,045 INFO : Browser exited with error code: 0 16:58:39 INFO - 2016-01-22 16:58:39,060 INFO : Completed test v8_7 (00:00:39) 16:58:39 INFO - 2016-01-22 16:58:39,286 INFO : Completed test suite (00:20:08) 16:58:39 INFO - 2016-01-22 16:58:39,286 DEBUG : Working with test: dromaeo_css 16:58:39 INFO - 2016-01-22 16:58:39,286 DEBUG : Generating results file: dromaeo_css 16:58:39 INFO - 2016-01-22 16:58:39,287 DEBUG : Working with test: kraken 16:58:39 INFO - 2016-01-22 16:58:39,287 DEBUG : Generating results file: kraken 16:58:39 INFO - 2016-01-22 16:58:39,288 INFO : javascript benchmark 16:58:39 INFO - 2016-01-22 16:58:39,288 DEBUG : Working with test: v8_7 16:58:39 INFO - 2016-01-22 16:58:39,288 DEBUG : Generating results file: v8_7 16:58:39 INFO - 2016-01-22 16:58:39,288 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:58:39 INFO - 2016-01-22 16:58:39,342 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 16:58:39 INFO - 2016-01-22 16:58:39,342 DEBUG : process_Request line: dromaeo_css 7287.30 graph.html#tests=[[72,52,35]] 16:58:39 INFO - 2016-01-22 16:58:39,342 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:58:39 INFO - 2016-01-22 16:58:39,374 DEBUG : process_Request line: kraken 1484.20 graph.html#tests=[[232,52,35]] 16:58:39 INFO - 2016-01-22 16:58:39,374 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:58:39 INFO - 2016-01-22 16:58:39,404 DEBUG : process_Request line: v8_7 22965.71 graph.html#tests=[[230,52,35]] 16:58:39 INFO - 2016-01-22 16:58:39,405 INFO : javascript benchmark 16:58:39 INFO - 2016-01-22 16:58:39,409 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3167.588213532241, 3221.8550165242564, 3255.4465740824057, 3259.3481303739245, 3274.3614995075955, 5360.517553420192, 5394.946050539504, 5400.810971615994, 5409.540189083923, 5435.673859568428, 5496.587755918302, 5517.36550296716, 5520.861978450541, 5531.585131115163, 5548.528375088113, 4992.700437973715, 5036.899262014757, 5070.1380765269805, 5102.260172275018, 5104.617153713468, 5017.147084995559, 5036.697798132123, 5046.369203849519, 5107.361579802525, 5123.385193776752, 5070.340855688755, 5148.613853960968, 5152.768125434346, 5154.175331946889, 5158.896822063556, 5053.216751403538, 5117.334746482933, 5125.077486052509, 5154.4587818278915, 5199.792008319662, 4840.419149702023, 4849.903001939977, 4954.405471343462, 4960.553550180465, 5033.245013248005, 5397.082495975694, 5398.028354896117, 5398.811041613564, 5401.432849550819, 5402.027635025694, 5959.0763431668165, 6019.879602407971, 6023.608465449732, 6024.578279520435, 6045.0, 5805.303363596396, 5836.708164591753, 5872.324682661506, 5898.233229680114, 5951.3751056139345, 5540.556755459554, 5542.889142217214, 5543.501084902378, 5546.251256080418, 5574.777008919638, 5825.854353641193, 6086.573939824169, 6093.6039157454625, 6095.2685677718955, 6096.603720758137, 5754.5971781975695, 5774.971125144431, 5821.039528477839, 5821.621594596338, 5858.121281807677, 5866.853328666817, 5870.236869207061, 5871.706414679335, 5881.735321910439, 5972.104184372379, 5693.28833895763, 5793.333766616893, 5847.152162936351, 5850.268716410449, 5860.736266868002, 5892.6759028253855, 5956.940430595725, 5958.880822383528, 5967.76128954837, 6001.789937352259, 4540.568645978627, 4547.454305483297, 4587.0, 4587.197240482902, 4614.653900957442, 4001.9799901000893, 4015.678745700337, 4086.570910054461, 4092.3656833190903, 4104.384342348671, 5601.355844077902, 5689.0, 5708.971455142698, 5711.7144142792695, 5718.828435146952, 6038.698065096728, 6068.089786531968, 6068.150458935665, 6084.30030546484, 6087.69561521931, 5422.8915421691345, 5524.502794748411, 5603.299587551556, 5629.4652008059165, 5684.204211410406, 5266.21006848968, 5296.0, 5296.735163241822, 5297.867553311198, 5302.151655735064, 6188.381161883865, 6192.783252586138, 6193.102000209944, 6195.039768835838, 6207.5654704171175, 5719.685417302088, 5802.6808525531505, 6005.219321488178, 6085.878282434415, 6108.786192483241, 6157.730091652496, 6166.938330616816, 6169.2288463942, 6177.505799535937, 6181.690915454119, 5660.490555849993, 5977.565384307822, 5999.310079340931, 6000.129981152621, 6030.849228769316, 5840.94159058404, 5907.822765317047, 5921.7631294747725, 5934.525237980864, 5958.702064896825, 5864.296284445893, 5905.793297234576, 5906.852328691817, 5914.172015917861, 5963.612365196248, 5732.082866741302, 5834.649921004753, 5899.764009439746, 5900.085486749561, 5911.7635294587735, 5729.799457018984, 5791.536677065909, 5821.476067153976, 5822.446867547576, 5830.62100963436, 5881.705914704162, 5913.852153696192, 5919.0, 5920.79277225295, 5929.762809487572, 5560.360558535658, 5744.339400968942, 5782.45066718661, 5784.595078344475, 5814.767409303749], "unit": "ms", "name": "dojo.html", "value": 5486.676611285023}, {"lowerIsBetter": false, "replicates": [598.2521847690386, 632.149758574717, 636.0237036149512, 644.6390021587911, 647.488484097563, 33497.0, 34523.65476345236, 34531.654683453155, 38756.418653720146, 39648.405273920915, 45678.54321456784, 46033.53966460334, 46281.768591157, 46356.768216158955, 46364.0, 8981.461112333282, 9196.816063678756, 9217.216536594398, 9217.493037882947, 9220.815583688322, 8250.958745206266, 8421.747347579552, 10808.135349172047, 11020.063294619968, 11041.503132359063, 10786.298890572127, 10835.349879007246, 10909.945450272737, 10910.890891091067, 10923.126149908028, 8212.46618969765, 8349.707760228363, 10536.209784266171, 10568.841467377995, 10571.577136914515, 10707.304025238334, 10966.342019478856, 10967.561297548169, 10968.067714244298, 10978.0, 42548.14903701909, 42927.0, 43015.35476967848, 43031.0, 43047.56952430467, 3095.9690403095906, 3136.2002689314077, 3161.65221825599, 3178.2372230664473, 3179.666135055809, 32301.0, 32422.6757732422, 32449.6755032449, 32594.674053259638, 32710.836445817855, 3091.984540077308, 3100.224943764059, 3112.7588136541654, 3123.687631236881, 3141.9528707069185, 297414.0, 298226.0, 298972.0, 299012.0, 299184.5040774804, 56603.0, 57875.0, 62659.37340626626, 62918.0, 63068.68465657642, 70906.64546677233, 71261.0, 71631.64184179046, 71881.6405917967, 71937.28062719411, 16470.505884823473, 16578.253978570992, 16727.749083763752, 16774.83225167757, 16952.74570881438, 12034.759304813855, 12102.213356131822, 12107.091968102428, 12197.573084941985, 12211.450484728031, 19971.900140499205, 20268.59462810765, 20308.08613612391, 20398.796012039988, 20442.897785510977, 8073.273405393543, 8341.791455213546, 8395.496270223684, 8439.662413503514, 8481.872771908425, 1042.7862288231047, 1066.973325666849, 1104.679642903565, 1141.5034460009922, 1144.1247445704043, 29217.561736573967, 29747.0, 29751.70248297489, 30049.248768780955, 30182.09453716392, 1030.299396410433, 1070.6734445994045, 1091.912646988239, 1111.2110401614782, 1181.4092953523239, 13732.86267137316, 13953.581392558239, 14025.929870350583, 15892.602684932737, 16671.99968001924, 339653.0, 344439.0, 345174.0, 345658.0, 348615.0, 56700.716496417255, 56976.71511642415, 57104.0, 57124.71437642868, 57196.71401642965, 1437.3388241409068, 1442.7186698593673, 1459.9416023358947, 1462.385797964836, 1479.4747864507945, 29952.70047299499, 30011.099667010025, 30587.54118688177, 30836.69163308338, 30947.535786962762, 48606.0, 49009.50990490049, 49036.75481622569, 49053.264201037724, 49111.75444122757, 316166.0, 316778.0, 317884.0, 318490.0, 318796.0, 29650.258743531584, 50142.24786628276, 50440.0, 50962.74518627383, 51649.225261620355, 49159.26261106015, 50148.0, 50699.0, 51320.74339628278, 51448.0, 40997.59002409938, 41542.37686434646, 41594.168116636894, 42008.78995605002, 42464.36303455512, 35859.46210806788, 41682.58317416787, 41953.0, 44166.0, 45782.771086144356, 41405.0, 41982.37026444667, 45772.7711361441, 45988.0, 46165.76917115393, 36518.0, 37109.25781484301, 37327.0, 38836.0, 39300.2139957205, 27902.30244243829, 28751.281217969718, 28830.279243018253, 29073.7092629071, 29085.7091429083], "unit": "ms", "name": "ext.html", "value": 20186.152102691944}, {"lowerIsBetter": false, "replicates": [389.4314301120364, 390.4670125278993, 394.24502078519635, 396.99206015879685, 398.509832905526, 13907.1295728439, 17770.289188432445, 17892.821071789294, 19241.903790481047, 19252.13365398557, 17332.913335433335, 17776.11119444029, 17805.287788488444, 17807.0, 18133.546661333472, 5070.619703522232, 5167.276581278624, 5176.948230517703, 5184.611154163434, 5191.351081114861, 4019.839206431739, 4126.546079931205, 5108.310378098946, 5537.252470916415, 5763.596548241625, 5684.4315568443035, 5687.118496633028, 5696.829095127132, 5706.3722990471015, 5744.741486633091, 5827.242458480391, 6247.5939063960695, 6269.0, 6272.937270627281, 6274.623522588659, 5567.415421380737, 5651.886962260732, 5653.293338332708, 5669.0, 5684.602077854552, 13851.51519696816, 13875.375608097558, 17263.482095537154, 22337.32988010362, 22582.096716131335, 2250.696156018933, 2319.8028167605603, 2335.718479742838, 2374.3233178544206, 2385.2367242482414, 10001.949990250076, 10272.794544109076, 10282.177425805918, 10294.7426314342, 10323.432211228379, 1910.522369407648, 1942.4464027752165, 1942.7765806932243, 1943.9708404373946, 1994.4914046918088, 65368.34631653718, 66174.66912665454, 66998.66500667515, 68078.65960670165, 68866.0, 10787.352758834495, 10954.287971281841, 10980.725481862857, 11027.44862756859, 11045.447727613588, 14534.636634084021, 14750.778738318933, 14763.0, 14782.26088695561, 14803.851961480463, 7825.843483130419, 7834.804129896685, 7988.0, 8038.0, 8051.718189863327, 7434.0, 7485.625718714043, 7516.962415187889, 7524.209957954446, 7535.660895259726, 4672.275797251432, 4713.74074425903, 4718.95281047192, 4729.172394830891, 4767.833125840648, 1697.2787393747387, 1792.345793785259, 1895.4218963216351, 1940.0590713503939, 1940.3596813051659, 485.9684120532154, 894.9731508054768, 1041.0162396535202, 1082.6643740440331, 1122.1583812140893, 9805.460699661444, 10559.313644613076, 10992.17558683102, 11054.889451105546, 11120.38837863909, 469.53985094607475, 472.17605278788045, 473.5288388053908, 477.7658947115888, 492.78071258290436, 6181.567290289637, 6265.342139075423, 6351.110844481776, 6410.262819775786, 6421.197350331208, 643216.0, 649762.0, 654226.0, 664742.0, 680372.0, 77860.0, 78114.0, 87101.0, 87101.12898871057, 87624.0, 1175.5767923547517, 1189.8420347792417, 1195.3963248559596, 1206.1617176062553, 1210.0501106631252, 16514.489483159836, 16564.503064908073, 16581.253843576826, 16647.334106636084, 16841.9894806312, 37159.81420092882, 37214.62785372112, 37291.44062839005, 37417.625823741415, 37888.24223515459, 48269.275960859915, 50248.0, 53155.202671960724, 53703.19445208247, 55268.44731552633, 9483.383580067273, 9552.522373881417, 9714.75713107178, 9752.756181095529, 9833.754156146153, 11580.88419115798, 11818.290902545874, 14345.0, 17697.115144242995, 18085.186166622796, 14715.264236787903, 14978.700425991638, 15082.17048062367, 15329.156896370807, 15382.92308538495, 14659.267036648338, 14803.481878134213, 14976.0, 15387.61530961735, 15402.69194616079, 15253.16107614092, 15330.0, 15575.0, 15579.298931548334, 15941.521754347388, 9879.851802223116, 10355.94822025885, 10386.532606032897, 10658.467076646291, 10751.731206719895, 10642.73393165177, 14841.0, 14885.106893586419, 14887.925560372129, 15280.388784448498], "unit": "ms", "name": "jquery.html", "value": 8879.476701151525}, {"lowerIsBetter": false, "replicates": [1366.2758737868933, 1500.1824005916774, 1510.1090356689551, 1825.6622524832908, 1825.99087004565, 7192.856142877139, 8181.3045891099255, 8336.791580210498, 8357.038940521841, 8358.205970432815, 8276.131006244348, 8407.495550266989, 8448.493090414579, 8449.155084491547, 8463.788405289872, 2056.2083597814876, 2088.112552165331, 2324.744278129413, 2409.6265078912797, 2441.9633705494343, 2387.5224955009066, 2391.6412538119334, 2392.425817803732, 2393.9162129325478, 2394.760523947609, 2358.469344397505, 2403.567357875582, 2420.5884999550117, 2423.0, 2425.527022230666, 2388.080588973249, 2396.2571602803187, 2428.2351059416314, 2429.307647320523, 2431.161249368965, 2422.563938491071, 2447.229122826304, 2451.82837201396, 2453.3498622864954, 2478.1698131126095, 8386.3710221733, 8399.496030238144, 8463.915360846375, 8481.19428654283, 8489.575521223976, 5013.774380152902, 5086.262491938648, 5113.744312784346, 5124.359455068116, 5132.794688212467, 3201.15169480088, 3219.645838957713, 3274.9672503275137, 3308.040668206217, 3308.4044871923043, 1018.6332920148741, 1019.4851599941982, 1034.0383443397636, 1037.165082108902, 1037.362022356253, 11602.825957610643, 11630.360330181837, 11636.94181529087, 11643.53425862973, 11660.591879284184, 4579.793909274091, 4623.653226008063, 4646.581807637262, 4670.299455081697, 4681.976590117028, 9877.950610246902, 9894.455804930654, 9900.900990990142, 9907.80184396308, 9922.454265015349, 5143.12566863634, 5146.176611742103, 5149.7940082397035, 5161.535461808456, 5169.68981861082, 4589.311603259538, 4638.744869032235, 4641.675082744243, 4646.233371493733, 4653.022865198279, 3414.778039427429, 3464.272502774395, 3924.843006279774, 3976.1053762903693, 4000.0, 1272.8599854016052, 1278.9744205115846, 1291.599604122725, 1304.3478260869565, 1316.440512782083, 1103.6302838549016, 1103.7626910214342, 1330.6141219046563, 1370.2326697049684, 1401.516476815497, 7898.091719452336, 8011.118776934532, 8017.078036025931, 8023.0, 8029.156938521488, 1136.1762722026465, 1143.5825923537848, 1144.7882141803793, 1147.5639257082423, 1152.4871432212753, 6183.81448556535, 6255.437010669061, 6266.49868010558, 6271.247450305901, 6279.152314437584, 9719.56261968213, 10137.391756494486, 10140.847887281696, 10141.340812847142, 10225.744356391, 9838.557264923096, 9966.20270378368, 10102.898971010343, 10111.292209545261, 10124.088832005154, 7888.053433588007, 7957.920420795718, 7978.122406535276, 7980.561069141137, 7982.401319901031, 7477.887831682638, 7566.735164269224, 7567.508111972704, 7569.697212111454, 7592.8861067082935, 8728.869066963875, 8840.115988401109, 9040.547972601475, 9052.547372631474, 9069.319801015083, 9118.589663465293, 9171.724848254564, 9290.6283748652, 9297.628094876129, 9456.2907781918, 6391.936080639134, 7190.784276471714, 7290.854182916418, 7292.453066019963, 7295.379892709179, 7540.9622951884885, 7603.391728661583, 7777.883331750141, 7797.220277972384, 7797.454178207471, 7285.125784905846, 7556.206598307319, 7558.886616700644, 7619.199984001822, 7665.271799179069, 7443.404527637885, 7488.925110749041, 7493.400527957641, 7520.962395187989, 7556.055493063367, 7448.590327532038, 7466.962665186639, 7489.962550187214, 7505.924940750522, 7526.397888169043, 6696.19645642526, 6725.092112564741, 6747.696353663999, 6756.966215168893, 6757.86484270302, 6638.701258443478, 6861.485388595976, 6862.451003919774, 6863.347981941708, 6878.484113691593], "unit": "ms", "name": "mootools.html", "value": 4781.8272355331865}, {"lowerIsBetter": false, "replicates": [375.3862434918907, 380.4179605204039, 381.6469765466944, 384.9018500282427, 388.0299251870324, 6026.608270462417, 6068.059450785136, 6079.996800527908, 6081.4222648848345, 6088.995315772892, 5782.710864456771, 5850.970745146268, 5896.646201227929, 5986.970065149668, 6000.789972350958, 4702.05958808238, 4724.5984091352275, 4734.668573199878, 4746.810127594892, 4758.310045043467, 4505.617022553087, 4731.101090792756, 4732.077244937239, 4732.550407711262, 4742.027884283731, 4541.114482675879, 4573.131105090039, 4645.628349732014, 4653.929596192877, 4670.042641258551, 4620.122176786416, 4669.136209801164, 4698.38920940279, 4699.389079419688, 4713.198756211452, 4181.310083836163, 4183.309753890604, 4184.7070705050655, 4188.4136220929095, 4190.874273771761, 5684.261046064026, 5741.3110426748635, 5741.511971482429, 5750.108733146369, 5750.2237197978575, 5501.202325662756, 5505.3393592768725, 5507.697076660782, 5507.834764957058, 5509.972450137764, 6457.935420645827, 6460.3862633049785, 6467.159269294962, 6468.417842394207, 6468.547201695883, 4627.976860115711, 4629.86110416688, 4631.791569379386, 4637.350770892078, 4644.8374306899095, 6499.155109835739, 6593.835154121138, 6646.936490161551, 6647.800565983028, 6652.600843949379, 4792.9281060784115, 4815.7351345676325, 4818.831340903052, 4822.397200349957, 4823.614110871122, 4873.342098816685, 4875.68308059975, 4879.26810978349, 4881.682690625169, 4887.462379138292, 5424.457554244544, 5493.423190565013, 5501.229827824108, 5501.724913754297, 5503.532199763065, 6456.903146452807, 6478.805635830932, 6482.0, 6485.67571621417, 6486.091947127406, 1699.7110491216522, 1715.5110793423814, 1716.0132923568997, 1716.5451155443818, 1716.7339062445092, 1175.3946717440524, 1181.9645410637695, 1187.9940600296943, 1190.6428071578491, 1206.9758604827855, 6255.749770009149, 6256.155419018465, 6257.124002639634, 6276.529260305404, 6278.874422511524, 6497.740090396425, 6682.164729408824, 6691.698873550702, 6691.7323307068145, 6693.564918280296, 6204.0, 6237.251529816361, 6324.841878953063, 6327.272363678236, 6350.4284614384005, 3599.3161299353037, 3623.547056617923, 3633.255182687543, 3636.818159092035, 3641.7268704847243, 6733.494987875831, 6886.758963436256, 6887.690053947585, 6891.448684105259, 6902.654867256617, 6874.759383421556, 6883.070785443901, 6884.208316043619, 6887.758928437581, 6896.931030689629, 6764.019217213575, 6768.289329620417, 6769.492288078413, 6771.864562708817, 6782.084418603524, 6617.106690596708, 6712.6979285931275, 6727.428168605723, 6729.394354507922, 6735.292794256533, 6571.145751052332, 6631.137952066393, 6631.568948018364, 6636.43590294811, 6638.767643132467, 6833.555818871758, 6869.072675188786, 6871.690773915286, 6877.071595334566, 6887.414569761627, 4700.153972285021, 4780.4741478436645, 4785.545373189541, 4791.784369703441, 4794.496577859414, 6724.991251312146, 6731.427828634425, 6734.831629209309, 6740.528163028541, 6743.629100399525, 6490.837729056811, 6506.284308726131, 6548.410643041959, 6556.147700798866, 6565.0, 6445.2265728112925, 6534.150560427114, 6541.378569035934, 6542.149520562297, 6543.345665433419, 6423.807285781434, 6426.582272152295, 6430.131932189094, 6434.420902118832, 6444.806655800334, 6557.0, 6561.475081993524, 6561.540692151503, 6563.704633291609, 6567.277599464151, 6319.715612797343, 6406.327335629691, 6410.262819775786, 6417.582857114273, 6421.261554921244], "unit": "ms", "name": "prototype.html", "value": 4948.452679069614}, {"lowerIsBetter": false, "replicates": [713.3971793834211, 775.5966897213449, 787.858185526605, 790.9485883417574, 804.2520455975941, 13467.259300738455, 13790.103643263194, 13791.862081379184, 13823.65440863979, 13828.792568111487, 12349.62951111466, 12910.419031143598, 12915.870841291608, 12921.935390323035, 12931.676708082303, 769.8229407236339, 772.5210369570846, 912.1061359867334, 912.8219997100568, 936.129399658321, 927.5686805635378, 928.7399528132133, 933.9486328251943, 934.5093825741507, 934.7102398256562, 781.238292664653, 964.1033838530165, 964.4502633498909, 968.7335982604804, 969.1616751509964, 768.4006474949548, 769.4882902869585, 770.0759089093111, 770.8920751094823, 943.8725772020758, 715.8174665460326, 722.50869408802, 722.6350692900104, 722.8373615936425, 724.380654540371, 12543.372831358487, 12673.683157921034, 12715.618531444072, 12723.872761272454, 12727.681807954783, 12387.62837114888, 12936.935315323362, 13123.803142952864, 13149.60551183466, 13188.340582970814, 10122.645707400206, 10186.439745813977, 10223.897761022368, 10316.58733650653, 10389.79220415595, 3731.328360895038, 3807.695384369244, 3815.6947444204675, 3817.618238176188, 3819.579846216914, 48549.27176092361, 49268.75365623149, 50046.0, 50566.0, 50584.0, 9652.90347096534, 9725.513724313756, 9745.65890193854, 9762.75593110178, 9765.853512197322, 18980.43058708241, 19173.233070677295, 19180.904095479433, 19219.32732354361, 19317.61364772697, 7418.480706350504, 7614.885776713354, 7642.312191902755, 7711.845763084707, 7902.3678105751405, 4530.524294948983, 4566.337881007235, 4581.931271030937, 4642.9535704643195, 4664.323673067454, 3224.951625725616, 3238.8380580970856, 3245.8701651933657, 3254.23525471514, 3261.608606967179, 567.7133047810829, 577.2899333819341, 583.5156819839523, 591.4026832898803, 593.890130325891, 563.2086917880384, 572.2389222334285, 595.0093094996869, 613.6440864298696, 618.8731310081422, 8835.614384116381, 8863.822723545492, 9056.683016094405, 9118.0, 9268.25853931684, 493.76546140583656, 609.6981993913041, 614.4776939601393, 617.4720613875072, 642.5254041973682, 3831.4635950966886, 3853.6917046636204, 3860.1507668312925, 3916.0, 3936.9295925874353, 63302.366976330566, 64734.676326618064, 64888.35111648823, 64922.0, 64962.0, 55646.72176639172, 56322.0, 57208.42791572114, 57322.14016789668, 57472.137917931264, 50828.49171508312, 50924.47226583208, 51037.0, 51204.0, 51626.74186629118, 7949.165337639464, 7991.84016319682, 8069.435139540411, 8126.553039582644, 8288.544130072663, 34061.65938340585, 34705.0, 35644.0, 35669.0, 36375.272494549434, 43600.0, 44106.11787764291, 48753.0, 49511.25733114078, 50068.24897626611, 9679.225661946886, 10022.0, 10069.546870390703, 10150.238732094975, 10486.37081775096, 12648.936755316165, 12826.74346513046, 12977.610671679487, 13020.544280950122, 13430.328483575977, 10942.343459392461, 11610.0, 11763.176577639826, 11880.702982425508, 12157.08821838348, 10472.895271047497, 10493.370397776158, 10907.509162087566, 11409.315441073562, 11853.407329633656, 10767.515461804081, 10903.618373356894, 11204.551817927191, 11214.495347709535, 11355.48900299472, 9365.157135857806, 9400.576974036321, 9487.57305921249, 9513.381630194015, 10163.44101074448, 9604.85592716096, 9649.662261821084, 9781.608735650494, 9796.559154838193, 9846.0], "unit": "ms", "name": "yui.html", "value": 6434.980819632841}], "name": "dromaeo_css", "value": 7287.297236383603}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 105.0, 107.0, 109.0, 108.0, 97.0, 108.0, 110.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 106.9}, {"lowerIsBetter": true, "replicates": [149.0, 129.0, 148.0, 167.0, 125.0, 143.0, 152.0, 122.0, 163.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.0}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 160.0, 162.0, 162.0, 161.0, 160.0, 158.0, 159.0], "unit": "ms", "name": "audio-dft", "value": 160.4}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 72.0, 160.0, 70.0, 71.0, 70.0, 73.0, 159.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 89.2}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 152.0, 93.0, 93.0, 94.0, 146.0, 93.0, 93.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 147.0, 145.0, 145.0, 145.0, 147.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 58.0, 56.0, 60.0, 55.0, 57.0, 57.0, 56.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 56.3}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 65.0, 64.0, 67.0, 64.0, 66.0, 65.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.8}, {"lowerIsBetter": true, "replicates": [79.0, 80.0, 81.0, 81.0, 80.0, 81.0, 81.0, 81.0, 82.0, 89.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 81.5}, {"lowerIsBetter": true, "replicates": [118.0, 110.0, 122.0, 112.0, 119.0, 121.0, 115.0, 119.0, 111.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 116.8}, {"lowerIsBetter": true, "replicates": [138.0, 136.0, 146.0, 146.0, 145.0, 137.0, 148.0, 149.0, 142.0, 133.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.0}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 67.0, 65.0, 67.0, 66.0, 64.0, 65.0, 66.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.5}], "name": "kraken", "value": 1484.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.9620587264929], "unit": "score", "name": "Richards", "value": 214.00072399999993}, {"lowerIsBetter": false, "replicates": [173.58097552508247], "unit": "score", "name": "DeltaBlue", "value": 380.90579799999983}, {"lowerIsBetter": false, "replicates": [279.17364600781684], "unit": "score", "name": "Encrypt", "value": 953.4603419999996}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [957.8544061302682], "unit": "score", "name": "RayTrace", "value": 772.5485159999996}, {"lowerIsBetter": false, "replicates": [558.3472920156337], "unit": "score", "name": "Earley", "value": 1193.6352329999995}, {"lowerIsBetter": false, "replicates": [11109.89010989011], "unit": "score", "name": "Boyer", "value": 59.98826211671617}, {"lowerIsBetter": false, "replicates": [24439.024390243903], "unit": "score", "name": "RegExp", "value": 37.27583333333335}, {"lowerIsBetter": false, "replicates": [525.4860746190226], "unit": "score", "name": "Splay", "value": 155.077373}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 22965.711358693447}]} 16:58:39 INFO - RETURN: dromaeo_css: 7287.30 16:58:39 INFO - RETURN: kraken: 1484.20 16:58:39 INFO - RETURN: v8_7: 22965.71 16:58:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "22965.71"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1484.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7287.30"}}} 16:58:39 INFO - Return code: 0 16:58:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:58:39 INFO - # TBPL SUCCESS # 16:58:39 INFO - Running post-action listener: _resource_record_post_action 16:58:39 INFO - Running post-run listener: _resource_record_post_run 16:58:40 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 0; Write bytes: 515162112; Read time: 0; Write time: 546352 16:58:40 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 246996992; Read time: 0; Write time: 377708 16:58:40 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 0; Write bytes: 263958528; Read time: 0; Write time: 168164 16:58:40 INFO - Running post-run listener: _upload_blobber_files 16:58:40 INFO - Blob upload gear active. 16:58:40 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:58:40 INFO - Copying logs to upload dir... 16:58:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1259.494460 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-01-22 16:58:39.855589) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-22 16:58:39.859252) ========= 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=cbe409c6de289db6ac707de3000001d4-1453508479.483616-2145164124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009946 build_url: 'https://queue.taskcluster.net/v1/task/ybNU5KrkTpmf1LTCumLbdw/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-22 16:58:39.911425) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:58:39.911819) ========= 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=cbe409c6de289db6ac707de3000001d4-1453508479.483616-2145164124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004647 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:58:39.962091) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 16:58:39.962442) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 16:58:39.962789) ========= ========= Total master_lag: 0.60 =========