builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-029 starttime: 1453391175.54 results: success (0) buildid: 20160121051922 builduid: 321dedcc02c547fbbb26220ac70a955c revision: 57a4738271792310f2b061fee8447060b13e961d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 07:46:15.542551) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 07:46:15.543395) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 07:46:15.543941) ========= 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=0274524eba3bdaad075c2247000001d4-1453390492.223816-1062301691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006397 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 07:46:15.568274) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 07:46:15.568606) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 07:46:15.581865) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:46:15.582262) ========= 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=0274524eba3bdaad075c2247000001d4-1453390492.223816-1062301691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004662 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:46:15.632549) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 07:46:15.632859) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 07:46:15.633228) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:46:15.633526) ========= 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=0274524eba3bdaad075c2247000001d4-1453390492.223816-1062301691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-21 07:46:16-- 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-21 07:46:16 (35.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.138847 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:46:15.784984) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:46:15.785331) ========= 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=0274524eba3bdaad075c2247000001d4-1453390492.223816-1062301691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021931 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:46:15.835549) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:46:15.836007) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 57a4738271792310f2b061fee8447060b13e961d --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 57a4738271792310f2b061fee8447060b13e961d --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=0274524eba3bdaad075c2247000001d4-1453390492.223816-1062301691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-21 07:46:16,427 truncating revision to first 12 chars 2016-01-21 07:46:16,427 Setting DEBUG logging. 2016-01-21 07:46:16,427 attempt 1/10 2016-01-21 07:46:16,427 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/57a473827179?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-21 07:46:16,681 unpacking tar archive at: mozilla-aurora-57a473827179/testing/mozharness/ program finished with exit code 0 elapsedTime=0.544050 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:46:16.394898) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 07:46:16.395557) ========= echo 57a4738271792310f2b061fee8447060b13e961d in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'57a4738271792310f2b061fee8447060b13e961d'] 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=0274524eba3bdaad075c2247000001d4-1453390492.223816-1062301691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 57a4738271792310f2b061fee8447060b13e961d program finished with exit code 0 elapsedTime=0.004651 script_repo_revision: '57a4738271792310f2b061fee8447060b13e961d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 07:46:16.447603) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 07:46:16.447936) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 07:46:16.458535) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-21 07:46:16.458876) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/57a4738271792310f2b061fee8447060b13e961d ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-21 07:46:16.459305) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-21 07:46:16.459618) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=0274524eba3bdaad075c2247000001d4-1453390492.223816-1062301691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:46:17 INFO - MultiFileLogger online at 20160121 07:46:17 in /builds/slave/test-pgo 07:46:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:46:17 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:46:17 INFO - {'append_to_log': False, 07:46:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:46:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:46:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:46:17 INFO - 'branch': 'Mozilla-Aurora', 07:46:17 INFO - 'buildbot_json_path': 'buildprops.json', 07:46:17 INFO - 'config_files': ('talos/linux_config.py',), 07:46:17 INFO - 'default_actions': ('clobber', 07:46:17 INFO - 'read-buildbot-config', 07:46:17 INFO - 'download-and-extract', 07:46:17 INFO - 'populate-webroot', 07:46:17 INFO - 'create-virtualenv', 07:46:17 INFO - 'install', 07:46:17 INFO - 'run-tests'), 07:46:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:46:17 INFO - 'download_minidump_stackwalk': True, 07:46:17 INFO - 'download_symbols': 'ondemand', 07:46:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:46:17 INFO - 'tooltool.py': '/tools/tooltool.py', 07:46:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:46:17 INFO - '/tools/misc-python/virtualenv.py')}, 07:46:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:46:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:46:17 INFO - 'installer_path': 'installer.exe', 07:46:17 INFO - 'log_level': 'info', 07:46:17 INFO - 'log_name': 'talos', 07:46:17 INFO - 'log_to_console': True, 07:46:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:46:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:46:17 INFO - 'opt_config_files': (), 07:46:17 INFO - 'pip_index': False, 07:46:17 INFO - 'sps_profile': False, 07:46:17 INFO - 'sps_profile_interval': 0, 07:46:17 INFO - 'suite': 'dromaeojs-e10s', 07:46:17 INFO - 'system_bits': '32', 07:46:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:46:17 INFO - 'title': 'talos-linux64-ix-029', 07:46:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:46:17 INFO - 'use_talos_json': True, 07:46:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:46:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:46:17 INFO - 'work_dir': 'build'} 07:46:17 INFO - ##### 07:46:17 INFO - ##### Running clobber step. 07:46:17 INFO - ##### 07:46:17 INFO - Running pre-action listener: _resource_record_pre_action 07:46:17 INFO - Running main action method: clobber 07:46:17 INFO - rmtree: /builds/slave/test-pgo/build 07:46:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:46:18 INFO - Running post-action listener: _resource_record_post_action 07:46:18 INFO - ##### 07:46:18 INFO - ##### Running read-buildbot-config step. 07:46:18 INFO - ##### 07:46:18 INFO - Running pre-action listener: _resource_record_pre_action 07:46:18 INFO - Running main action method: read_buildbot_config 07:46:18 INFO - Using buildbot properties: 07:46:18 INFO - { 07:46:18 INFO - "properties": { 07:46:18 INFO - "buildnumber": 8, 07:46:18 INFO - "product": "firefox", 07:46:18 INFO - "script_repo_revision": "production", 07:46:18 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 07:46:18 INFO - "repository": "", 07:46:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 07:46:18 INFO - "buildid": "20160121051922", 07:46:18 INFO - "slavename": "talos-linux64-ix-029", 07:46:18 INFO - "pgo_build": "True", 07:46:18 INFO - "basedir": "/builds/slave/test-pgo", 07:46:18 INFO - "project": "", 07:46:18 INFO - "platform": "ubuntu64_hw", 07:46:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:46:18 INFO - "slavebuilddir": "test", 07:46:18 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:46:18 INFO - "branch": "mozilla-aurora", 07:46:18 INFO - "repo_path": "releases/mozilla-aurora", 07:46:18 INFO - "stage_platform": "linux64-pgo", 07:46:18 INFO - "builduid": "321dedcc02c547fbbb26220ac70a955c", 07:46:18 INFO - "revision": "57a4738271792310f2b061fee8447060b13e961d" 07:46:18 INFO - }, 07:46:18 INFO - "sourcestamp": { 07:46:18 INFO - "repository": "", 07:46:18 INFO - "hasPatch": false, 07:46:18 INFO - "project": "", 07:46:18 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 07:46:18 INFO - "changes": [ 07:46:18 INFO - { 07:46:18 INFO - "category": null, 07:46:18 INFO - "files": [ 07:46:18 INFO - { 07:46:18 INFO - "url": null, 07:46:18 INFO - "name": "https://queue.taskcluster.net/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 07:46:18 INFO - } 07:46:18 INFO - ], 07:46:18 INFO - "repository": "", 07:46:18 INFO - "rev": "57a4738271792310f2b061fee8447060b13e961d", 07:46:18 INFO - "who": "cbook@mozilla.com", 07:46:18 INFO - "when": 1453391149, 07:46:18 INFO - "number": 7493146, 07:46:18 INFO - "comments": "Backed out changeset a812bb3848d0 (bug 1237179) for test failures in VideoPuppeteer Media Tests", 07:46:18 INFO - "project": "", 07:46:18 INFO - "at": "Thu 21 Jan 2016 07:45:49", 07:46:18 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 07:46:18 INFO - "revlink": "", 07:46:18 INFO - "properties": [ 07:46:18 INFO - [ 07:46:18 INFO - "buildid", 07:46:18 INFO - "20160121051922", 07:46:18 INFO - "Change" 07:46:18 INFO - ], 07:46:18 INFO - [ 07:46:18 INFO - "builduid", 07:46:18 INFO - "321dedcc02c547fbbb26220ac70a955c", 07:46:18 INFO - "Change" 07:46:18 INFO - ], 07:46:18 INFO - [ 07:46:18 INFO - "pgo_build", 07:46:18 INFO - "True", 07:46:18 INFO - "Change" 07:46:18 INFO - ] 07:46:18 INFO - ], 07:46:18 INFO - "revision": "57a4738271792310f2b061fee8447060b13e961d" 07:46:18 INFO - } 07:46:18 INFO - ], 07:46:18 INFO - "revision": "57a4738271792310f2b061fee8447060b13e961d" 07:46:18 INFO - } 07:46:18 INFO - } 07:46:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 07:46:18 INFO - Running post-action listener: _resource_record_post_action 07:46:18 INFO - ##### 07:46:18 INFO - ##### Running download-and-extract step. 07:46:18 INFO - ##### 07:46:18 INFO - Running pre-action listener: _resource_record_pre_action 07:46:18 INFO - Running main action method: download_and_extract 07:46:18 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:46:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:18 INFO - https://queue.taskcluster.net/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:46:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/artifacts/public/build/test_packages.json 07:46:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/artifacts/public/build/test_packages.json 07:46:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:46:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:46:20 INFO - Downloaded 1302 bytes. 07:46:20 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:46:20 INFO - Using the following test package requirements: 07:46:20 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 07:46:20 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 07:46:20 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:46:20 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 07:46:20 INFO - u'jsshell-linux-x86_64.zip'], 07:46:20 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 07:46:20 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:46:20 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 07:46:20 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 07:46:20 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:46:20 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 07:46:20 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:46:20 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 07:46:20 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:46:20 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 07:46:20 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 07:46:20 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:46:20 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:46:20 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')]} 07:46:20 INFO - https://queue.taskcluster.net/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:46:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 07:46:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 07:46:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/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 07:46:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/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 07:46:23 INFO - Downloaded 23160682 bytes. 07:46:23 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 07:46:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 07:46:23 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 07:46:24 INFO - Return code: 0 07:46:24 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 07:46:24 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')]} 07:46:24 INFO - https://queue.taskcluster.net/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:46:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 07:46:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 07:46:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/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 07:46:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/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 07:46:28 INFO - Downloaded 23160682 bytes. 07:46:28 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 07:46:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 07:46:28 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 07:46:29 INFO - Return code: 0 07:46: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')]} 07:46:29 INFO - https://queue.taskcluster.net/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:46:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 07:46:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 07:46:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/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 07:46:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/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 07:46:30 INFO - Downloaded 11132038 bytes. 07:46:30 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 07:46:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 07:46:30 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 07:46:31 INFO - Return code: 0 07:46:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:31 INFO - https://queue.taskcluster.net/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:46:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 07:46:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 07:46:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/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 07:46:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/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 07:46:33 INFO - Downloaded 58133675 bytes. 07:46:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 07:46:33 INFO - mkdir: /builds/slave/test-pgo/properties 07:46:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:46:33 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:46:33 INFO - Contents: 07:46:33 INFO - build_url:https://queue.taskcluster.net/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 07:46:33 INFO - Running post-action listener: _resource_record_post_action 07:46:33 INFO - Running post-action listener: set_extra_try_arguments 07:46:33 INFO - ##### 07:46:33 INFO - ##### Running populate-webroot step. 07:46:33 INFO - ##### 07:46:33 INFO - Running pre-action listener: _resource_record_pre_action 07:46:33 INFO - Running main action method: populate_webroot 07:46:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:46:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:46:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:46:33 INFO - '--tppagecycles', 07:46:33 INFO - '7'], 07:46:33 INFO - 'tests': ['tsvgm']}}, 07:46:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:46:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:46:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:46:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:46:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:46:33 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:46:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:33 INFO - 'talos_options': ['--e10s'], 07:46:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:33 INFO - 'tests': ['damp', 'tps']}, 07:46:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:33 INFO - 'talos_options': ['--e10s'], 07:46:33 INFO - 'tests': ['damp', 'tps']}, 07:46:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:46:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:46:33 INFO - 'other': {'tests': ['a11yr', 07:46:33 INFO - 'ts_paint', 07:46:33 INFO - 'tpaint', 07:46:33 INFO - 'sessionrestore', 07:46:33 INFO - 'sessionrestore_no_auto_restore']}, 07:46:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:46:33 INFO - 'tests': ['a11yr', 07:46:33 INFO - 'ts_paint', 07:46:33 INFO - 'tpaint', 07:46:33 INFO - 'sessionrestore', 07:46:33 INFO - 'sessionrestore_no_auto_restore']}, 07:46:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:46:33 INFO - 'tests': ['a11yr', 07:46:33 INFO - 'ts_paint', 07:46:33 INFO - 'tpaint', 07:46:33 INFO - 'sessionrestore', 07:46:33 INFO - 'sessionrestore_no_auto_restore']}, 07:46:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:46:33 INFO - 'tests': ['a11yr', 07:46:33 INFO - 'ts_paint', 07:46:33 INFO - 'tpaint', 07:46:33 INFO - 'sessionrestore', 07:46:33 INFO - 'sessionrestore_no_auto_restore']}, 07:46:33 INFO - 'other_l64': {'tests': ['a11yr', 07:46:33 INFO - 'ts_paint', 07:46:33 INFO - 'tpaint', 07:46:33 INFO - 'sessionrestore', 07:46:33 INFO - 'sessionrestore_no_auto_restore']}, 07:46:33 INFO - 'other_nol64': {'tests': ['a11yr', 07:46:33 INFO - 'ts_paint', 07:46:33 INFO - 'tpaint', 07:46:33 INFO - 'sessionrestore', 07:46:33 INFO - 'sessionrestore_no_auto_restore']}, 07:46:33 INFO - 'svgr': {'tests': ['tsvgx', 07:46:33 INFO - 'tsvgr_opacity', 07:46:33 INFO - 'tart', 07:46:33 INFO - 'tscrollx', 07:46:33 INFO - 'cart']}, 07:46:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:46:33 INFO - 'tests': ['tsvgx', 07:46:33 INFO - 'tsvgr_opacity', 07:46:33 INFO - 'tart', 07:46:33 INFO - 'tscrollx', 07:46:33 INFO - 'cart']}, 07:46:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:33 INFO - 'tests': ['tp5o']}, 07:46:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:33 INFO - 'talos_options': ['--e10s'], 07:46:33 INFO - 'tests': ['tp5o']}, 07:46:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:33 INFO - 'talos_options': ['--xperf_path', 07:46:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:33 INFO - 'tests': ['tp5n']}, 07:46:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:33 INFO - 'talos_options': ['--e10s', 07:46:33 INFO - '--xperf_path', 07:46:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:33 INFO - 'tests': ['tp5n']}}, 07:46:33 INFO - 'talos.zip': {'path': '', 07:46:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:46:33 INFO - Running post-action listener: _resource_record_post_action 07:46:33 INFO - ##### 07:46:33 INFO - ##### Running create-virtualenv step. 07:46:33 INFO - ##### 07:46:33 INFO - Running pre-action listener: _resource_record_pre_action 07:46:33 INFO - Running main action method: create_virtualenv 07:46:33 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:46:33 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 07:46:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:46:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:46:33 INFO - Using real prefix '/usr' 07:46:33 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:46:33 INFO - Installing distribute.............................................................................................................................................................................................done. 07:46:35 INFO - Installing pip.................done. 07:46:35 INFO - Return code: 0 07:46:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:46:35 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')]} 07:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:35 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')]} 07:46:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:35 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 0x7fda21800f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d0450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2262a50>, '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 0x21ce550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ce9e0>, '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': '0274524eba3bdaad075c2247000001d4-1453390492.223816-1062301691', '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 07:46:35 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 07:46:35 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 07:46:35 INFO - Using env: {'DISPLAY': ':0', 07:46:35 INFO - 'HOME': '/home/cltbld', 07:46:35 INFO - 'LANG': 'en_US.UTF-8', 07:46:35 INFO - 'LANGUAGE': 'en_US:en', 07:46:35 INFO - 'LOGNAME': 'cltbld', 07:46:35 INFO - 'MAIL': '/var/mail/cltbld', 07:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:35 INFO - 'MOZ_NO_REMOTE': '1', 07:46:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:35 INFO - 'NO_EM_RESTART': '1', 07:46:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:46:35 INFO - 'PWD': '/builds/slave/test-pgo', 07:46:35 INFO - 'SHELL': '/bin/bash', 07:46:35 INFO - 'SHLVL': '1', 07:46:35 INFO - 'TERM': 'linux', 07:46:35 INFO - 'TMOUT': '86400', 07:46:35 INFO - 'USER': 'cltbld', 07:46:35 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1453390492.223816-1062301691', 07:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:35 INFO - '_': '/tools/buildbot/bin/python'} 07:46:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:36 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 07:46:36 INFO - Cleaning up... 07:46:36 INFO - Return code: 0 07:46:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:46:36 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')]} 07:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:36 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')]} 07:46:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:36 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 0x7fda21800f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d0450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2262a50>, '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 0x21ce550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ce9e0>, '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': '0274524eba3bdaad075c2247000001d4-1453390492.223816-1062301691', '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 07:46:36 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 07:46:36 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 07:46:36 INFO - Using env: {'DISPLAY': ':0', 07:46:36 INFO - 'HOME': '/home/cltbld', 07:46:36 INFO - 'LANG': 'en_US.UTF-8', 07:46:36 INFO - 'LANGUAGE': 'en_US:en', 07:46:36 INFO - 'LOGNAME': 'cltbld', 07:46:36 INFO - 'MAIL': '/var/mail/cltbld', 07:46:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:36 INFO - 'MOZ_NO_REMOTE': '1', 07:46:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:36 INFO - 'NO_EM_RESTART': '1', 07:46:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:46:36 INFO - 'PWD': '/builds/slave/test-pgo', 07:46:36 INFO - 'SHELL': '/bin/bash', 07:46:36 INFO - 'SHLVL': '1', 07:46:36 INFO - 'TERM': 'linux', 07:46:36 INFO - 'TMOUT': '86400', 07:46:36 INFO - 'USER': 'cltbld', 07:46:36 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1453390492.223816-1062301691', 07:46:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:36 INFO - '_': '/tools/buildbot/bin/python'} 07:46:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:36 INFO - Downloading/unpacking psutil>=0.7.1 07:46:36 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 07:46:36 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 07:46:36 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 07:46:36 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 07:46:36 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 07:46:36 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 07:46:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:46:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:38 INFO - Installing collected packages: psutil 07:46:38 INFO - Running setup.py install for psutil 07:46:38 INFO - building 'psutil._psutil_linux' extension 07:46:38 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 07:46:38 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 07:46:38 INFO - building 'psutil._psutil_posix' extension 07:46:38 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 07:46:38 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 07:46:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:38 INFO - Successfully installed psutil 07:46:38 INFO - Cleaning up... 07:46:38 INFO - Return code: 0 07:46:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:38 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 0x7fda21800f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d0450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2262a50>, '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 0x21ce550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ce9e0>, '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': '0274524eba3bdaad075c2247000001d4-1453390492.223816-1062301691', '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 07:46:38 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 07:46:38 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 07:46:38 INFO - Using env: {'DISPLAY': ':0', 07:46:38 INFO - 'HOME': '/home/cltbld', 07:46:38 INFO - 'LANG': 'en_US.UTF-8', 07:46:38 INFO - 'LANGUAGE': 'en_US:en', 07:46:38 INFO - 'LOGNAME': 'cltbld', 07:46:38 INFO - 'MAIL': '/var/mail/cltbld', 07:46:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:38 INFO - 'MOZ_NO_REMOTE': '1', 07:46:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:38 INFO - 'NO_EM_RESTART': '1', 07:46:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:46:38 INFO - 'PWD': '/builds/slave/test-pgo', 07:46:38 INFO - 'SHELL': '/bin/bash', 07:46:38 INFO - 'SHLVL': '1', 07:46:38 INFO - 'TERM': 'linux', 07:46:38 INFO - 'TMOUT': '86400', 07:46:38 INFO - 'USER': 'cltbld', 07:46:38 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1453390492.223816-1062301691', 07:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:38 INFO - '_': '/tools/buildbot/bin/python'} 07:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:46:38 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 07:46:38 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 07:46:38 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 07:46:38 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 07:46:38 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 07:46:38 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 07:46:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:46:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:46:40 INFO - Installing collected packages: mozsystemmonitor 07:46:40 INFO - Running setup.py install for mozsystemmonitor 07:46:40 INFO - Successfully installed mozsystemmonitor 07:46:40 INFO - Cleaning up... 07:46:40 INFO - Return code: 0 07:46:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:40 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 0x7fda21800f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d0450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2262a50>, '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 0x21ce550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ce9e0>, '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': '0274524eba3bdaad075c2247000001d4-1453390492.223816-1062301691', '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 07:46:40 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 07:46:40 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 07:46:40 INFO - Using env: {'DISPLAY': ':0', 07:46:40 INFO - 'HOME': '/home/cltbld', 07:46:40 INFO - 'LANG': 'en_US.UTF-8', 07:46:40 INFO - 'LANGUAGE': 'en_US:en', 07:46:40 INFO - 'LOGNAME': 'cltbld', 07:46:40 INFO - 'MAIL': '/var/mail/cltbld', 07:46:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:40 INFO - 'MOZ_NO_REMOTE': '1', 07:46:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:40 INFO - 'NO_EM_RESTART': '1', 07:46:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:46:40 INFO - 'PWD': '/builds/slave/test-pgo', 07:46:40 INFO - 'SHELL': '/bin/bash', 07:46:40 INFO - 'SHLVL': '1', 07:46:40 INFO - 'TERM': 'linux', 07:46:40 INFO - 'TMOUT': '86400', 07:46:40 INFO - 'USER': 'cltbld', 07:46:40 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1453390492.223816-1062301691', 07:46:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:40 INFO - '_': '/tools/buildbot/bin/python'} 07:46:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:41 INFO - Downloading/unpacking blobuploader==1.2.4 07:46:41 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 07:46:41 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 07:46:41 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 07:46:41 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 07:46:41 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 07:46:41 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 07:46:42 INFO - Downloading blobuploader-1.2.4.tar.gz 07:46:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:46:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:46:42 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 07:46:42 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 07:46:42 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 07:46:42 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 07:46:42 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 07:46:42 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 07:46:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:46:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:46:43 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 07:46:43 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 07:46:43 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 07:46:43 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 07:46:43 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 07:46:43 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 07:46:43 INFO - Downloading docopt-0.6.1.tar.gz 07:46:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:46:43 INFO - Installing collected packages: blobuploader, requests, docopt 07:46:43 INFO - Running setup.py install for blobuploader 07:46:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:46:43 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:46:43 INFO - Running setup.py install for requests 07:46:44 INFO - Running setup.py install for docopt 07:46:44 INFO - Successfully installed blobuploader requests docopt 07:46:44 INFO - Cleaning up... 07:46:44 INFO - Return code: 0 07:46:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:46: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')]} 07:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46: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')]} 07:46:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:44 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 0x7fda21800f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d0450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2262a50>, '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 0x21ce550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ce9e0>, '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': '0274524eba3bdaad075c2247000001d4-1453390492.223816-1062301691', '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 07:46:44 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 07:46:44 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 07:46:44 INFO - Using env: {'DISPLAY': ':0', 07:46:44 INFO - 'HOME': '/home/cltbld', 07:46:44 INFO - 'LANG': 'en_US.UTF-8', 07:46:44 INFO - 'LANGUAGE': 'en_US:en', 07:46:44 INFO - 'LOGNAME': 'cltbld', 07:46:44 INFO - 'MAIL': '/var/mail/cltbld', 07:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:44 INFO - 'MOZ_NO_REMOTE': '1', 07:46:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:44 INFO - 'NO_EM_RESTART': '1', 07:46:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:46:44 INFO - 'PWD': '/builds/slave/test-pgo', 07:46:44 INFO - 'SHELL': '/bin/bash', 07:46:44 INFO - 'SHLVL': '1', 07:46:44 INFO - 'TERM': 'linux', 07:46:44 INFO - 'TMOUT': '86400', 07:46:44 INFO - 'USER': 'cltbld', 07:46:44 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1453390492.223816-1062301691', 07:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:44 INFO - '_': '/tools/buildbot/bin/python'} 07:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:46:44 INFO - Running setup.py (path:/tmp/pip-I9biuI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:46:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:46:44 INFO - Running setup.py (path:/tmp/pip-0FfYqr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:46:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:46:44 INFO - Running setup.py (path:/tmp/pip-Bx8tS0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:46:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:46:44 INFO - Running setup.py (path:/tmp/pip-8W7KTa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:46:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:46:44 INFO - Running setup.py (path:/tmp/pip-tx9Tou-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:46:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:46:44 INFO - Running setup.py (path:/tmp/pip-5Wb9JT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:46:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:46:44 INFO - Running setup.py (path:/tmp/pip-jh0JW5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:46:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:46:44 INFO - Running setup.py (path:/tmp/pip-qBkyvG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:46:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:46:44 INFO - Running setup.py (path:/tmp/pip-Udci8r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:46:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:46:45 INFO - Running setup.py (path:/tmp/pip-r1aqnV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:46:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:46:45 INFO - Running setup.py (path:/tmp/pip-WEcB4o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:46:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:46:45 INFO - Running setup.py (path:/tmp/pip-WjId03-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:46:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:46:45 INFO - Running setup.py (path:/tmp/pip-wyoAZv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:46:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:46:45 INFO - Running setup.py (path:/tmp/pip-SdC7gN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:46:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:46:45 INFO - Running setup.py (path:/tmp/pip-znI1Qi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:46:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:46:45 INFO - Running setup.py (path:/tmp/pip-xUg1FI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:46:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:46:45 INFO - Running setup.py (path:/tmp/pip-8ATmqU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:46:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:46:45 INFO - Running setup.py install for manifestparser 07:46:45 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:46:45 INFO - Running setup.py install for mozcrash 07:46:45 INFO - Running setup.py install for mozdebug 07:46:45 INFO - Running setup.py install for mozdevice 07:46:46 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:46:46 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:46:46 INFO - Running setup.py install for mozfile 07:46:46 INFO - Running setup.py install for mozhttpd 07:46:46 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:46:46 INFO - Running setup.py install for mozinfo 07:46:46 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:46:46 INFO - Running setup.py install for mozInstall 07:46:46 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:46:46 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:46:46 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:46:46 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:46:46 INFO - Running setup.py install for mozleak 07:46:46 INFO - Running setup.py install for mozlog 07:46:46 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:46:46 INFO - Running setup.py install for moznetwork 07:46:46 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:46:46 INFO - Running setup.py install for mozprocess 07:46:46 INFO - Running setup.py install for mozprofile 07:46:46 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:46:46 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:46:46 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:46:46 INFO - Running setup.py install for mozrunner 07:46:47 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:46:47 INFO - Running setup.py install for mozscreenshot 07:46:47 INFO - Running setup.py install for moztest 07:46:47 INFO - Running setup.py install for mozversion 07:46:47 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:46:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:46:47 INFO - Cleaning up... 07:46:47 INFO - Return code: 0 07:46:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:46:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:47 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 0x7fda21800f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d0450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2262a50>, '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 0x21ce550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ce9e0>, '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': '0274524eba3bdaad075c2247000001d4-1453390492.223816-1062301691', '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 07:46:47 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 07:46:47 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 07:46:47 INFO - Using env: {'DISPLAY': ':0', 07:46:47 INFO - 'HOME': '/home/cltbld', 07:46:47 INFO - 'LANG': 'en_US.UTF-8', 07:46:47 INFO - 'LANGUAGE': 'en_US:en', 07:46:47 INFO - 'LOGNAME': 'cltbld', 07:46:47 INFO - 'MAIL': '/var/mail/cltbld', 07:46:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:47 INFO - 'MOZ_NO_REMOTE': '1', 07:46:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:47 INFO - 'NO_EM_RESTART': '1', 07:46:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:46:47 INFO - 'PWD': '/builds/slave/test-pgo', 07:46:47 INFO - 'SHELL': '/bin/bash', 07:46:47 INFO - 'SHLVL': '1', 07:46:47 INFO - 'TERM': 'linux', 07:46:47 INFO - 'TMOUT': '86400', 07:46:47 INFO - 'USER': 'cltbld', 07:46:47 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1453390492.223816-1062301691', 07:46:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:47 INFO - '_': '/tools/buildbot/bin/python'} 07:46:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:46:47 INFO - Running setup.py (path:/tmp/pip-C5Rqpa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:46:47 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)) 07:46:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:46:47 INFO - Running setup.py (path:/tmp/pip-qwmf2A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:46:47 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)) 07:46:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:46:47 INFO - Running setup.py (path:/tmp/pip-Hh8Q0P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:46:47 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)) 07:46:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:46:47 INFO - Running setup.py (path:/tmp/pip-Tuclj8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:46:47 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)) 07:46:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:46:47 INFO - Running setup.py (path:/tmp/pip-V1R48I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:46:47 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)) 07:46:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:46:47 INFO - Running setup.py (path:/tmp/pip-Ryt8Se-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:46:48 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)) 07:46:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:46:48 INFO - Running setup.py (path:/tmp/pip-RHCWHq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:46:48 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)) 07:46:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:46:48 INFO - Running setup.py (path:/tmp/pip-m2gPv2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:46:48 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)) 07:46:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:46:48 INFO - Running setup.py (path:/tmp/pip-GFhVk3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:46:48 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)) 07:46:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:46:48 INFO - Running setup.py (path:/tmp/pip-D3miv2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:46:48 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)) 07:46:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:46:48 INFO - Running setup.py (path:/tmp/pip-D5atqM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:46:48 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)) 07:46:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:46:48 INFO - Running setup.py (path:/tmp/pip-HkdTpH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:46:48 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)) 07:46:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:46:48 INFO - Running setup.py (path:/tmp/pip-gwGXzY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:46:48 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)) 07:46:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:46:48 INFO - Running setup.py (path:/tmp/pip-YLhLSe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:46:48 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)) 07:46:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:46:48 INFO - Running setup.py (path:/tmp/pip-MhhCIn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:46:48 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)) 07:46:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:46:48 INFO - Running setup.py (path:/tmp/pip-Jjpfbs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:46:48 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)) 07:46:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:46:48 INFO - Running setup.py (path:/tmp/pip-XZLFAn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:46:48 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)) 07:46:48 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)) 07:46:48 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)) 07:46:48 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)) 07:46:48 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)) 07:46:48 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)) 07:46:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:50 INFO - Downloading blessings-1.6.tar.gz 07:46:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:46:50 INFO - Installing collected packages: blessings 07:46:50 INFO - Running setup.py install for blessings 07:46:50 INFO - Successfully installed blessings 07:46:50 INFO - Cleaning up... 07:46:50 INFO - Return code: 0 07:46:50 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:46:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:46:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:46:51 INFO - Reading from file tmpfile_stdout 07:46:51 INFO - Current package versions: 07:46:51 INFO - argparse == 1.2.1 07:46:51 INFO - blessings == 1.6 07:46:51 INFO - blobuploader == 1.2.4 07:46:51 INFO - docopt == 0.6.1 07:46:51 INFO - manifestparser == 1.1 07:46:51 INFO - mozInstall == 1.12 07:46:51 INFO - mozcrash == 0.16 07:46:51 INFO - mozdebug == 0.1 07:46:51 INFO - mozdevice == 0.47 07:46:51 INFO - mozfile == 1.2 07:46:51 INFO - mozhttpd == 0.7 07:46:51 INFO - mozinfo == 0.9 07:46:51 INFO - mozleak == 0.1 07:46:51 INFO - mozlog == 3.1 07:46:51 INFO - moznetwork == 0.27 07:46:51 INFO - mozprocess == 0.22 07:46:51 INFO - mozprofile == 0.27 07:46:51 INFO - mozrunner == 6.11 07:46:51 INFO - mozscreenshot == 0.1 07:46:51 INFO - mozsystemmonitor == 0.0 07:46:51 INFO - moztest == 0.7 07:46:51 INFO - mozversion == 1.4 07:46:51 INFO - psutil == 3.1.1 07:46:51 INFO - requests == 1.2.3 07:46:51 INFO - wsgiref == 0.1.2 07:46:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:51 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 0x7fda21800f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d0450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2262a50>, '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 0x21ce550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ce9e0>, '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': '0274524eba3bdaad075c2247000001d4-1453390492.223816-1062301691', '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 07:46:51 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 07:46:51 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 07:46:51 INFO - Using env: {'DISPLAY': ':0', 07:46:51 INFO - 'HOME': '/home/cltbld', 07:46:51 INFO - 'LANG': 'en_US.UTF-8', 07:46:51 INFO - 'LANGUAGE': 'en_US:en', 07:46:51 INFO - 'LOGNAME': 'cltbld', 07:46:51 INFO - 'MAIL': '/var/mail/cltbld', 07:46:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:51 INFO - 'MOZ_NO_REMOTE': '1', 07:46:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:51 INFO - 'NO_EM_RESTART': '1', 07:46:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:46:51 INFO - 'PWD': '/builds/slave/test-pgo', 07:46:51 INFO - 'SHELL': '/bin/bash', 07:46:51 INFO - 'SHLVL': '1', 07:46:51 INFO - 'TERM': 'linux', 07:46:51 INFO - 'TMOUT': '86400', 07:46:51 INFO - 'USER': 'cltbld', 07:46:51 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1453390492.223816-1062301691', 07:46:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:51 INFO - '_': '/tools/buildbot/bin/python'} 07:46:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:51 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)) 07:46:51 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)) 07:46:51 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)) 07:46:51 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)) 07:46:51 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)) 07:46:51 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)) 07:46:51 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)) 07:46:51 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)) 07:46:51 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)) 07:46:51 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)) 07:46:51 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)) 07:46:51 INFO - Cleaning up... 07:46:51 INFO - Return code: 0 07:46:51 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:51 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 0x7fda21800f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d0450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2262a50>, '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 0x21ce550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ce9e0>, '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': '0274524eba3bdaad075c2247000001d4-1453390492.223816-1062301691', '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 07:46:51 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 07:46:51 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 07:46:51 INFO - Using env: {'DISPLAY': ':0', 07:46:51 INFO - 'HOME': '/home/cltbld', 07:46:51 INFO - 'LANG': 'en_US.UTF-8', 07:46:51 INFO - 'LANGUAGE': 'en_US:en', 07:46:51 INFO - 'LOGNAME': 'cltbld', 07:46:51 INFO - 'MAIL': '/var/mail/cltbld', 07:46:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:51 INFO - 'MOZ_NO_REMOTE': '1', 07:46:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:51 INFO - 'NO_EM_RESTART': '1', 07:46:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:46:51 INFO - 'PWD': '/builds/slave/test-pgo', 07:46:51 INFO - 'SHELL': '/bin/bash', 07:46:51 INFO - 'SHLVL': '1', 07:46:51 INFO - 'TERM': 'linux', 07:46:51 INFO - 'TMOUT': '86400', 07:46:51 INFO - 'USER': 'cltbld', 07:46:51 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1453390492.223816-1062301691', 07:46:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:51 INFO - '_': '/tools/buildbot/bin/python'} 07:46:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:51 INFO - Downloading/unpacking jsonschema 07:46:51 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 07:46:51 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 07:46:51 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 07:46:51 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 07:46:51 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 07:46:51 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 07:46:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:46:53 INFO - Downloading/unpacking functools32 (from jsonschema) 07:46: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 07:46: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 07:46: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 07:46: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 07:46: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 07:46: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 07:46:53 INFO - Downloading functools32-3.2.3-2.tar.gz 07:46:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:46:53 INFO - warning: no files found matching '*.txt' 07:46:53 INFO - no previously-included directories found matching 'build' 07:46:53 INFO - no previously-included directories found matching 'dist' 07:46:53 INFO - no previously-included directories found matching '.git*' 07:46:53 INFO - Installing collected packages: jsonschema, functools32 07:46:53 INFO - Running setup.py install for functools32 07:46:53 INFO - warning: no files found matching '*.txt' 07:46:53 INFO - no previously-included directories found matching 'build' 07:46:53 INFO - no previously-included directories found matching 'dist' 07:46:53 INFO - no previously-included directories found matching '.git*' 07:46:53 INFO - Successfully installed jsonschema functools32 07:46:53 INFO - Cleaning up... 07:46:53 INFO - Return code: 0 07:46:53 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:46: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')]} 07:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46: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')]} 07:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda21800f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d0450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2262a50>, '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 0x21ce550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ce9e0>, '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': '0274524eba3bdaad075c2247000001d4-1453390492.223816-1062301691', '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 07:46: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', 'flake8'] in /builds/slave/test-pgo/build 07:46: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 flake8 07:46:53 INFO - Using env: {'DISPLAY': ':0', 07:46:53 INFO - 'HOME': '/home/cltbld', 07:46:53 INFO - 'LANG': 'en_US.UTF-8', 07:46:53 INFO - 'LANGUAGE': 'en_US:en', 07:46:53 INFO - 'LOGNAME': 'cltbld', 07:46:53 INFO - 'MAIL': '/var/mail/cltbld', 07:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:53 INFO - 'MOZ_NO_REMOTE': '1', 07:46:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:53 INFO - 'NO_EM_RESTART': '1', 07:46:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:46:53 INFO - 'PWD': '/builds/slave/test-pgo', 07:46:53 INFO - 'SHELL': '/bin/bash', 07:46:53 INFO - 'SHLVL': '1', 07:46:53 INFO - 'TERM': 'linux', 07:46:53 INFO - 'TMOUT': '86400', 07:46:53 INFO - 'USER': 'cltbld', 07:46:53 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1453390492.223816-1062301691', 07:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:53 INFO - '_': '/tools/buildbot/bin/python'} 07:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:53 INFO - Downloading/unpacking flake8 07:46: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 07:46: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 07:46: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 07:46: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 07:46: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 07:46: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 07:46:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:46:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:46:55 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 07:46:55 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 07:46:55 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 07:46:55 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 07:46:55 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 07:46:55 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 07:46:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:46:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:46:55 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 07:46:55 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 07:46:55 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 07:46:55 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 07:46:55 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 07:46:55 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 07:46:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:46: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 07:46: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 07:46: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 07:46: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 07:46: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 07:46: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 07:46:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:46:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:46:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:46:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:46:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:46:56 INFO - no previously-included directories found matching 'docs/_build' 07:46:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:46:56 INFO - Running setup.py install for pep8 07:46:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:46:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:46:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:46:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:46:56 INFO - no previously-included directories found matching 'docs/_build' 07:46:56 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:46:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:46:56 INFO - Cleaning up... 07:46:56 INFO - Return code: 0 07:46:56 INFO - Running post-action listener: _resource_record_post_action 07:46:56 INFO - Running post-action listener: _start_resource_monitoring 07:46:56 INFO - Starting resource monitoring. 07:46:56 INFO - ##### 07:46:56 INFO - ##### Running install step. 07:46:56 INFO - ##### 07:46:56 INFO - Running pre-action listener: _resource_record_pre_action 07:46:56 INFO - Running main action method: install 07:46:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:46:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:46:56 INFO - Reading from file tmpfile_stdout 07:46:56 INFO - Detecting whether we're running mozinstall >=1.0... 07:46:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:46:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:46:56 INFO - Reading from file tmpfile_stdout 07:46:56 INFO - Output received: 07:46:56 INFO - Usage: mozinstall [options] installer 07:46:56 INFO - Options: 07:46:56 INFO - -h, --help show this help message and exit 07:46:56 INFO - -d DEST, --destination=DEST 07:46:56 INFO - Directory to install application into. [default: 07:46:56 INFO - "/builds/slave/test-pgo"] 07:46:56 INFO - --app=APP Application being installed. [default: firefox] 07:46:56 INFO - mkdir: /builds/slave/test-pgo/build/application 07:46:56 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'] 07:46:56 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 07:47:11 INFO - Reading from file tmpfile_stdout 07:47:11 INFO - Output received: 07:47:11 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:47:11 INFO - Running post-action listener: _resource_record_post_action 07:47:11 INFO - ##### 07:47:11 INFO - ##### Running run-tests step. 07:47:11 INFO - ##### 07:47:11 INFO - Running pre-action listener: _resource_record_pre_action 07:47:11 INFO - Running main action method: run_tests 07:47:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:47:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:47:11 INFO - Python 2.7.3 07:47:11 INFO - Return code: 0 07:47:11 INFO - grabbing minidump binary from tooltool 07:47: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')]} 07:47:11 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 0x2262a50>, '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 0x21ce550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ce9e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:47:11 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 07:47:11 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 07:47:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:47:11 INFO - Return code: 0 07:47:11 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:47:11 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:47:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:47:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:47:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:47:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:47:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:47:12 INFO - Return code: 0 07:47:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 07:47:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost 07:47:12 INFO - Using env: {'DISPLAY': ':0', 07:47:12 INFO - 'HOME': '/home/cltbld', 07:47:12 INFO - 'LANG': 'en_US.UTF-8', 07:47:12 INFO - 'LANGUAGE': 'en_US:en', 07:47:12 INFO - 'LOGNAME': 'cltbld', 07:47:12 INFO - 'MAIL': '/var/mail/cltbld', 07:47:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:47:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:12 INFO - 'MOZ_NO_REMOTE': '1', 07:47:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:47:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:12 INFO - 'NO_EM_RESTART': '1', 07:47:12 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:47:12 INFO - 'PWD': '/builds/slave/test-pgo', 07:47:12 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:47:12 INFO - 'SHELL': '/bin/bash', 07:47:12 INFO - 'SHLVL': '1', 07:47:12 INFO - 'TERM': 'linux', 07:47:12 INFO - 'TMOUT': '86400', 07:47:12 INFO - 'USER': 'cltbld', 07:47:12 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1453390492.223816-1062301691', 07:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:12 INFO - '_': '/tools/buildbot/bin/python'} 07:47:12 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost'] with output_timeout 3600 07:47:12 INFO - mozversion INFO | application_buildid: 20160121051922 07:47:12 INFO - mozversion INFO | application_changeset: 57a4738271792310f2b061fee8447060b13e961d 07:47:12 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 07:47:12 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:47:12 INFO - mozversion INFO | application_name: Firefox 07:47:12 INFO - mozversion INFO | application_remotingname: firefox-dev 07:47:12 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:47:12 INFO - mozversion INFO | application_vendor: Mozilla 07:47:12 INFO - mozversion INFO | application_version: 45.0a2 07:47:12 INFO - mozversion INFO | platform_buildid: 20160121051922 07:47:12 INFO - mozversion INFO | platform_changeset: 57a4738271792310f2b061fee8447060b13e961d 07:47:12 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:47:12 INFO - mozversion INFO | platform_version: 45.0a2 07:47:12 INFO - 2016-01-21 07:47:12,801 DEBUG : using testdate: 1453391232 07:47:12 INFO - 2016-01-21 07:47:12,801 DEBUG : actual date: 1453391232 07:47:12 INFO - 2016-01-21 07:47:12,810 INFO : starting webserver on 'localhost:43119' 07:47:12 INFO - 2016-01-21 07:47:12,812 INFO : Starting test suite talos-linux64-ix-029.e 07:47:12 INFO - 2016-01-21 07:47:12,812 INFO : Starting test dromaeo_css 07:47:12 INFO - 2016-01-21 07:47:12,812 DEBUG : operating with platform_type : linux_ 07:47:12 INFO - 2016-01-21 07:47:12,813 INFO : Initialising browser for dromaeo_css test... 07:47:12 INFO - 2016-01-21 07:47:12,829 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6KPMtB/profile http://localhost:43119/getInfo.html 07:47:16 INFO - 2016-01-21 07:47:16,433 DEBUG : BROWSER_OUTPUT: 07:47:16 INFO - 2016-01-21 07:47:16,434 DEBUG : BROWSER_OUTPUT: (process:17406): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:47:17 INFO - 2016-01-21 07:47:17,143 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:47:17 INFO - 2016-01-21 07:47:17,143 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:47:17 INFO - 2016-01-21 07:47:17,143 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:47:17 INFO - 2016-01-21 07:47:17,143 DEBUG : BROWSER_OUTPUT: __metrics 07:47:18 INFO - 2016-01-21 07:47:18,081 INFO : Browser initialized. 07:47:18 INFO - 2016-01-21 07:47:18,081 INFO : Running cycle 1/1 for dromaeo_css test... 07:47:18 INFO - 2016-01-21 07:47:18,082 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6KPMtB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:47:19 INFO - 2016-01-21 07:47:19,421 DEBUG : BROWSER_OUTPUT: 07:47:19 INFO - 2016-01-21 07:47:19,421 DEBUG : BROWSER_OUTPUT: (process:17516): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:47:29 INFO - 2016-01-21 07:47:29,928 DEBUG : BROWSER_OUTPUT: RSS: Main: 136077312 07:47:29 INFO - 2016-01-21 07:47:29,928 DEBUG : BROWSER_OUTPUT: 07:48:19 INFO - 2016-01-21 07:48:19,532 DEBUG : BROWSER_OUTPUT: 1453391299531 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] 07:50:27 INFO - 2016-01-21 07:50:27,861 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43119/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43119/tests/dromaeo/cssquery-ext.html) 07:50:28 INFO - 2016-01-21 07:50:28,911 DEBUG : BROWSER_OUTPUT: RSS: Main: 141758464 07:50:28 INFO - 2016-01-21 07:50:28,911 DEBUG : BROWSER_OUTPUT: 07:53:30 INFO - 2016-01-21 07:53:30,781 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43119/tests/dromaeo/cssquery-ext.html (next: http://localhost:43119/tests/dromaeo/cssquery-jquery.html) 07:53:31 INFO - 2016-01-21 07:53:31,375 DEBUG : BROWSER_OUTPUT: RSS: Main: 139075584 07:53:31 INFO - 2016-01-21 07:53:31,375 DEBUG : BROWSER_OUTPUT: 07:56:32 INFO - 2016-01-21 07:56:32,943 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43119/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43119/tests/dromaeo/cssquery-mootools.html) 07:56:33 INFO - 2016-01-21 07:56:33,530 DEBUG : BROWSER_OUTPUT: RSS: Main: 139436032 07:56:33 INFO - 2016-01-21 07:56:33,530 DEBUG : BROWSER_OUTPUT: 07:59:35 INFO - 2016-01-21 07:59:35,118 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43119/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43119/tests/dromaeo/cssquery-prototype.html) 07:59:35 INFO - 2016-01-21 07:59:35,706 DEBUG : BROWSER_OUTPUT: RSS: Main: 138551296 07:59:35 INFO - 2016-01-21 07:59:35,707 DEBUG : BROWSER_OUTPUT: 08:02:37 INFO - 2016-01-21 08:02:37,945 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43119/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43119/tests/dromaeo/cssquery-yui.html) 08:02:38 INFO - 2016-01-21 08:02:38,534 DEBUG : BROWSER_OUTPUT: RSS: Main: 139628544 08:02:38 INFO - 2016-01-21 08:02:38,534 DEBUG : BROWSER_OUTPUT: 08:05:40 INFO - 2016-01-21 08:05:40,495 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43119/tests/dromaeo/cssquery-yui.html (next: http://localhost:43119/tests/dromaeo/cssquery-dojo.html) 08:05:40 INFO - 2016-01-21 08:05:40,746 DEBUG : BROWSER_OUTPUT: RSS: Main: 141533184 08:05:40 INFO - 2016-01-21 08:05:40,746 DEBUG : BROWSER_OUTPUT: 08:05:40 INFO - 2016-01-21 08:05:40,747 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:05:40 INFO - 2016-01-21 08:05:40,747 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:05:40 INFO - 2016-01-21 08:05:40,747 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:05:40 INFO - 2016-01-21 08:05:40,748 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:05:40 INFO - 2016-01-21 08:05:40,751 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3243.5296881952113;3286.671332866712;3290.9012729618103;3317.7014068733815;3327;5551.500364967153;5554.888902221953;5557.86105347366;5580.581456390767;5629.577781666376;5575.972120139394;5599.692016939067;5607.355154157273;5621.381648018725;5649.717514124298;5104.310918026074;5110.821121260757;5177.119889618755;5188.6367954243215;5202.683520851064;5023.7236951967625;5124.92312615311;5134.563562097208;5198.740062996835;5296.285001524783;5100.897982040357;5187.455317191697;5192.55863251624;5192.974035129819;5196.220566914955;5212.582993360522;5262.4474430184855;5275.657082289677;5279.366476022902;5316.494932981361;4952.62855285855;5008.449070602231;5052;5177.534021938006;5179.482051794828;5408.215808707755;5445.401005889349;5477.589180811416;5488.807891723771;5489.1217405214975;6003.699815009232;6052.21321228242;6054.576179667425;6067.787627433018;6074.48366888815;5961.463468287875;6088.299845517734;6102.908456373158;6107.877842443127;6152.969235153841;5587.916181257285;5596.944030559724;5680.0627896397455;5687.431256874363;5712.942870571283;6131.540134489842;6186.907196392058;6201.56589038772;6212.782552610637;6228.252609686776;5750.079987202028;5843.094320380348;5978.521718262528;5987.670678112746;5994.910076348859;6074.51403887688;6123.9387606124255;6152.230971128609;6164.198654174928;6165.04441811511;6064.9090263646085;6085.087236914498;6099.5840286945295;6112.74665817949;6127.9837278401355;5936.614120082181;6001.36985616504;6053.545984051214;6115.816525504242;6131.448169664752;4663.183942809995;4663.743494107789;4664.673472856935;4674.22875225584;4697.741624210701;4159.9792001040405;4163.084121493267;4163.854265100767;4164.708470407103;4205.705600607928;5670.659760414388;5683.857903552362;5738;5815.767369305265;5841.240638716939;6017.789377371771;6052.364501727343;6097.817065488042;6113.419225173601;6142.9078563820685;5798.971005144947;5801.158831969341;5807.68057756819;5809.041508151107;5815.680137592389;5213.218017297359;5247.2129180623215;5298.8940221196135;5324.680519168863;5335.706536140549;6207.689615519206;6247.656378899204;6265.154204182377;6267.5299352548745;6272.121902933502;5887.61730487517;6154.569180157346;6156.015037593964;6168.321484636686;6181.81454556364;6110.236220472441;6147.600405973598;6193.597416167935;6204.286507051746;6205.937940620536;6029.668368239789;6042.607230530001;6043.486303664238;6043.758249669964;6109.419605137505;5910.320313163869;6016.007358785751;6152.138700582012;6155.261368635793;6159.876802464015;5985.132155837467;6076.027835546468;6119;6129.724162412613;6136.2943261523715;5905.881882362414;5930;5944.73248703818;5951.821445356646;5965.970170149121;5708.457696518824;5753.1945527627;5881.823545293648;5888.116782482662;5928;5952.255968003999;5992.8501787453915;6002.159697642246;6016.037434010537;6056.424639659225;5843.1235314703135;5845.561582881216;5847.707614619167;5855.677937713466;5907.143464197581 08:05:40 INFO - 2016-01-21 08:05:40,751 DEBUG : BROWSER_OUTPUT: |1;ext.html;575.4331982996747;611.0986295214557;611.6269075863722;620.2773768559626;674.6356967237689;31518.52722209166;32642.67357326426;40409.797951010274;41058.178836423256;41151.79424102875;44088.338674919905;44253.55746442534;44365.7781711091;44618;44682.77658611711;9011.234045106174;9113.0886911309;9124.954375228148;9174.036726143759;9174.724758257264;8939.418937769024;9014.414063085911;9025.59384827681;9059.592318345658;9069.365144439858;8897.73306800797;8951.820963580725;9002.684906028291;9039.954800225989;9054.456732596032;8929.374943753939;8996.595153218088;9059.139381758723;9065.818683626356;9086.22767064797;8903.465792052497;9050.456972581665;9083.18251357381;9089.81820363589;9132;41161.1767764643;41260.1747965039;41444.79277603623;41579.1684166318;41630.375544366856;3811.9809400953095;3929.8035098244973;4073.144639625682;4211.115665710205;4393.07745373472;31329.530057049164;31335;31355.84322078398;31577.684223157703;32449.351012979845;4374.496932852699;4391.978040109779;4400.44994375703;4443.866683999453;4479.73121612701;270497;271318;271369;271718;384628;50311.49688503141;60468.39531604716;61312.69343653253;61338.69330653318;61397.69301153555;60944;61006;61240.387596123466;61355.386446134966;61452;14427.278636068155;14498.85501144975;14543;14555.563333100024;14586;11503.19477636574;11687.065034797195;11706.12204084697;11711.004564611932;11744.59064912216;19731.309404170785;19778.505537361394;19968.70046949297;20090.69863952042;20133.899330503547;7865.567393793396;7937.523748575104;8013.358931285483;8087.959560202161;8137.75586732399;1020.4183615339185;1083.544911137324;1139.3448766958866;1139.9968028135188;1149.1725957310723;29039.12882613525;29338.413231735245;29379.412411751644;29805.552916706267;30251.394972100436;1070.0743856564172;1125.4766533561933;1139.1342579639368;1152.3028567716578;1213.3993673131679;13465.259410732504;14104;14255;14276.785848212285;14391.496297629743;337152;343022;343364;343683;354108;48438.75780621074;48693.75653121783;49026.26460603094;49046.75476622594;49335.50664493381;1418.2483283859572;1425.2090089999942;1428.3358238419185;1432.5702289313165;1443.9639009024859;28305.15084547467;28334.291642709097;28575.857120715096;28629.856850716445;29235.7076429233;45245;45330.09339813119;45532.089358213314;45550.31674524819;45766.542334576225;272849;273748.63125684246;275243;275451;276423;32434.35131297408;32701.18247043843;32751.836240818644;33342;33692.157696057795;40230.597694023854;40561.391579126925;40872.79563602163;40880.79559602183;41448.171036579704;36524.63475365318;36889.815550922074;37513.062173445884;37603.81198093992;37842;36207.63792362042;37461.250774983804;38445;38613.15531432289;41427.37858932179;37829.24341513209;38072.42891356687;38160.618393815705;38247.42628860514;38329.23341533098;32853.342933140724;32995.175120622174;33202;33348.1662958428;33679.15802104967;24548.386290342885;25692.871535642204;25962.480750385264;26032.47935041251;26139.738602613732 08:05:40 INFO - 2016-01-21 08:05:40,755 DEBUG : BROWSER_OUTPUT: |2;jquery.html;388.5861557441325;388.62109443292775;390.4884601172464;392.5015230657066;396.37175077502155;15937.203139843019;17205;17256.654866902685;18903.621927561457;18943.43169704911;11714.121440891924;12486.687832804162;12919.677008074803;17884.463466096004;17914.37299694511;4983.551480366767;5227.73861306935;5356.4107948125675;5365.678059316453;6187.81436556904;5338.439463856297;5443.863903402407;5476.288082549263;5482.671039737608;6120.081987701836;5422.024035673597;5426.2674538937135;5454.481824226692;5502.779888804443;5745.712714364265;5633.436656334375;5646.971765141148;5669.036263835158;5687.317521897378;5690.174924635905;5036.949630503685;5136.306598609177;5325.4142044375085;5458.727063646802;5468.781248750045;13615.727685446236;13729.176249425067;13841.238731869744;14010.36953337092;14069;2272.1593010586025;2300.332903457995;2306.1813056365086;2344.3787396339985;2485.8384205026796;10682.412467314294;10694.144468442506;12392.008639308833;12748.936255318664;13590.77683008534;1981.455099847539;2008.1967213114872;2022.9190832366687;2024.98987505063;2055.732754741889;61651;63044.36955630431;63523.047154293185;63975.68012159956;64562.67718661424;10890.61882834097;11112.111031117653;11149.665510034712;11207.439628018567;11282.210245282751;14538.200398978157;14571;14578.489752858599;14647.487337943334;14671.486497972519;7899.526028438312;8003.599820008976;8009.879851802228;8026.558539280279;8084.3936704747375;7502.699892004368;7531.849363012709;7593.354564861938;7599.506032107895;7609.885851712229;4653.95346046542;4730.739809310521;4740.620750339965;4759.785809638505;4824.469308376076;1942.893140877237;1994.7706013808597;2068.917243310251;2074.346580827035;2078.7193728846714;435.27092120698336;469.93420921070395;498.50896866586385;926.9536523173814;1119.781642579689;11298.322100673822;11661;11780.88219117815;11809.350485723196;11990.400479975966;487.22044728434224;506.8428787076018;515.885686916259;519.0734538848138;523.3510447045636;6289.937100628935;6400.679966001681;6499.642519661369;6521.380468855451;6554.787364337612;629087;649346;663108;671321;674796;44550.88622784457;83836.06573769888;84647;84941;86377.13622863816;524.3838489774499;530.5755395683515;533.2214966149465;534.3801190618941;536.0538649284017;10787.460626968777;10826.729331766768;10929.672109836718;11024.5038973248;11163.944180279372;34753.82623086868;35313.823430883705;36112;36362.8181859089;36547.45178822373;50634.240486391995;50842;51410.48589514057;51708.22437663513;52950.762309422644;9756.85364719544;9825.85261221068;10247.487625618838;10314.690559283234;10341;16194.352225910832;17074.743878842077;17411.303547857944;17458.039807810183;17997.64004719872;14621.268936553342;14633.707325853637;15126.621834453787;15147.54557363281;15209.467668631545;14583.708325833211;14784.556463306119;15097.32062057232;15133.924330378719;15174.393024278905;15631;15927;15992.200389980222;16134.838651613334;16294;10467.738306542398;10555.208359373231;10607.893921060691;10635.415052172204;10660;14795.630109246924;14968.625784355043;15523.146226957626;15745.13401762914;15833.208339583205 08:05:40 INFO - 2016-01-21 08:05:40,755 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1559.3216950626477;1611.1299898055051;1647;1832.7067669172927;1913.1199648161844;7926.326262267707;8036.316913062396;8139.593020348989;8145.34837213023;8193.139720329362;7982.28159465648;7983.08194557626;8035.276825085741;8093.797655058626;8107.3919456040885;2374.8693821839747;2387.379281386843;2411;2413.4449076712367;2414.8309618326725;2394.1022116706235;2406.5547873643345;2423.321469988406;2443.0472115874823;2455.2020593307248;2330.8601483910934;2344.7069116360453;2369.34842918198;2379.167291447997;2392.9282121536294;2282.224043825091;2341.5785158671433;2369.668246445499;2378.785909268157;2388.581998150334;2360.091364824538;2379.3456799380137;2384.78536931677;2389.1279682915783;2389.1518510928545;7948.801279967989;8047.919520804834;8054.597270136528;8077.313428358597;8078.111407745143;4889.828855990023;4976.477469865648;4992.975035124801;5004.799808007675;5009.5491405773655;3116;3133.514305282662;3135.5923729915194;3150.763692723055;3166.6200055993427;1074.355386767941;1087.5595383869545;1123.1239633086207;1139.800534906388;1145.770845830837;10960.397178155199;10962.890371096346;11061.170412219115;11116;11140.999999999918;4331.45856767904;4376.102898905717;4395.296752519582;4407.823687052482;4425.446819147606;8974.14745599167;9026.323025773094;9045.638174473079;9061.728148155566;9067.183953444222;4881.048195601824;4883.438404583448;4894.8042078317185;4897.681650692693;4917.188663870421;4510.75190864499;4525.683202175882;4535.7732113394195;4545.749983750926;4572.542745725467;3555.5377800886235;3595.2270261893295;3615.9819200903826;3637.2907283079544;3637.690796282293;1099.1042300525046;1100.6147848253208;1105.3754628634795;1117.6423544465692;1175.6002958993984;1068.0494360019588;1091.1052936591918;1098.6319582939645;1237.7710123627157;1339.6583871112998;7548.056492938383;7566;7605.049368828896;7646.044244469442;7663.271989161132;1053.4627340056472;1056.6354607660344;1089.4988305379613;1126.3748619516084;1162.4710756605723;5797.420257974169;5803.071508558611;5819.53443724501;5843.918875008138;5854.034084376115;9547.093026162504;9653.855192172123;9856.605735770489;9904.900950990543;9999.650012249536;9721.368111072758;9772.21822254218;9782.657606983721;9785.412875227508;9883.209343252522;7559.28186822251;7652.426068044919;7685.500442471333;7699.769006929801;7709.036370453693;7256.310650488195;7295.854082918206;7329.74345897891;7339.9633001834645;7353.301436363537;8020.558869262247;8113.959430202811;8298.58507074656;8358.62386192635;8432.45189062709;8152.307053900485;8173.305269052197;8180.46826956246;8215.219554142346;8232.958835205785;7037;7074.540154889915;7085.14978202619;7087.964560177166;7103.467239957127;7480.326770590673;7508.474406791473;7519.812004699707;7527.096748390009;7527.3601743850195;7008.404285635778;7093.255208203064;7177.102862142232;7217.855642887008;7326.853462930818;6980.720771169096;7221.4222862171955;7282.6722797473185;7283.672234749343;7301.963490182515;7225.494215404871;7292.781216563511;7303.160136584361;7305.050343455317;7335.303146201102;6409.519286053658;6424.2933277338525;6437.452816510649;6455.354464553507;6459.483241340776;6643.667816609053;6751.122354094133;6783.694733736895;6784.3894049535775;6791.864162716817 08:05:40 INFO - 2016-01-21 08:05:40,755 DEBUG : BROWSER_OUTPUT: |4;prototype.html;357.43168362303936;368.08163631738813;369.254106704457;371.10008230042143;372.80614080678066;6358.332375100617;6367;6403.903941440876;6487.545871788977;6492.480601551876;6237;6362.618242905429;6380.4895608351335;6411.390917862807;6423;4937.407511098673;4960.25596160577;4961.652684312099;4962.578180854632;4975.626827987898;4942.209246520558;4956.40523137224;4962.660081777918;4967.279744437054;4968.801247950078;4672.948586568029;4897.338859254009;4904.656674032802;4915.9754201229125;4916.43461001984;4877.975625118729;4882.584980276681;4895.898422854865;4896.926546101811;4898.510148985109;4283.014906571475;4283.057727299989;4284.207421627009;4288.485381754178;4305.913881722379;5907.970460147715;6032.849178770522;6055;6060.636361818261;6079.118527813486;5667.688277144755;5679.318481782213;5680.488756011979;5694.914576281359;5695.77216911323;6747.831304217385;6750.662466876685;6762.594244345355;6763.120794296759;6776.525643204977;4702.929456058162;4707.176244157293;4724.889650932063;4739.9526004739855;4755.595774359183;6919.6886140123315;6985.091938048072;7050.29497050296;7064.964675176642;7066.681999309992;4831.758412079382;4849.4908034656555;4850.296706977539;4864.489228631013;4872.342233798463;4879.780409881564;4888.340074089952;4908.631852611068;4908.828191013297;4914.36113305268;5453.890922181534;5651.2935883014625;5657.830265092054;5667.404922483162;5687.857803554862;6771.695273712695;6790.083338749305;6825.215100263434;6873.965630171817;6882.174139103339;1689.4255952976048;1739.6433731085096;1743.8692098092695;1745.3280487012337;1750.063715911981;1148.2593727046008;1165.7143999720122;1180.0500597019482;1180.4333919718583;1191.184038933316;6533.934660653333;6537.509686773511;6546.639934803537;6551.344865513506;6612.768553100618;6969.30306969299;6981.441484681213;7002.544834585736;7009.509334346547;7012.474064445187;6465.77369792055;6536.411722944958;6561.967190164114;6565.179352580927;6573.605583664996;3761.7366784324836;3806.3719486284454;3813.3517302058717;3813.523309586302;3814.7901865397116;7156.499045066899;7178.676959536833;7238.92761072393;7240.493165478471;7250.383717383976;7071.964640176869;7193.820154496075;7193.9280607194305;7195.532290401107;7319.597422141726;7317.573073250772;7339.926600733925;7354.448416368687;7358.374538164209;7358.521696089737;7109.573425594481;7115.181754098345;7122.145342558926;7127.180374256819;7134.714611415485;6893.20728116273;6951.165860096618;6992.1259842519685;7022.859542809218;7026.402755765817;7324.926750732425;7329.963350183215;7331.193568707545;7336.853262934818;7344.449166312441;4789.4971028041555;4873.537013983666;4885.047415753894;4890.193118135468;4892.4373697023875;6914.51598388108;7005.22942476317;7069.293070693096;7086.645667716697;7096.432285417051;6882.03651488782;6897.103376561015;6902.033715279765;6906.654667266516;6944.4097251734165;6876.415504682158;6900.689468974008;6904.896426553505;6910.378065974087;6910.896336555056;6683.598984060972;6768.424683901923;6786.966065169642;6794.694238759169;6812.829679258059;6932.965335173292;6949.930500694928;6953.374196322356;6953.721851125898;6965.651717414008;6565.113709649137;6687.966560167168;6732.980105968288;6734.4275736560985;6777.45780337562 08:05:40 INFO - 2016-01-21 08:05:40,756 DEBUG : BROWSER_OUTPUT: |5;yui.html;838.6477679374663;912.968046118386;917.80146190526;922.5341202692636;924.2975338742554;14228;14522.709545809077;14523.636909077279;14601.780973285382;15179.241037948086;13709.725805483884;13819.51631692891;13822.170669759822;13832.585022449342;13918.791218131737;873.4933738431711;906.1527471813876;907.6188001039546;909.2226146644623;910.7085732565581;891.7191084808297;901.625825282507;904.1184844776324;906.084854297158;906.4063038709655;955.5461155950902;958.8178246133248;959.6113574002541;962.8363178259677;964.5755867418349;936.3539157981039;938.6104766521885;944.9527523623791;947.4268067818973;948.2840455456155;692.2731132311053;693.9063226464414;695.5756988237172;703.7888633409957;714.8963400306926;14603.561893143222;14750.852491475056;14816.481423150139;14828.406863725439;14833.110013399122;12555.183913045623;12701.110922235448;12861.80707289382;12885.806712899313;13466.528671496451;11192.328460292327;11278.323300601991;11573.594924177698;11981.64055078349;12326;3631;3654.7624404413627;3880.3209438348176;3905.7461265017682;3909.8240579174008;48641;48871.75564122156;48913.51086489125;49069.01861962741;49278.7536062321;10526.105281051043;10664.093552048163;10729.78540429187;10827.404492752974;10837;18246.270149194148;18253;18332.816671833112;18361.81638183601;18384;7808.7657370278985;7829.686812527549;7882.645280962256;8259.256666900008;8395.412321137463;4374.518802931675;4377.255866502638;4400.273954797422;4419.756913369795;4551.544845515422;3270.296886169485;3277.3772983133126;3317.004898530431;3317.867285308609;3322.8670853166086;581.3517927510795;587.9500242479352;590.9438603332677;592.1384385718769;600.8888355654218;622.4460230394952;689.1144878830779;689.3726708695064;714.953528020677;717.1895757793764;8671.56642167889;8739.126087391338;8806.647734090693;8844.204021638083;8928;652.4323838260743;654.2051407539861;662.8409181796334;685.8971154326891;707.1514182980444;3854.5567259765485;4222.218889505451;4224.155168966219;4328.8484903028875;4358.716683415568;59751.402485974584;60008.69995650081;60060.69969650124;60304;61264;49282;49474.25788613102;50136.247956280684;50233.497665022885;53135;49261;49363;50010.24943628135;50643.74678126659;51625.741871290404;8159.144299495129;8357.623906924324;8388.496690198608;8410.495370277802;8596.183362580545;36114.45828312525;36286.63713362833;36612.26775464423;36708.81645591755;37234.62765372312;47116;48616.5138348612;49000.2649960258;49508;49607;10703.143748500257;11056.004959553678;11314.717132071764;11648.475818588015;12074.879251207727;12468.875311246771;12614.621561353175;12758.362081896053;12958.611241662766;12990.935045324713;10772;10947.616833410792;10989.285696429706;11021.393823339793;11234.382108984084;11700;11825.467853946766;11869.347185904859;11942.582009629621;12185.878141218474;10068.899311006797;10286.2799604027;10372.844407333745;11144.275622084539;11319.09447244235;9987.350822196535;10177.694669159937;10339.586416543554;10481.842772358268;10881.075108615856;8438.156184381513;8681.652733890825;9232.169104780602;9371.02113572693;9867.851982220129 08:05:40 INFO - 2016-01-21 08:05:40,756 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:05:40 INFO - 2016-01-21 08:05:40,756 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:05:40 INFO - 2016-01-21 08:05:40,756 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,309 08:05:40 INFO - 2016-01-21 08:05:40,756 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:05:40 INFO - 2016-01-21 08:05:40,757 DEBUG : BROWSER_OUTPUT: __startTimestamp1453392340746__endTimestamp 08:05:40 INFO - 2016-01-21 08:05:40,757 DEBUG : BROWSER_OUTPUT: 08:05:40 INFO - 2016-01-21 08:05:40,757 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:05:40 INFO - 2016-01-21 08:05:40,757 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:05:40 INFO - 2016-01-21 08:05:40,757 DEBUG : BROWSER_OUTPUT: 08:05:40 INFO - 2016-01-21 08:05:40,757 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5639.46 Median:5855.68 stddev:638.13 (10.9%) stddev-sans-first:611.79 08:05:40 INFO - 2016-01-21 08:05:40,757 DEBUG : BROWSER_OUTPUT: Values: 3243.5 3286.7 3290.9 3317.7 3327.0 5551.5 5554.9 5557.9 5580.6 5629.6 5576.0 5599.7 5607.4 5621.4 5649.7 5104.3 5110.8 5177.1 5188.6 5202.7 5023.7 5124.9 5134.6 5198.7 5296.3 5100.9 5187.5 5192.6 5193.0 5196.2 5212.6 5262.4 5275.7 5279.4 5316.5 4952.6 5008.4 5052.0 5177.5 5179.5 5408.2 5445.4 5477.6 5488.8 5489.1 6003.7 6052.2 6054.6 6067.8 6074.5 5961.5 6088.3 6102.9 6107.9 6153.0 5587.9 5596.9 5680.1 5687.4 5712.9 6131.5 6186.9 6201.6 6212.8 6228.3 5750.1 5843.1 5978.5 5987.7 5994.9 6074.5 6123.9 6152.2 6164.2 6165.0 6064.9 6085.1 6099.6 6112.7 6128.0 5936.6 6001.4 6053.5 6115.8 6131.4 4663.2 4663.7 4664.7 4674.2 4697.7 4160.0 4163.1 4163.9 4164.7 4205.7 5670.7 5683.9 5738.0 5815.8 5841.2 6017.8 6052.4 6097.8 6113.4 6142.9 5799.0 5801.2 5807.7 5809.0 5815.7 5213.2 5247.2 5298.9 5324.7 5335.7 6207.7 6247.7 6265.2 6267.5 6272.1 5887.6 6154.6 6156.0 6168.3 6181.8 6110.2 6147.6 6193.6 6204.3 6205.9 6029.7 6042.6 6043.5 6043.8 6109.4 5910.3 6016.0 6152.1 6155.3 6159.9 5985.1 6076.0 6119.0 6129.7 6136.3 5905.9 5930.0 5944.7 5951.8 5966.0 5708.5 5753.2 5881.8 5888.1 5928.0 5952.3 5992.9 6002.2 6016.0 6056.4 5843.1 5845.6 5847.7 5855.7 5907.1 08:05:40 INFO - 2016-01-21 08:05:40,757 DEBUG : BROWSER_OUTPUT: 08:05:40 INFO - 2016-01-21 08:05:40,757 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47588.57 Median:20986.30 stddev:80281.85 (382.5%) stddev-sans-first:80429.46 08:05:40 INFO - 2016-01-21 08:05:40,757 DEBUG : BROWSER_OUTPUT: Values: 575.4 611.1 611.6 620.3 674.6 31518.5 32642.7 40409.8 41058.2 41151.8 44088.3 44253.6 44365.8 44618.0 44682.8 9011.2 9113.1 9125.0 9174.0 9174.7 8939.4 9014.4 9025.6 9059.6 9069.4 8897.7 8951.8 9002.7 9040.0 9054.5 8929.4 8996.6 9059.1 9065.8 9086.2 8903.5 9050.5 9083.2 9089.8 9132.0 41161.2 41260.2 41444.8 41579.2 41630.4 3812.0 3929.8 4073.1 4211.1 4393.1 31329.5 31335.0 31355.8 31577.7 32449.4 4374.5 4392.0 4400.4 4443.9 4479.7 270497.0 271318.0 271369.0 271718.0 384628.0 50311.5 60468.4 61312.7 61338.7 61397.7 60944.0 61006.0 61240.4 61355.4 61452.0 14427.3 14498.9 14543.0 14555.6 14586.0 11503.2 11687.1 11706.1 11711.0 11744.6 19731.3 19778.5 19968.7 20090.7 20133.9 7865.6 7937.5 8013.4 8088.0 8137.8 1020.4 1083.5 1139.3 1140.0 1149.2 29039.1 29338.4 29379.4 29805.6 30251.4 1070.1 1125.5 1139.1 1152.3 1213.4 13465.3 14104.0 14255.0 14276.8 14391.5 337152.0 343022.0 343364.0 343683.0 354108.0 48438.8 48693.8 49026.3 49046.8 49335.5 1418.2 1425.2 1428.3 1432.6 1444.0 28305.2 28334.3 28575.9 28629.9 29235.7 45245.0 45330.1 45532.1 45550.3 45766.5 272849.0 273748.6 275243.0 275451.0 276423.0 32434.4 32701.2 32751.8 33342.0 33692.2 40230.6 40561.4 40872.8 40880.8 41448.2 36524.6 36889.8 37513.1 37603.8 37842.0 36207.6 37461.3 38445.0 38613.2 41427.4 37829.2 38072.4 38160.6 38247.4 38329.2 32853.3 32995.2 33202.0 33348.2 33679.2 24548.4 25692.9 25962.5 26032.5 26139.7 08:05:40 INFO - 2016-01-21 08:05:40,757 DEBUG : BROWSER_OUTPUT: 08:05:40 INFO - 2016-01-21 08:05:40,757 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32041.51 Median:35712.91 stddev:107414.63 (300.8%) stddev-sans-first:107689.65 08:05:40 INFO - 2016-01-21 08:05:40,759 DEBUG : BROWSER_OUTPUT: Values: 388.6 388.6 390.5 392.5 396.4 15937.2 17205.0 17256.7 18903.6 18943.4 11714.1 12486.7 12919.7 17884.5 17914.4 4983.6 5227.7 5356.4 5365.7 6187.8 5338.4 5443.9 5476.3 5482.7 6120.1 5422.0 5426.3 5454.5 5502.8 5745.7 5633.4 5647.0 5669.0 5687.3 5690.2 5036.9 5136.3 5325.4 5458.7 5468.8 13615.7 13729.2 13841.2 14010.4 14069.0 2272.2 2300.3 2306.2 2344.4 2485.8 10682.4 10694.1 12392.0 12748.9 13590.8 1981.5 2008.2 2022.9 2025.0 2055.7 61651.0 63044.4 63523.0 63975.7 64562.7 10890.6 11112.1 11149.7 11207.4 11282.2 14538.2 14571.0 14578.5 14647.5 14671.5 7899.5 8003.6 8009.9 8026.6 8084.4 7502.7 7531.8 7593.4 7599.5 7609.9 4654.0 4730.7 4740.6 4759.8 4824.5 1942.9 1994.8 2068.9 2074.3 2078.7 435.3 469.9 498.5 927.0 1119.8 11298.3 11661.0 11780.9 11809.4 11990.4 487.2 506.8 515.9 519.1 523.4 6289.9 6400.7 6499.6 6521.4 6554.8 629087.0 649346.0 663108.0 671321.0 674796.0 44550.9 83836.1 84647.0 84941.0 86377.1 524.4 530.6 533.2 534.4 536.1 10787.5 10826.7 10929.7 11024.5 11163.9 34753.8 35313.8 36112.0 36362.8 36547.5 50634.2 50842.0 51410.5 51708.2 52950.8 9756.9 9825.9 10247.5 10314.7 10341.0 16194.4 17074.7 17411.3 17458.0 17997.6 14621.3 14633.7 15126.6 15147.5 15209.5 14583.7 14784.6 15097.3 15133.9 15174.4 15631.0 15927.0 15992.2 16134.8 16294.0 10467.7 10555.2 10607.9 10635.4 10660.0 14795.6 14968.6 15523.1 15745.1 15833.2 08:05:40 INFO - 2016-01-21 08:05:40,759 DEBUG : BROWSER_OUTPUT: 08:05:40 INFO - 2016-01-21 08:05:40,759 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5605.58 Median:6416.91 stddev:2875.76 (44.8%) stddev-sans-first:2867.75 08:05:40 INFO - 2016-01-21 08:05:40,759 DEBUG : BROWSER_OUTPUT: Values: 1559.3 1611.1 1647.0 1832.7 1913.1 7926.3 8036.3 8139.6 8145.3 8193.1 7982.3 7983.1 8035.3 8093.8 8107.4 2374.9 2387.4 2411.0 2413.4 2414.8 2394.1 2406.6 2423.3 2443.0 2455.2 2330.9 2344.7 2369.3 2379.2 2392.9 2282.2 2341.6 2369.7 2378.8 2388.6 2360.1 2379.3 2384.8 2389.1 2389.2 7948.8 8047.9 8054.6 8077.3 8078.1 4889.8 4976.5 4993.0 5004.8 5009.5 3116.0 3133.5 3135.6 3150.8 3166.6 1074.4 1087.6 1123.1 1139.8 1145.8 10960.4 10962.9 11061.2 11116.0 11141.0 4331.5 4376.1 4395.3 4407.8 4425.4 8974.1 9026.3 9045.6 9061.7 9067.2 4881.0 4883.4 4894.8 4897.7 4917.2 4510.8 4525.7 4535.8 4545.7 4572.5 3555.5 3595.2 3616.0 3637.3 3637.7 1099.1 1100.6 1105.4 1117.6 1175.6 1068.0 1091.1 1098.6 1237.8 1339.7 7548.1 7566.0 7605.0 7646.0 7663.3 1053.5 1056.6 1089.5 1126.4 1162.5 5797.4 5803.1 5819.5 5843.9 5854.0 9547.1 9653.9 9856.6 9904.9 9999.7 9721.4 9772.2 9782.7 9785.4 9883.2 7559.3 7652.4 7685.5 7699.8 7709.0 7256.3 7295.9 7329.7 7340.0 7353.3 8020.6 8114.0 8298.6 8358.6 8432.5 8152.3 8173.3 8180.5 8215.2 8233.0 7037.0 7074.5 7085.1 7088.0 7103.5 7480.3 7508.5 7519.8 7527.1 7527.4 7008.4 7093.3 7177.1 7217.9 7326.9 6980.7 7221.4 7282.7 7283.7 7302.0 7225.5 7292.8 7303.2 7305.1 7335.3 6409.5 6424.3 6437.5 6455.4 6459.5 6643.7 6751.1 6783.7 6784.4 6791.9 08:05:40 INFO - 2016-01-21 08:05:40,759 DEBUG : BROWSER_OUTPUT: 08:05:40 INFO - 2016-01-21 08:05:40,759 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5712.42 Median:6513.21 stddev:1720.94 (26.4%) stddev-sans-first:1678.18 08:05:40 INFO - 2016-01-21 08:05:40,759 DEBUG : BROWSER_OUTPUT: Values: 357.4 368.1 369.3 371.1 372.8 6358.3 6367.0 6403.9 6487.5 6492.5 6237.0 6362.6 6380.5 6411.4 6423.0 4937.4 4960.3 4961.7 4962.6 4975.6 4942.2 4956.4 4962.7 4967.3 4968.8 4672.9 4897.3 4904.7 4916.0 4916.4 4878.0 4882.6 4895.9 4896.9 4898.5 4283.0 4283.1 4284.2 4288.5 4305.9 5908.0 6032.8 6055.0 6060.6 6079.1 5667.7 5679.3 5680.5 5694.9 5695.8 6747.8 6750.7 6762.6 6763.1 6776.5 4702.9 4707.2 4724.9 4740.0 4755.6 6919.7 6985.1 7050.3 7065.0 7066.7 4831.8 4849.5 4850.3 4864.5 4872.3 4879.8 4888.3 4908.6 4908.8 4914.4 5453.9 5651.3 5657.8 5667.4 5687.9 6771.7 6790.1 6825.2 6874.0 6882.2 1689.4 1739.6 1743.9 1745.3 1750.1 1148.3 1165.7 1180.1 1180.4 1191.2 6533.9 6537.5 6546.6 6551.3 6612.8 6969.3 6981.4 7002.5 7009.5 7012.5 6465.8 6536.4 6562.0 6565.2 6573.6 3761.7 3806.4 3813.4 3813.5 3814.8 7156.5 7178.7 7238.9 7240.5 7250.4 7072.0 7193.8 7193.9 7195.5 7319.6 7317.6 7339.9 7354.4 7358.4 7358.5 7109.6 7115.2 7122.1 7127.2 7134.7 6893.2 6951.2 6992.1 7022.9 7026.4 7324.9 7330.0 7331.2 7336.9 7344.4 4789.5 4873.5 4885.0 4890.2 4892.4 6914.5 7005.2 7069.3 7086.6 7096.4 6882.0 6897.1 6902.0 6906.7 6944.4 6876.4 6900.7 6904.9 6910.4 6910.9 6683.6 6768.4 6787.0 6794.7 6812.8 6933.0 6949.9 6953.4 6953.7 6965.7 6565.1 6688.0 6733.0 6734.4 6777.5 08:05:40 INFO - 2016-01-21 08:05:40,759 DEBUG : BROWSER_OUTPUT: 08:05:40 INFO - 2016-01-21 08:05:40,760 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14371.16 Median:48628.76 stddev:16625.70 (34.2%) stddev-sans-first:16641.28 08:05:40 INFO - 2016-01-21 08:05:40,760 DEBUG : BROWSER_OUTPUT: Values: 838.6 913.0 917.8 922.5 924.3 14228.0 14522.7 14523.6 14601.8 15179.2 13709.7 13819.5 13822.2 13832.6 13918.8 873.5 906.2 907.6 909.2 910.7 891.7 901.6 904.1 906.1 906.4 955.5 958.8 959.6 962.8 964.6 936.4 938.6 945.0 947.4 948.3 692.3 693.9 695.6 703.8 714.9 14603.6 14750.9 14816.5 14828.4 14833.1 12555.2 12701.1 12861.8 12885.8 13466.5 11192.3 11278.3 11573.6 11981.6 12326.0 3631.0 3654.8 3880.3 3905.7 3909.8 48641.0 48871.8 48913.5 49069.0 49278.8 10526.1 10664.1 10729.8 10827.4 10837.0 18246.3 18253.0 18332.8 18361.8 18384.0 7808.8 7829.7 7882.6 8259.3 8395.4 4374.5 4377.3 4400.3 4419.8 4551.5 3270.3 3277.4 3317.0 3317.9 3322.9 581.4 588.0 590.9 592.1 600.9 622.4 689.1 689.4 715.0 717.2 8671.6 8739.1 8806.6 8844.2 8928.0 652.4 654.2 662.8 685.9 707.2 3854.6 4222.2 4224.2 4328.8 4358.7 59751.4 60008.7 60060.7 60304.0 61264.0 49282.0 49474.3 50136.2 50233.5 53135.0 49261.0 49363.0 50010.2 50643.7 51625.7 8159.1 8357.6 8388.5 8410.5 8596.2 36114.5 36286.6 36612.3 36708.8 37234.6 47116.0 48616.5 49000.3 49508.0 49607.0 10703.1 11056.0 11314.7 11648.5 12074.9 12468.9 12614.6 12758.4 12958.6 12990.9 10772.0 10947.6 10989.3 11021.4 11234.4 11700.0 11825.5 11869.3 11942.6 12185.9 10068.9 10286.3 10372.8 11144.3 11319.1 9987.4 10177.7 10339.6 10481.8 10881.1 8438.2 8681.7 9232.2 9371.0 9867.9 08:05:40 INFO - 2016-01-21 08:05:40,761 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:05:40 INFO - 2016-01-21 08:05:40,761 DEBUG : BROWSER_OUTPUT: 08:05:41 INFO - 2016-01-21 08:05:41,397 INFO : Browser exited with error code: 0 08:05:41 INFO - 2016-01-21 08:05:41,418 INFO : Completed test dromaeo_css (00:18:28) 08:05:41 INFO - 2016-01-21 08:05:41,418 INFO : Starting test kraken 08:05:41 INFO - 2016-01-21 08:05:41,419 DEBUG : operating with platform_type : linux_ 08:05:41 INFO - 2016-01-21 08:05:41,419 INFO : Initialising browser for kraken test... 08:05:41 INFO - 2016-01-21 08:05:41,425 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpE5H1AL/profile http://localhost:43119/getInfo.html 08:05:44 INFO - 2016-01-21 08:05:44,442 DEBUG : BROWSER_OUTPUT: 08:05:44 INFO - 2016-01-21 08:05:44,442 DEBUG : BROWSER_OUTPUT: (process:17783): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:05:45 INFO - 2016-01-21 08:05:45,189 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:05:45 INFO - 2016-01-21 08:05:45,190 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:05:45 INFO - 2016-01-21 08:05:45,190 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:05:45 INFO - 2016-01-21 08:05:45,190 DEBUG : BROWSER_OUTPUT: __metrics 08:05:46 INFO - 2016-01-21 08:05:46,057 INFO : Browser initialized. 08:05:46 INFO - 2016-01-21 08:05:46,058 INFO : Running cycle 1/1 for kraken test... 08:05:46 INFO - 2016-01-21 08:05:46,058 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpE5H1AL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:05:47 INFO - 2016-01-21 08:05:47,376 DEBUG : BROWSER_OUTPUT: 08:05:47 INFO - 2016-01-21 08:05:47,376 DEBUG : BROWSER_OUTPUT: (process:17897): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:05:57 INFO - 2016-01-21 08:05:57,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 136900608 08:05:57 INFO - 2016-01-21 08:05:57,881 DEBUG : BROWSER_OUTPUT: 08:06:00 INFO - 2016-01-21 08:06:00,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43119/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43119/tests/kraken/driver.html?testName=audio-beat-detection) 08:06:00 INFO - 2016-01-21 08:06:00,951 DEBUG : BROWSER_OUTPUT: RSS: Main: 138526720 08:06:00 INFO - 2016-01-21 08:06:00,951 DEBUG : BROWSER_OUTPUT: 08:06:03 INFO - 2016-01-21 08:06:03,527 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43119/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43119/tests/kraken/driver.html?testName=audio-dft) 08:06:04 INFO - 2016-01-21 08:06:04,121 DEBUG : BROWSER_OUTPUT: RSS: Main: 137048064 08:06:04 INFO - 2016-01-21 08:06:04,121 DEBUG : BROWSER_OUTPUT: 08:06:06 INFO - 2016-01-21 08:06:06,939 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43119/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43119/tests/kraken/driver.html?testName=audio-fft) 08:06:07 INFO - 2016-01-21 08:06:07,512 DEBUG : BROWSER_OUTPUT: RSS: Main: 139165696 08:06:07 INFO - 2016-01-21 08:06:07,513 DEBUG : BROWSER_OUTPUT: 08:06:09 INFO - 2016-01-21 08:06:09,525 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43119/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43119/tests/kraken/driver.html?testName=audio-oscillator) 08:06:10 INFO - 2016-01-21 08:06:10,118 DEBUG : BROWSER_OUTPUT: RSS: Main: 139571200 08:06:10 INFO - 2016-01-21 08:06:10,119 DEBUG : BROWSER_OUTPUT: 08:06:12 INFO - 2016-01-21 08:06:12,297 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43119/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43119/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:06:12 INFO - 2016-01-21 08:06:12,878 DEBUG : BROWSER_OUTPUT: RSS: Main: 139509760 08:06:12 INFO - 2016-01-21 08:06:12,879 DEBUG : BROWSER_OUTPUT: 08:06:15 INFO - 2016-01-21 08:06:15,822 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43119/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43119/tests/kraken/driver.html?testName=imaging-darkroom) 08:06:16 INFO - 2016-01-21 08:06:16,416 DEBUG : BROWSER_OUTPUT: RSS: Main: 139599872 08:06:16 INFO - 2016-01-21 08:06:16,417 DEBUG : BROWSER_OUTPUT: 08:06:19 INFO - 2016-01-21 08:06:19,790 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43119/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43119/tests/kraken/driver.html?testName=imaging-desaturate) 08:06:20 INFO - 2016-01-21 08:06:20,379 DEBUG : BROWSER_OUTPUT: RSS: Main: 138506240 08:06:20 INFO - 2016-01-21 08:06:20,379 DEBUG : BROWSER_OUTPUT: 08:06:23 INFO - 2016-01-21 08:06:23,162 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43119/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43119/tests/kraken/driver.html?testName=json-parse-financial) 08:06:23 INFO - 2016-01-21 08:06:23,748 DEBUG : BROWSER_OUTPUT: RSS: Main: 138780672 08:06:23 INFO - 2016-01-21 08:06:23,748 DEBUG : BROWSER_OUTPUT: 08:06:25 INFO - 2016-01-21 08:06:25,321 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43119/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43119/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:06:25 INFO - 2016-01-21 08:06:25,897 DEBUG : BROWSER_OUTPUT: RSS: Main: 137940992 08:06:25 INFO - 2016-01-21 08:06:25,897 DEBUG : BROWSER_OUTPUT: 08:06:27 INFO - 2016-01-21 08:06:27,659 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43119/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43119/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:06:28 INFO - 2016-01-21 08:06:28,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 139812864 08:06:28 INFO - 2016-01-21 08:06:28,266 DEBUG : BROWSER_OUTPUT: 08:06:30 INFO - 2016-01-21 08:06:30,330 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43119/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43119/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:06:30 INFO - 2016-01-21 08:06:30,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 139911168 08:06:30 INFO - 2016-01-21 08:06:30,913 DEBUG : BROWSER_OUTPUT: 08:06:33 INFO - 2016-01-21 08:06:33,328 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43119/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43119/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:06:33 INFO - 2016-01-21 08:06:33,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 139878400 08:06:33 INFO - 2016-01-21 08:06:33,921 DEBUG : BROWSER_OUTPUT: 08:06:36 INFO - 2016-01-21 08:06:36,465 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43119/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43119/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:06:37 INFO - 2016-01-21 08:06:37,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 138752000 08:06:37 INFO - 2016-01-21 08:06:37,051 DEBUG : BROWSER_OUTPUT: 08:06:38 INFO - 2016-01-21 08:06:38,748 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43119/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43119/tests/kraken/driver.html?testName=ai-astar) 08:06:39 INFO - 2016-01-21 08:06:39,007 DEBUG : BROWSER_OUTPUT: RSS: Main: 138366976 08:06:39 INFO - 2016-01-21 08:06:39,007 DEBUG : BROWSER_OUTPUT: 08:06:39 INFO - 2016-01-21 08:06:39,007 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:06:39 INFO - 2016-01-21 08:06:39,007 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:06:39 INFO - 2016-01-21 08:06:39,007 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:06:39 INFO - 2016-01-21 08:06:39,007 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:06:39 INFO - 2016-01-21 08:06:39,008 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;105;109;110;109;120;110;109;110;112 08:06:39 INFO - 2016-01-21 08:06:39,008 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;126;151;158;125;153;151;127;156;124 08:06:39 INFO - 2016-01-21 08:06:39,008 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;163;160;162;161;160;162;161;163;162 08:06:39 INFO - 2016-01-21 08:06:39,008 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;73;158;73;74;73;74;160;72 08:06:39 INFO - 2016-01-21 08:06:39,008 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;133;93;92;92;136;91;92;134 08:06:39 INFO - 2016-01-21 08:06:39,008 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;111;109;109;109;110;110;109 08:06:39 INFO - 2016-01-21 08:06:39,009 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;146;146;146;146;147;147;147;147 08:06:39 INFO - 2016-01-21 08:06:39,009 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;96;97;96;96;96 08:06:39 INFO - 2016-01-21 08:06:39,009 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;61;62;60;60;59;58;62;64;57 08:06:39 INFO - 2016-01-21 08:06:39,009 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;65;66;66;65;66;64;65;66;66 08:06:39 INFO - 2016-01-21 08:06:39,010 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;79;89;90;89;83;89;82;82;88;80 08:06:39 INFO - 2016-01-21 08:06:39,010 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;115;122;121;128;122;132;127;116;114;119 08:06:39 INFO - 2016-01-21 08:06:39,010 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;144;148;155;147;151;136;146;150;137;146 08:06:39 INFO - 2016-01-21 08:06:39,010 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;68;69;68;69;66;69;71;68;66 08:06:39 INFO - 2016-01-21 08:06:39,010 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:06:39 INFO - 2016-01-21 08:06:39,010 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:06:39 INFO - 2016-01-21 08:06:39,011 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,710 08:06:39 INFO - 2016-01-21 08:06:39,011 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:06:39 INFO - 2016-01-21 08:06:39,011 DEBUG : BROWSER_OUTPUT: __startTimestamp1453392399001__endTimestamp 08:06:39 INFO - 2016-01-21 08:06:39,011 DEBUG : BROWSER_OUTPUT: 08:06:39 INFO - 2016-01-21 08:06:39,011 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:06:39 INFO - 2016-01-21 08:06:39,011 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:06:39 INFO - 2016-01-21 08:06:39,012 DEBUG : BROWSER_OUTPUT: 08:06:39 INFO - 2016-01-21 08:06:39,012 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.40 Median:110.00 stddev:3.81 (3.5%) stddev-sans-first:4.03 08:06:39 INFO - 2016-01-21 08:06:39,012 DEBUG : BROWSER_OUTPUT: Values: 110.0 105.0 109.0 110.0 109.0 120.0 110.0 109.0 110.0 112.0 08:06:39 INFO - 2016-01-21 08:06:39,012 DEBUG : BROWSER_OUTPUT: 08:06:39 INFO - 2016-01-21 08:06:39,012 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.30 Median:151.50 stddev:14.64 (9.7%) stddev-sans-first:15.10 08:06:39 INFO - 2016-01-21 08:06:39,013 DEBUG : BROWSER_OUTPUT: Values: 152.0 126.0 151.0 158.0 125.0 153.0 151.0 127.0 156.0 124.0 08:06:39 INFO - 2016-01-21 08:06:39,013 DEBUG : BROWSER_OUTPUT: 08:06:39 INFO - 2016-01-21 08:06:39,013 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.13 08:06:39 INFO - 2016-01-21 08:06:39,013 DEBUG : BROWSER_OUTPUT: Values: 163.0 163.0 160.0 162.0 161.0 160.0 162.0 161.0 163.0 162.0 08:06:39 INFO - 2016-01-21 08:06:39,013 DEBUG : BROWSER_OUTPUT: 08:06:39 INFO - 2016-01-21 08:06:39,013 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.20 Median:73.00 stddev:36.27 (49.7%) stddev-sans-first:37.93 08:06:39 INFO - 2016-01-21 08:06:39,014 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 73.0 158.0 73.0 74.0 73.0 74.0 160.0 72.0 08:06:39 INFO - 2016-01-21 08:06:39,014 DEBUG : BROWSER_OUTPUT: 08:06:39 INFO - 2016-01-21 08:06:39,014 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.90 Median:92.00 stddev:20.33 (22.1%) stddev-sans-first:21.11 08:06:39 INFO - 2016-01-21 08:06:39,014 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 133.0 93.0 92.0 92.0 136.0 91.0 92.0 134.0 08:06:39 INFO - 2016-01-21 08:06:39,014 DEBUG : BROWSER_OUTPUT: 08:06:39 INFO - 2016-01-21 08:06:39,015 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 08:06:39 INFO - 2016-01-21 08:06:39,015 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 111.0 109.0 109.0 109.0 110.0 110.0 109.0 08:06:39 INFO - 2016-01-21 08:06:39,015 DEBUG : BROWSER_OUTPUT: 08:06:39 INFO - 2016-01-21 08:06:39,015 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 08:06:39 INFO - 2016-01-21 08:06:39,015 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 146.0 146.0 146.0 146.0 147.0 147.0 147.0 147.0 08:06:39 INFO - 2016-01-21 08:06:39,015 DEBUG : BROWSER_OUTPUT: 08:06:39 INFO - 2016-01-21 08:06:39,015 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:06:39 INFO - 2016-01-21 08:06:39,015 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 08:06:39 INFO - 2016-01-21 08:06:39,015 DEBUG : BROWSER_OUTPUT: 08:06:39 INFO - 2016-01-21 08:06:39,015 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.30 Median:60.50 stddev:2.06 (3.4%) stddev-sans-first:2.18 08:06:39 INFO - 2016-01-21 08:06:39,015 DEBUG : BROWSER_OUTPUT: Values: 60.0 61.0 62.0 60.0 60.0 59.0 58.0 62.0 64.0 57.0 08:06:39 INFO - 2016-01-21 08:06:39,015 DEBUG : BROWSER_OUTPUT: 08:06:39 INFO - 2016-01-21 08:06:39,016 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.73 08:06:39 INFO - 2016-01-21 08:06:39,016 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 66.0 66.0 65.0 66.0 64.0 65.0 66.0 66.0 08:06:39 INFO - 2016-01-21 08:06:39,016 DEBUG : BROWSER_OUTPUT: 08:06:39 INFO - 2016-01-21 08:06:39,016 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:88.50 stddev:4.28 (4.8%) stddev-sans-first:3.93 08:06:39 INFO - 2016-01-21 08:06:39,016 DEBUG : BROWSER_OUTPUT: Values: 79.0 89.0 90.0 89.0 83.0 89.0 82.0 82.0 88.0 80.0 08:06:39 INFO - 2016-01-21 08:06:39,016 DEBUG : BROWSER_OUTPUT: 08:06:39 INFO - 2016-01-21 08:06:39,016 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.60 Median:122.00 stddev:5.95 (4.9%) stddev-sans-first:5.81 08:06:39 INFO - 2016-01-21 08:06:39,016 DEBUG : BROWSER_OUTPUT: Values: 115.0 122.0 121.0 128.0 122.0 132.0 127.0 116.0 114.0 119.0 08:06:39 INFO - 2016-01-21 08:06:39,016 DEBUG : BROWSER_OUTPUT: 08:06:39 INFO - 2016-01-21 08:06:39,017 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.00 Median:147.50 stddev:5.89 (4.0%) stddev-sans-first:6.20 08:06:39 INFO - 2016-01-21 08:06:39,017 DEBUG : BROWSER_OUTPUT: Values: 144.0 148.0 155.0 147.0 151.0 136.0 146.0 150.0 137.0 146.0 08:06:39 INFO - 2016-01-21 08:06:39,017 DEBUG : BROWSER_OUTPUT: 08:06:39 INFO - 2016-01-21 08:06:39,017 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:2.11 (3.1%) stddev-sans-first:1.56 08:06:39 INFO - 2016-01-21 08:06:39,017 DEBUG : BROWSER_OUTPUT: Values: 73.0 68.0 69.0 68.0 69.0 66.0 69.0 71.0 68.0 66.0 08:06:39 INFO - 2016-01-21 08:06:39,017 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:06:39 INFO - 2016-01-21 08:06:39,017 DEBUG : BROWSER_OUTPUT: 08:06:39 INFO - 2016-01-21 08:06:39,797 INFO : Browser exited with error code: 0 08:06:39 INFO - 2016-01-21 08:06:39,845 INFO : Completed test kraken (00:00:58) 08:06:39 INFO - 2016-01-21 08:06:39,845 INFO : Starting test v8_7 08:06:39 INFO - 2016-01-21 08:06:39,845 DEBUG : operating with platform_type : linux_ 08:06:39 INFO - 2016-01-21 08:06:39,845 INFO : Initialising browser for v8_7 test... 08:06:39 INFO - 2016-01-21 08:06:39,851 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoDkXMJ/profile http://localhost:43119/getInfo.html 08:06:43 INFO - 2016-01-21 08:06:43,002 DEBUG : BROWSER_OUTPUT: 08:06:43 INFO - 2016-01-21 08:06:43,003 DEBUG : BROWSER_OUTPUT: (process:18205): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:06:43 INFO - 2016-01-21 08:06:43,692 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:06:43 INFO - 2016-01-21 08:06:43,692 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:06:43 INFO - 2016-01-21 08:06:43,692 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:06:43 INFO - 2016-01-21 08:06:43,692 DEBUG : BROWSER_OUTPUT: __metrics 08:06:44 INFO - 2016-01-21 08:06:44,597 INFO : Browser initialized. 08:06:44 INFO - 2016-01-21 08:06:44,598 INFO : Running cycle 1/1 for v8_7 test... 08:06:44 INFO - 2016-01-21 08:06:44,598 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoDkXMJ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:06:45 INFO - 2016-01-21 08:06:45,930 DEBUG : BROWSER_OUTPUT: 08:06:45 INFO - 2016-01-21 08:06:45,931 DEBUG : BROWSER_OUTPUT: (process:18318): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:06:56 INFO - 2016-01-21 08:06:56,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 136667136 08:06:56 INFO - 2016-01-21 08:06:56,436 DEBUG : BROWSER_OUTPUT: 08:07:17 INFO - 2016-01-21 08:07:17,799 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43119/tests/v8_7/run.html (next: http://localhost:43119/tests/v8_7/run.html) 08:07:18 INFO - 2016-01-21 08:07:18,045 DEBUG : BROWSER_OUTPUT: RSS: Main: 136212480 08:07:18 INFO - 2016-01-21 08:07:18,046 DEBUG : BROWSER_OUTPUT: 08:07:18 INFO - 2016-01-21 08:07:18,046 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:07:18 INFO - 2016-01-21 08:07:18,046 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:07:18 INFO - 2016-01-21 08:07:18,046 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:07:18 INFO - 2016-01-21 08:07:18,046 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:07:18 INFO - 2016-01-21 08:07:18,046 DEBUG : BROWSER_OUTPUT: |0;Richards;164.17665407978984 08:07:18 INFO - 2016-01-21 08:07:18,046 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;172.95053614666205 08:07:18 INFO - 2016-01-21 08:07:18,047 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.473962684489 08:07:18 INFO - 2016-01-21 08:07:18,047 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 08:07:18 INFO - 2016-01-21 08:07:18,047 DEBUG : BROWSER_OUTPUT: |4;RayTrace;903.342366757001 08:07:18 INFO - 2016-01-21 08:07:18,047 DEBUG : BROWSER_OUTPUT: |5;Earley;554.016620498615 08:07:18 INFO - 2016-01-21 08:07:18,047 DEBUG : BROWSER_OUTPUT: |6;Boyer;11131.868131868132 08:07:18 INFO - 2016-01-21 08:07:18,047 DEBUG : BROWSER_OUTPUT: |7;RegExp;23767.441860465115 08:07:18 INFO - 2016-01-21 08:07:18,048 DEBUG : BROWSER_OUTPUT: |8;Splay;529.6610169491526 08:07:18 INFO - 2016-01-21 08:07:18,048 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 08:07:18 INFO - 2016-01-21 08:07:18,048 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:07:18 INFO - 2016-01-21 08:07:18,048 DEBUG : BROWSER_OUTPUT: __startTimestamp1453392438044__endTimestamp 08:07:18 INFO - 2016-01-21 08:07:18,048 DEBUG : BROWSER_OUTPUT: 08:07:18 INFO - 2016-01-21 08:07:18,048 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:07:18 INFO - 2016-01-21 08:07:18,049 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:07:18 INFO - 2016-01-21 08:07:18,049 DEBUG : BROWSER_OUTPUT: 08:07:18 INFO - 2016-01-21 08:07:18,049 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.18 Median:164.18 stddev:0.00 (0.0%) 08:07:18 INFO - 2016-01-21 08:07:18,049 DEBUG : BROWSER_OUTPUT: Values: 164.2 08:07:18 INFO - 2016-01-21 08:07:18,049 DEBUG : BROWSER_OUTPUT: 08:07:18 INFO - 2016-01-21 08:07:18,049 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:172.95 Median:172.95 stddev:0.00 (0.0%) 08:07:18 INFO - 2016-01-21 08:07:18,049 DEBUG : BROWSER_OUTPUT: Values: 173.0 08:07:18 INFO - 2016-01-21 08:07:18,049 DEBUG : BROWSER_OUTPUT: 08:07:18 INFO - 2016-01-21 08:07:18,049 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.47 Median:278.47 stddev:0.00 (0.0%) 08:07:18 INFO - 2016-01-21 08:07:18,049 DEBUG : BROWSER_OUTPUT: Values: 278.5 08:07:18 INFO - 2016-01-21 08:07:18,049 DEBUG : BROWSER_OUTPUT: 08:07:18 INFO - 2016-01-21 08:07:18,050 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 08:07:18 INFO - 2016-01-21 08:07:18,050 DEBUG : BROWSER_OUTPUT: Values: 5133.3 08:07:18 INFO - 2016-01-21 08:07:18,050 DEBUG : BROWSER_OUTPUT: 08:07:18 INFO - 2016-01-21 08:07:18,050 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:903.34 Median:903.34 stddev:0.00 (0.0%) 08:07:18 INFO - 2016-01-21 08:07:18,051 DEBUG : BROWSER_OUTPUT: Values: 903.3 08:07:18 INFO - 2016-01-21 08:07:18,051 DEBUG : BROWSER_OUTPUT: 08:07:18 INFO - 2016-01-21 08:07:18,051 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:554.02 Median:554.02 stddev:0.00 (0.0%) 08:07:18 INFO - 2016-01-21 08:07:18,051 DEBUG : BROWSER_OUTPUT: Values: 554.0 08:07:18 INFO - 2016-01-21 08:07:18,051 DEBUG : BROWSER_OUTPUT: 08:07:18 INFO - 2016-01-21 08:07:18,051 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11131.87 Median:11131.87 stddev:0.00 (0.0%) 08:07:18 INFO - 2016-01-21 08:07:18,052 DEBUG : BROWSER_OUTPUT: Values: 11131.9 08:07:18 INFO - 2016-01-21 08:07:18,052 DEBUG : BROWSER_OUTPUT: 08:07:18 INFO - 2016-01-21 08:07:18,052 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23767.44 Median:23767.44 stddev:0.00 (0.0%) 08:07:18 INFO - 2016-01-21 08:07:18,052 DEBUG : BROWSER_OUTPUT: Values: 23767.4 08:07:18 INFO - 2016-01-21 08:07:18,052 DEBUG : BROWSER_OUTPUT: 08:07:18 INFO - 2016-01-21 08:07:18,052 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:529.66 Median:529.66 stddev:0.00 (0.0%) 08:07:18 INFO - 2016-01-21 08:07:18,052 DEBUG : BROWSER_OUTPUT: Values: 529.7 08:07:18 INFO - 2016-01-21 08:07:18,052 DEBUG : BROWSER_OUTPUT: 08:07:18 INFO - 2016-01-21 08:07:18,052 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 08:07:18 INFO - 2016-01-21 08:07:18,052 DEBUG : BROWSER_OUTPUT: Values: 4840.6 08:07:18 INFO - 2016-01-21 08:07:18,052 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:07:18 INFO - 2016-01-21 08:07:18,052 DEBUG : BROWSER_OUTPUT: 08:07:18 INFO - 2016-01-21 08:07:18,841 INFO : Browser exited with error code: 0 08:07:18 INFO - 2016-01-21 08:07:18,855 INFO : Completed test v8_7 (00:00:39) 08:07:19 INFO - 2016-01-21 08:07:19,088 INFO : Completed test suite (00:20:06) 08:07:19 INFO - 2016-01-21 08:07:19,088 DEBUG : Working with test: dromaeo_css 08:07:19 INFO - 2016-01-21 08:07:19,089 DEBUG : Generating results file: dromaeo_css 08:07:19 INFO - 2016-01-21 08:07:19,090 DEBUG : Working with test: kraken 08:07:19 INFO - 2016-01-21 08:07:19,090 DEBUG : Generating results file: kraken 08:07:19 INFO - 2016-01-21 08:07:19,090 INFO : javascript benchmark 08:07:19 INFO - 2016-01-21 08:07:19,090 DEBUG : Working with test: v8_7 08:07:19 INFO - 2016-01-21 08:07:19,090 DEBUG : Generating results file: v8_7 08:07:19 INFO - 2016-01-21 08:07:19,091 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:07:19 INFO - 2016-01-21 08:07:19,149 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 08:07:19 INFO - 2016-01-21 08:07:19,150 DEBUG : process_Request line: dromaeo_css 7241.12 graph.html#tests=[[72,52,43]] 08:07:19 INFO - 2016-01-21 08:07:19,150 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:07:19 INFO - 2016-01-21 08:07:19,181 DEBUG : process_Request line: kraken 1508.90 graph.html#tests=[[232,52,43]] 08:07:19 INFO - 2016-01-21 08:07:19,181 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:07:19 INFO - 2016-01-21 08:07:19,219 DEBUG : process_Request line: v8_7 23199.49 graph.html#tests=[[230,52,43]] 08:07:19 INFO - 2016-01-21 08:07:19,220 INFO : javascript benchmark 08:07:19 INFO - 2016-01-21 08:07:19,224 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3243.5296881952113, 3286.671332866712, 3290.9012729618103, 3317.7014068733815, 3327.0, 5551.500364967153, 5554.888902221953, 5557.86105347366, 5580.581456390767, 5629.577781666376, 5575.972120139394, 5599.692016939067, 5607.355154157273, 5621.381648018725, 5649.717514124298, 5104.310918026074, 5110.821121260757, 5177.119889618755, 5188.6367954243215, 5202.683520851064, 5023.7236951967625, 5124.92312615311, 5134.563562097208, 5198.740062996835, 5296.285001524783, 5100.897982040357, 5187.455317191697, 5192.55863251624, 5192.974035129819, 5196.220566914955, 5212.582993360522, 5262.4474430184855, 5275.657082289677, 5279.366476022902, 5316.494932981361, 4952.62855285855, 5008.449070602231, 5052.0, 5177.534021938006, 5179.482051794828, 5408.215808707755, 5445.401005889349, 5477.589180811416, 5488.807891723771, 5489.1217405214975, 6003.699815009232, 6052.21321228242, 6054.576179667425, 6067.787627433018, 6074.48366888815, 5961.463468287875, 6088.299845517734, 6102.908456373158, 6107.877842443127, 6152.969235153841, 5587.916181257285, 5596.944030559724, 5680.0627896397455, 5687.431256874363, 5712.942870571283, 6131.540134489842, 6186.907196392058, 6201.56589038772, 6212.782552610637, 6228.252609686776, 5750.079987202028, 5843.094320380348, 5978.521718262528, 5987.670678112746, 5994.910076348859, 6074.51403887688, 6123.9387606124255, 6152.230971128609, 6164.198654174928, 6165.04441811511, 6064.9090263646085, 6085.087236914498, 6099.5840286945295, 6112.74665817949, 6127.9837278401355, 5936.614120082181, 6001.36985616504, 6053.545984051214, 6115.816525504242, 6131.448169664752, 4663.183942809995, 4663.743494107789, 4664.673472856935, 4674.22875225584, 4697.741624210701, 4159.9792001040405, 4163.084121493267, 4163.854265100767, 4164.708470407103, 4205.705600607928, 5670.659760414388, 5683.857903552362, 5738.0, 5815.767369305265, 5841.240638716939, 6017.789377371771, 6052.364501727343, 6097.817065488042, 6113.419225173601, 6142.9078563820685, 5798.971005144947, 5801.158831969341, 5807.68057756819, 5809.041508151107, 5815.680137592389, 5213.218017297359, 5247.2129180623215, 5298.8940221196135, 5324.680519168863, 5335.706536140549, 6207.689615519206, 6247.656378899204, 6265.154204182377, 6267.5299352548745, 6272.121902933502, 5887.61730487517, 6154.569180157346, 6156.015037593964, 6168.321484636686, 6181.81454556364, 6110.236220472441, 6147.600405973598, 6193.597416167935, 6204.286507051746, 6205.937940620536, 6029.668368239789, 6042.607230530001, 6043.486303664238, 6043.758249669964, 6109.419605137505, 5910.320313163869, 6016.007358785751, 6152.138700582012, 6155.261368635793, 6159.876802464015, 5985.132155837467, 6076.027835546468, 6119.0, 6129.724162412613, 6136.2943261523715, 5905.881882362414, 5930.0, 5944.73248703818, 5951.821445356646, 5965.970170149121, 5708.457696518824, 5753.1945527627, 5881.823545293648, 5888.116782482662, 5928.0, 5952.255968003999, 5992.8501787453915, 6002.159697642246, 6016.037434010537, 6056.424639659225, 5843.1235314703135, 5845.561582881216, 5847.707614619167, 5855.677937713466, 5907.143464197581], "unit": "ms", "name": "dojo.html", "value": 5596.638336511415}, {"lowerIsBetter": false, "replicates": [575.4331982996747, 611.0986295214557, 611.6269075863722, 620.2773768559626, 674.6356967237689, 31518.52722209166, 32642.67357326426, 40409.797951010274, 41058.178836423256, 41151.79424102875, 44088.338674919905, 44253.55746442534, 44365.7781711091, 44618.0, 44682.77658611711, 9011.234045106174, 9113.0886911309, 9124.954375228148, 9174.036726143759, 9174.724758257264, 8939.418937769024, 9014.414063085911, 9025.59384827681, 9059.592318345658, 9069.365144439858, 8897.73306800797, 8951.820963580725, 9002.684906028291, 9039.954800225989, 9054.456732596032, 8929.374943753939, 8996.595153218088, 9059.139381758723, 9065.818683626356, 9086.22767064797, 8903.465792052497, 9050.456972581665, 9083.18251357381, 9089.81820363589, 9132.0, 41161.1767764643, 41260.1747965039, 41444.79277603623, 41579.1684166318, 41630.375544366856, 3811.9809400953095, 3929.8035098244973, 4073.144639625682, 4211.115665710205, 4393.07745373472, 31329.530057049164, 31335.0, 31355.84322078398, 31577.684223157703, 32449.351012979845, 4374.496932852699, 4391.978040109779, 4400.44994375703, 4443.866683999453, 4479.73121612701, 270497.0, 271318.0, 271369.0, 271718.0, 384628.0, 50311.49688503141, 60468.39531604716, 61312.69343653253, 61338.69330653318, 61397.69301153555, 60944.0, 61006.0, 61240.387596123466, 61355.386446134966, 61452.0, 14427.278636068155, 14498.85501144975, 14543.0, 14555.563333100024, 14586.0, 11503.19477636574, 11687.065034797195, 11706.12204084697, 11711.004564611932, 11744.59064912216, 19731.309404170785, 19778.505537361394, 19968.70046949297, 20090.69863952042, 20133.899330503547, 7865.567393793396, 7937.523748575104, 8013.358931285483, 8087.959560202161, 8137.75586732399, 1020.4183615339185, 1083.544911137324, 1139.3448766958866, 1139.9968028135188, 1149.1725957310723, 29039.12882613525, 29338.413231735245, 29379.412411751644, 29805.552916706267, 30251.394972100436, 1070.0743856564172, 1125.4766533561933, 1139.1342579639368, 1152.3028567716578, 1213.3993673131679, 13465.259410732504, 14104.0, 14255.0, 14276.785848212285, 14391.496297629743, 337152.0, 343022.0, 343364.0, 343683.0, 354108.0, 48438.75780621074, 48693.75653121783, 49026.26460603094, 49046.75476622594, 49335.50664493381, 1418.2483283859572, 1425.2090089999942, 1428.3358238419185, 1432.5702289313165, 1443.9639009024859, 28305.15084547467, 28334.291642709097, 28575.857120715096, 28629.856850716445, 29235.7076429233, 45245.0, 45330.09339813119, 45532.089358213314, 45550.31674524819, 45766.542334576225, 272849.0, 273748.63125684246, 275243.0, 275451.0, 276423.0, 32434.35131297408, 32701.18247043843, 32751.836240818644, 33342.0, 33692.157696057795, 40230.597694023854, 40561.391579126925, 40872.79563602163, 40880.79559602183, 41448.171036579704, 36524.63475365318, 36889.815550922074, 37513.062173445884, 37603.81198093992, 37842.0, 36207.63792362042, 37461.250774983804, 38445.0, 38613.15531432289, 41427.37858932179, 37829.24341513209, 38072.42891356687, 38160.618393815705, 38247.42628860514, 38329.23341533098, 32853.342933140724, 32995.175120622174, 33202.0, 33348.1662958428, 33679.15802104967, 24548.386290342885, 25692.871535642204, 25962.480750385264, 26032.47935041251, 26139.738602613732], "unit": "ms", "name": "ext.html", "value": 19052.5959103977}, {"lowerIsBetter": false, "replicates": [388.5861557441325, 388.62109443292775, 390.4884601172464, 392.5015230657066, 396.37175077502155, 15937.203139843019, 17205.0, 17256.654866902685, 18903.621927561457, 18943.43169704911, 11714.121440891924, 12486.687832804162, 12919.677008074803, 17884.463466096004, 17914.37299694511, 4983.551480366767, 5227.73861306935, 5356.4107948125675, 5365.678059316453, 6187.81436556904, 5338.439463856297, 5443.863903402407, 5476.288082549263, 5482.671039737608, 6120.081987701836, 5422.024035673597, 5426.2674538937135, 5454.481824226692, 5502.779888804443, 5745.712714364265, 5633.436656334375, 5646.971765141148, 5669.036263835158, 5687.317521897378, 5690.174924635905, 5036.949630503685, 5136.306598609177, 5325.4142044375085, 5458.727063646802, 5468.781248750045, 13615.727685446236, 13729.176249425067, 13841.238731869744, 14010.36953337092, 14069.0, 2272.1593010586025, 2300.332903457995, 2306.1813056365086, 2344.3787396339985, 2485.8384205026796, 10682.412467314294, 10694.144468442506, 12392.008639308833, 12748.936255318664, 13590.77683008534, 1981.455099847539, 2008.1967213114872, 2022.9190832366687, 2024.98987505063, 2055.732754741889, 61651.0, 63044.36955630431, 63523.047154293185, 63975.68012159956, 64562.67718661424, 10890.61882834097, 11112.111031117653, 11149.665510034712, 11207.439628018567, 11282.210245282751, 14538.200398978157, 14571.0, 14578.489752858599, 14647.487337943334, 14671.486497972519, 7899.526028438312, 8003.599820008976, 8009.879851802228, 8026.558539280279, 8084.3936704747375, 7502.699892004368, 7531.849363012709, 7593.354564861938, 7599.506032107895, 7609.885851712229, 4653.95346046542, 4730.739809310521, 4740.620750339965, 4759.785809638505, 4824.469308376076, 1942.893140877237, 1994.7706013808597, 2068.917243310251, 2074.346580827035, 2078.7193728846714, 435.27092120698336, 469.93420921070395, 498.50896866586385, 926.9536523173814, 1119.781642579689, 11298.322100673822, 11661.0, 11780.88219117815, 11809.350485723196, 11990.400479975966, 487.22044728434224, 506.8428787076018, 515.885686916259, 519.0734538848138, 523.3510447045636, 6289.937100628935, 6400.679966001681, 6499.642519661369, 6521.380468855451, 6554.787364337612, 629087.0, 649346.0, 663108.0, 671321.0, 674796.0, 44550.88622784457, 83836.06573769888, 84647.0, 84941.0, 86377.13622863816, 524.3838489774499, 530.5755395683515, 533.2214966149465, 534.3801190618941, 536.0538649284017, 10787.460626968777, 10826.729331766768, 10929.672109836718, 11024.5038973248, 11163.944180279372, 34753.82623086868, 35313.823430883705, 36112.0, 36362.8181859089, 36547.45178822373, 50634.240486391995, 50842.0, 51410.48589514057, 51708.22437663513, 52950.762309422644, 9756.85364719544, 9825.85261221068, 10247.487625618838, 10314.690559283234, 10341.0, 16194.352225910832, 17074.743878842077, 17411.303547857944, 17458.039807810183, 17997.64004719872, 14621.268936553342, 14633.707325853637, 15126.621834453787, 15147.54557363281, 15209.467668631545, 14583.708325833211, 14784.556463306119, 15097.32062057232, 15133.924330378719, 15174.393024278905, 15631.0, 15927.0, 15992.200389980222, 16134.838651613334, 16294.0, 10467.738306542398, 10555.208359373231, 10607.893921060691, 10635.415052172204, 10660.0, 14795.630109246924, 14968.625784355043, 15523.146226957626, 15745.13401762914, 15833.208339583205], "unit": "ms", "name": "jquery.html", "value": 8546.404886029915}, {"lowerIsBetter": false, "replicates": [1559.3216950626477, 1611.1299898055051, 1647.0, 1832.7067669172927, 1913.1199648161844, 7926.326262267707, 8036.316913062396, 8139.593020348989, 8145.34837213023, 8193.139720329362, 7982.28159465648, 7983.08194557626, 8035.276825085741, 8093.797655058626, 8107.3919456040885, 2374.8693821839747, 2387.379281386843, 2411.0, 2413.4449076712367, 2414.8309618326725, 2394.1022116706235, 2406.5547873643345, 2423.321469988406, 2443.0472115874823, 2455.2020593307248, 2330.8601483910934, 2344.7069116360453, 2369.34842918198, 2379.167291447997, 2392.9282121536294, 2282.224043825091, 2341.5785158671433, 2369.668246445499, 2378.785909268157, 2388.581998150334, 2360.091364824538, 2379.3456799380137, 2384.78536931677, 2389.1279682915783, 2389.1518510928545, 7948.801279967989, 8047.919520804834, 8054.597270136528, 8077.313428358597, 8078.111407745143, 4889.828855990023, 4976.477469865648, 4992.975035124801, 5004.799808007675, 5009.5491405773655, 3116.0, 3133.514305282662, 3135.5923729915194, 3150.763692723055, 3166.6200055993427, 1074.355386767941, 1087.5595383869545, 1123.1239633086207, 1139.800534906388, 1145.770845830837, 10960.397178155199, 10962.890371096346, 11061.170412219115, 11116.0, 11140.999999999918, 4331.45856767904, 4376.102898905717, 4395.296752519582, 4407.823687052482, 4425.446819147606, 8974.14745599167, 9026.323025773094, 9045.638174473079, 9061.728148155566, 9067.183953444222, 4881.048195601824, 4883.438404583448, 4894.8042078317185, 4897.681650692693, 4917.188663870421, 4510.75190864499, 4525.683202175882, 4535.7732113394195, 4545.749983750926, 4572.542745725467, 3555.5377800886235, 3595.2270261893295, 3615.9819200903826, 3637.2907283079544, 3637.690796282293, 1099.1042300525046, 1100.6147848253208, 1105.3754628634795, 1117.6423544465692, 1175.6002958993984, 1068.0494360019588, 1091.1052936591918, 1098.6319582939645, 1237.7710123627157, 1339.6583871112998, 7548.056492938383, 7566.0, 7605.049368828896, 7646.044244469442, 7663.271989161132, 1053.4627340056472, 1056.6354607660344, 1089.4988305379613, 1126.3748619516084, 1162.4710756605723, 5797.420257974169, 5803.071508558611, 5819.53443724501, 5843.918875008138, 5854.034084376115, 9547.093026162504, 9653.855192172123, 9856.605735770489, 9904.900950990543, 9999.650012249536, 9721.368111072758, 9772.21822254218, 9782.657606983721, 9785.412875227508, 9883.209343252522, 7559.28186822251, 7652.426068044919, 7685.500442471333, 7699.769006929801, 7709.036370453693, 7256.310650488195, 7295.854082918206, 7329.74345897891, 7339.9633001834645, 7353.301436363537, 8020.558869262247, 8113.959430202811, 8298.58507074656, 8358.62386192635, 8432.45189062709, 8152.307053900485, 8173.305269052197, 8180.46826956246, 8215.219554142346, 8232.958835205785, 7037.0, 7074.540154889915, 7085.14978202619, 7087.964560177166, 7103.467239957127, 7480.326770590673, 7508.474406791473, 7519.812004699707, 7527.096748390009, 7527.3601743850195, 7008.404285635778, 7093.255208203064, 7177.102862142232, 7217.855642887008, 7326.853462930818, 6980.720771169096, 7221.4222862171955, 7282.6722797473185, 7283.672234749343, 7301.963490182515, 7225.494215404871, 7292.781216563511, 7303.160136584361, 7305.050343455317, 7335.303146201102, 6409.519286053658, 6424.2933277338525, 6437.452816510649, 6455.354464553507, 6459.483241340776, 6643.667816609053, 6751.122354094133, 6783.694733736895, 6784.3894049535775, 6791.864162716817], "unit": "ms", "name": "mootools.html", "value": 4620.384786518769}, {"lowerIsBetter": false, "replicates": [357.43168362303936, 368.08163631738813, 369.254106704457, 371.10008230042143, 372.80614080678066, 6358.332375100617, 6367.0, 6403.903941440876, 6487.545871788977, 6492.480601551876, 6237.0, 6362.618242905429, 6380.4895608351335, 6411.390917862807, 6423.0, 4937.407511098673, 4960.25596160577, 4961.652684312099, 4962.578180854632, 4975.626827987898, 4942.209246520558, 4956.40523137224, 4962.660081777918, 4967.279744437054, 4968.801247950078, 4672.948586568029, 4897.338859254009, 4904.656674032802, 4915.9754201229125, 4916.43461001984, 4877.975625118729, 4882.584980276681, 4895.898422854865, 4896.926546101811, 4898.510148985109, 4283.014906571475, 4283.057727299989, 4284.207421627009, 4288.485381754178, 4305.913881722379, 5907.970460147715, 6032.849178770522, 6055.0, 6060.636361818261, 6079.118527813486, 5667.688277144755, 5679.318481782213, 5680.488756011979, 5694.914576281359, 5695.77216911323, 6747.831304217385, 6750.662466876685, 6762.594244345355, 6763.120794296759, 6776.525643204977, 4702.929456058162, 4707.176244157293, 4724.889650932063, 4739.9526004739855, 4755.595774359183, 6919.6886140123315, 6985.091938048072, 7050.29497050296, 7064.964675176642, 7066.681999309992, 4831.758412079382, 4849.4908034656555, 4850.296706977539, 4864.489228631013, 4872.342233798463, 4879.780409881564, 4888.340074089952, 4908.631852611068, 4908.828191013297, 4914.36113305268, 5453.890922181534, 5651.2935883014625, 5657.830265092054, 5667.404922483162, 5687.857803554862, 6771.695273712695, 6790.083338749305, 6825.215100263434, 6873.965630171817, 6882.174139103339, 1689.4255952976048, 1739.6433731085096, 1743.8692098092695, 1745.3280487012337, 1750.063715911981, 1148.2593727046008, 1165.7143999720122, 1180.0500597019482, 1180.4333919718583, 1191.184038933316, 6533.934660653333, 6537.509686773511, 6546.639934803537, 6551.344865513506, 6612.768553100618, 6969.30306969299, 6981.441484681213, 7002.544834585736, 7009.509334346547, 7012.474064445187, 6465.77369792055, 6536.411722944958, 6561.967190164114, 6565.179352580927, 6573.605583664996, 3761.7366784324836, 3806.3719486284454, 3813.3517302058717, 3813.523309586302, 3814.7901865397116, 7156.499045066899, 7178.676959536833, 7238.92761072393, 7240.493165478471, 7250.383717383976, 7071.964640176869, 7193.820154496075, 7193.9280607194305, 7195.532290401107, 7319.597422141726, 7317.573073250772, 7339.926600733925, 7354.448416368687, 7358.374538164209, 7358.521696089737, 7109.573425594481, 7115.181754098345, 7122.145342558926, 7127.180374256819, 7134.714611415485, 6893.20728116273, 6951.165860096618, 6992.1259842519685, 7022.859542809218, 7026.402755765817, 7324.926750732425, 7329.963350183215, 7331.193568707545, 7336.853262934818, 7344.449166312441, 4789.4971028041555, 4873.537013983666, 4885.047415753894, 4890.193118135468, 4892.4373697023875, 6914.51598388108, 7005.22942476317, 7069.293070693096, 7086.645667716697, 7096.432285417051, 6882.03651488782, 6897.103376561015, 6902.033715279765, 6906.654667266516, 6944.4097251734165, 6876.415504682158, 6900.689468974008, 6904.896426553505, 6910.378065974087, 6910.896336555056, 6683.598984060972, 6768.424683901923, 6786.966065169642, 6794.694238759169, 6812.829679258059, 6932.965335173292, 6949.930500694928, 6953.374196322356, 6953.721851125898, 6965.651717414008, 6565.113709649137, 6687.966560167168, 6732.980105968288, 6734.4275736560985, 6777.45780337562], "unit": "ms", "name": "prototype.html", "value": 5155.816849428759}, {"lowerIsBetter": false, "replicates": [838.6477679374663, 912.968046118386, 917.80146190526, 922.5341202692636, 924.2975338742554, 14228.0, 14522.709545809077, 14523.636909077279, 14601.780973285382, 15179.241037948086, 13709.725805483884, 13819.51631692891, 13822.170669759822, 13832.585022449342, 13918.791218131737, 873.4933738431711, 906.1527471813876, 907.6188001039546, 909.2226146644623, 910.7085732565581, 891.7191084808297, 901.625825282507, 904.1184844776324, 906.084854297158, 906.4063038709655, 955.5461155950902, 958.8178246133248, 959.6113574002541, 962.8363178259677, 964.5755867418349, 936.3539157981039, 938.6104766521885, 944.9527523623791, 947.4268067818973, 948.2840455456155, 692.2731132311053, 693.9063226464414, 695.5756988237172, 703.7888633409957, 714.8963400306926, 14603.561893143222, 14750.852491475056, 14816.481423150139, 14828.406863725439, 14833.110013399122, 12555.183913045623, 12701.110922235448, 12861.80707289382, 12885.806712899313, 13466.528671496451, 11192.328460292327, 11278.323300601991, 11573.594924177698, 11981.64055078349, 12326.0, 3631.0, 3654.7624404413627, 3880.3209438348176, 3905.7461265017682, 3909.8240579174008, 48641.0, 48871.75564122156, 48913.51086489125, 49069.01861962741, 49278.7536062321, 10526.105281051043, 10664.093552048163, 10729.78540429187, 10827.404492752974, 10837.0, 18246.270149194148, 18253.0, 18332.816671833112, 18361.81638183601, 18384.0, 7808.7657370278985, 7829.686812527549, 7882.645280962256, 8259.256666900008, 8395.412321137463, 4374.518802931675, 4377.255866502638, 4400.273954797422, 4419.756913369795, 4551.544845515422, 3270.296886169485, 3277.3772983133126, 3317.004898530431, 3317.867285308609, 3322.8670853166086, 581.3517927510795, 587.9500242479352, 590.9438603332677, 592.1384385718769, 600.8888355654218, 622.4460230394952, 689.1144878830779, 689.3726708695064, 714.953528020677, 717.1895757793764, 8671.56642167889, 8739.126087391338, 8806.647734090693, 8844.204021638083, 8928.0, 652.4323838260743, 654.2051407539861, 662.8409181796334, 685.8971154326891, 707.1514182980444, 3854.5567259765485, 4222.218889505451, 4224.155168966219, 4328.8484903028875, 4358.716683415568, 59751.402485974584, 60008.69995650081, 60060.69969650124, 60304.0, 61264.0, 49282.0, 49474.25788613102, 50136.247956280684, 50233.497665022885, 53135.0, 49261.0, 49363.0, 50010.24943628135, 50643.74678126659, 51625.741871290404, 8159.144299495129, 8357.623906924324, 8388.496690198608, 8410.495370277802, 8596.183362580545, 36114.45828312525, 36286.63713362833, 36612.26775464423, 36708.81645591755, 37234.62765372312, 47116.0, 48616.5138348612, 49000.2649960258, 49508.0, 49607.0, 10703.143748500257, 11056.004959553678, 11314.717132071764, 11648.475818588015, 12074.879251207727, 12468.875311246771, 12614.621561353175, 12758.362081896053, 12958.611241662766, 12990.935045324713, 10772.0, 10947.616833410792, 10989.285696429706, 11021.393823339793, 11234.382108984084, 11700.0, 11825.467853946766, 11869.347185904859, 11942.582009629621, 12185.878141218474, 10068.899311006797, 10286.2799604027, 10372.844407333745, 11144.275622084539, 11319.09447244235, 9987.350822196535, 10177.694669159937, 10339.586416543554, 10481.842772358268, 10881.075108615856, 8438.156184381513, 8681.652733890825, 9232.169104780602, 9371.02113572693, 9867.851982220129], "unit": "ms", "name": "yui.html", "value": 6639.845558170019}], "name": "dromaeo_css", "value": 7241.117165446978}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 105.0, 109.0, 110.0, 109.0, 120.0, 110.0, 109.0, 110.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 110.4}, {"lowerIsBetter": true, "replicates": [152.0, 126.0, 151.0, 158.0, 125.0, 153.0, 151.0, 127.0, 156.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.3}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 160.0, 162.0, 161.0, 160.0, 162.0, 161.0, 163.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 158.0, 73.0, 74.0, 73.0, 74.0, 160.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 90.2}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 133.0, 93.0, 92.0, 92.0, 136.0, 91.0, 92.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 104.9}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 111.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [60.0, 61.0, 62.0, 60.0, 60.0, 59.0, 58.0, 62.0, 64.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 60.3}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 66.0, 66.0, 65.0, 66.0, 64.0, 65.0, 66.0, 66.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.3}, {"lowerIsBetter": true, "replicates": [79.0, 89.0, 90.0, 89.0, 83.0, 89.0, 82.0, 82.0, 88.0, 80.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [115.0, 122.0, 121.0, 128.0, 122.0, 132.0, 127.0, 116.0, 114.0, 119.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.6}, {"lowerIsBetter": true, "replicates": [144.0, 148.0, 155.0, 147.0, 151.0, 136.0, 146.0, 150.0, 137.0, 146.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.0}, {"lowerIsBetter": true, "replicates": [73.0, 68.0, 69.0, 68.0, 69.0, 66.0, 69.0, 71.0, 68.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1508.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.17665407978984], "unit": "score", "name": "Richards", "value": 215.02448200000006}, {"lowerIsBetter": false, "replicates": [172.95053614666205], "unit": "score", "name": "DeltaBlue", "value": 382.29427599999997}, {"lowerIsBetter": false, "replicates": [278.473962684489], "unit": "score", "name": "Encrypt", "value": 955.8559709999997}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [903.342366757001], "unit": "score", "name": "RayTrace", "value": 819.1678230000001}, {"lowerIsBetter": false, "replicates": [554.016620498615], "unit": "score", "name": "Earley", "value": 1202.9657150000005}, {"lowerIsBetter": false, "replicates": [11131.868131868132], "unit": "score", "name": "Boyer", "value": 59.869825271470894}, {"lowerIsBetter": false, "replicates": [23767.441860465115], "unit": "score", "name": "RegExp", "value": 38.329114481408986}, {"lowerIsBetter": false, "replicates": [529.6610169491526], "unit": "score", "name": "Splay", "value": 153.85500800000003}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 23199.49078502482}]} 08:07:19 INFO - RETURN: dromaeo_css: 7241.12 08:07:19 INFO - RETURN: kraken: 1508.90 08:07:19 INFO - RETURN: v8_7: 23199.49 08:07:19 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23199.49"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1508.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7241.12"}}} 08:07:19 INFO - Return code: 0 08:07:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:07:19 INFO - # TBPL SUCCESS # 08:07:19 INFO - Running post-action listener: _resource_record_post_action 08:07:19 INFO - Running post-run listener: _resource_record_post_run 08:07:20 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 262144; Write bytes: 504770560; Read time: 20; Write time: 406560 08:07:20 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 237203456; Read time: 0; Write time: 239000 08:07:20 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 262144; Write bytes: 267567104; Read time: 20; Write time: 167560 08:07:20 INFO - Running post-run listener: _upload_blobber_files 08:07:20 INFO - Blob upload gear active. 08:07:20 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:07:20 INFO - Copying logs to upload dir... 08:07:20 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1263.457902 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-21 08:07:19.939209) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-21 08:07:19.942946) ========= 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=0274524eba3bdaad075c2247000001d4-1453390492.223816-1062301691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010143 build_url: 'https://queue.taskcluster.net/v1/task/iwA-FAeNRTmYVxvgr1rX8Q/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-21 08:07:19.994321) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 08:07:19.994651) ========= 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=0274524eba3bdaad075c2247000001d4-1453390492.223816-1062301691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 08:07:20.044598) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 08:07:20.044910) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 08:07:20.045289) ========= ========= Total master_lag: 0.28 =========