builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-021 starttime: 1453482163.1 results: success (0) buildid: 20160122063728 builduid: 7b04268e85d7456c9ccc5f589136c755 revision: 0ce166f4fec610dd1b3a99f348f19811c571b51b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 09:02:43.104568) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 09:02:43.105046) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 09:02:43.105337) ========= 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=df17445c3590ff7897617a0e00000225-1453482162.836543-559619016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006249 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 09:02:43.127750) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 09:02:43.128019) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 09:02:43.140984) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:02:43.141243) ========= 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=df17445c3590ff7897617a0e00000225-1453482162.836543-559619016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004586 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:02:43.191023) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 09:02:43.191427) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 09:02:43.191802) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:02:43.192086) ========= 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=df17445c3590ff7897617a0e00000225-1453482162.836543-559619016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-22 09:02:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 62.9M=0s 2016-01-22 09:02:44 (62.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157422 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:02:43.362045) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:02:43.362411) ========= 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=df17445c3590ff7897617a0e00000225-1453482162.836543-559619016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016088 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:02:43.411542) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:02:43.411897) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0ce166f4fec610dd1b3a99f348f19811c571b51b --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 0ce166f4fec610dd1b3a99f348f19811c571b51b --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=df17445c3590ff7897617a0e00000225-1453482162.836543-559619016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-22 09:02:44,172 truncating revision to first 12 chars 2016-01-22 09:02:44,172 Setting DEBUG logging. 2016-01-22 09:02:44,172 attempt 1/10 2016-01-22 09:02:44,172 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0ce166f4fec6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-22 09:02:44,434 unpacking tar archive at: mozilla-aurora-0ce166f4fec6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.569977 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:02:43.994571) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 09:02:43.994916) ========= echo 0ce166f4fec610dd1b3a99f348f19811c571b51b in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'0ce166f4fec610dd1b3a99f348f19811c571b51b'] 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=df17445c3590ff7897617a0e00000225-1453482162.836543-559619016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 0ce166f4fec610dd1b3a99f348f19811c571b51b program finished with exit code 0 elapsedTime=0.004531 script_repo_revision: '0ce166f4fec610dd1b3a99f348f19811c571b51b' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 09:02:44.043891) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 09:02:44.044191) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 09:02:44.053947) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-22 09:02:44.054223) ========= /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=df17445c3590ff7897617a0e00000225-1453482162.836543-559619016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:02:44 INFO - MultiFileLogger online at 20160122 09:02:44 in /builds/slave/test-pgo 09:02:44 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 09:02:44 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:02:44 INFO - {'append_to_log': False, 09:02:44 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:02:44 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:02:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:02:44 INFO - 'branch': 'Mozilla-Aurora', 09:02:44 INFO - 'buildbot_json_path': 'buildprops.json', 09:02:44 INFO - 'config_files': ('talos/linux_config.py',), 09:02:44 INFO - 'default_actions': ('clobber', 09:02:44 INFO - 'read-buildbot-config', 09:02:44 INFO - 'download-and-extract', 09:02:44 INFO - 'populate-webroot', 09:02:44 INFO - 'create-virtualenv', 09:02:44 INFO - 'install', 09:02:44 INFO - 'run-tests'), 09:02:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:02:44 INFO - 'download_minidump_stackwalk': True, 09:02:44 INFO - 'download_symbols': 'ondemand', 09:02:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:02:44 INFO - 'tooltool.py': '/tools/tooltool.py', 09:02:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:02:44 INFO - '/tools/misc-python/virtualenv.py')}, 09:02:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:02:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:02:44 INFO - 'installer_path': 'installer.exe', 09:02:44 INFO - 'log_level': 'info', 09:02:44 INFO - 'log_name': 'talos', 09:02:44 INFO - 'log_to_console': True, 09:02:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:02:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:02:44 INFO - 'opt_config_files': (), 09:02:44 INFO - 'pip_index': False, 09:02:44 INFO - 'sps_profile': False, 09:02:44 INFO - 'sps_profile_interval': 0, 09:02:44 INFO - 'suite': 'dromaeojs-e10s', 09:02:44 INFO - 'system_bits': '32', 09:02:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:02:44 INFO - 'title': 'talos-linux64-ix-021', 09:02:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:02:44 INFO - 'use_talos_json': True, 09:02:44 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:02:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:02:44 INFO - 'work_dir': 'build'} 09:02:44 INFO - ##### 09:02:44 INFO - ##### Running clobber step. 09:02:44 INFO - ##### 09:02:44 INFO - Running pre-action listener: _resource_record_pre_action 09:02:44 INFO - Running main action method: clobber 09:02:44 INFO - rmtree: /builds/slave/test-pgo/build 09:02:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:02:45 INFO - Running post-action listener: _resource_record_post_action 09:02:45 INFO - ##### 09:02:45 INFO - ##### Running read-buildbot-config step. 09:02:45 INFO - ##### 09:02:45 INFO - Running pre-action listener: _resource_record_pre_action 09:02:45 INFO - Running main action method: read_buildbot_config 09:02:45 INFO - Using buildbot properties: 09:02:45 INFO - { 09:02:45 INFO - "properties": { 09:02:45 INFO - "buildnumber": 101, 09:02:45 INFO - "product": "firefox", 09:02:45 INFO - "script_repo_revision": "production", 09:02:45 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:02:45 INFO - "repository": "", 09:02:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:02:45 INFO - "buildid": "20160122063728", 09:02:45 INFO - "slavename": "talos-linux64-ix-021", 09:02:45 INFO - "pgo_build": "True", 09:02:45 INFO - "basedir": "/builds/slave/test-pgo", 09:02:45 INFO - "project": "", 09:02:45 INFO - "platform": "ubuntu64_hw", 09:02:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:02:45 INFO - "slavebuilddir": "test", 09:02:45 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:02:45 INFO - "branch": "mozilla-aurora", 09:02:45 INFO - "repo_path": "releases/mozilla-aurora", 09:02:45 INFO - "stage_platform": "linux64-pgo", 09:02:45 INFO - "builduid": "7b04268e85d7456c9ccc5f589136c755", 09:02:45 INFO - "revision": "0ce166f4fec610dd1b3a99f348f19811c571b51b" 09:02:45 INFO - }, 09:02:45 INFO - "sourcestamp": { 09:02:45 INFO - "repository": "", 09:02:45 INFO - "hasPatch": false, 09:02:45 INFO - "project": "", 09:02:45 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 09:02:45 INFO - "changes": [ 09:02:45 INFO - { 09:02:45 INFO - "category": null, 09:02:45 INFO - "files": [ 09:02:45 INFO - { 09:02:45 INFO - "url": null, 09:02:45 INFO - "name": "https://queue.taskcluster.net/v1/task/bUODrfdIQQynOXWD0dtxhg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 09:02:45 INFO - } 09:02:45 INFO - ], 09:02:45 INFO - "repository": "", 09:02:45 INFO - "rev": "0ce166f4fec610dd1b3a99f348f19811c571b51b", 09:02:45 INFO - "who": "mconley@mozilla.com", 09:02:45 INFO - "when": 1453481905, 09:02:45 INFO - "number": 7501312, 09:02:45 INFO - "comments": "Bug 1238180 - Avoid unsafe CPOWs when opening Page / Frame / Image Info from the context menu. r=florian, a=sledru", 09:02:45 INFO - "project": "", 09:02:45 INFO - "at": "Fri 22 Jan 2016 08:58:25", 09:02:45 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 09:02:45 INFO - "revlink": "", 09:02:45 INFO - "properties": [ 09:02:45 INFO - [ 09:02:45 INFO - "buildid", 09:02:45 INFO - "20160122063728", 09:02:45 INFO - "Change" 09:02:45 INFO - ], 09:02:45 INFO - [ 09:02:45 INFO - "builduid", 09:02:45 INFO - "7b04268e85d7456c9ccc5f589136c755", 09:02:45 INFO - "Change" 09:02:45 INFO - ], 09:02:45 INFO - [ 09:02:45 INFO - "pgo_build", 09:02:45 INFO - "True", 09:02:45 INFO - "Change" 09:02:45 INFO - ] 09:02:45 INFO - ], 09:02:45 INFO - "revision": "0ce166f4fec610dd1b3a99f348f19811c571b51b" 09:02:45 INFO - } 09:02:45 INFO - ], 09:02:45 INFO - "revision": "0ce166f4fec610dd1b3a99f348f19811c571b51b" 09:02:45 INFO - } 09:02:45 INFO - } 09:02:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/bUODrfdIQQynOXWD0dtxhg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 09:02:45 INFO - Running post-action listener: _resource_record_post_action 09:02:45 INFO - ##### 09:02:45 INFO - ##### Running download-and-extract step. 09:02:45 INFO - ##### 09:02:45 INFO - Running pre-action listener: _resource_record_pre_action 09:02:45 INFO - Running main action method: download_and_extract 09:02:45 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:02:45 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')]} 09:02:45 INFO - https://queue.taskcluster.net/v1/task/bUODrfdIQQynOXWD0dtxhg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:02:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUODrfdIQQynOXWD0dtxhg/artifacts/public/build/test_packages.json 09:02:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUODrfdIQQynOXWD0dtxhg/artifacts/public/build/test_packages.json 09:02:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUODrfdIQQynOXWD0dtxhg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:02:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUODrfdIQQynOXWD0dtxhg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:02:46 INFO - Downloaded 1302 bytes. 09:02:46 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:02:46 INFO - Using the following test package requirements: 09:02:46 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 09:02:46 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:02:46 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:02:46 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:02:46 INFO - u'jsshell-linux-x86_64.zip'], 09:02:46 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:02:46 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:02:46 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 09:02:46 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:02:46 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:02:46 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:02:46 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:02:46 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:02:46 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:02:46 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 09:02:46 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:02:46 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:02:46 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:46 INFO - https://queue.taskcluster.net/v1/task/bUODrfdIQQynOXWD0dtxhg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:02:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUODrfdIQQynOXWD0dtxhg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:02:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUODrfdIQQynOXWD0dtxhg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:02:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUODrfdIQQynOXWD0dtxhg/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 09:02:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUODrfdIQQynOXWD0dtxhg/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 09:02:48 INFO - Downloaded 23159892 bytes. 09:02:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 09:02:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:02:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:02:49 INFO - Return code: 0 09:02:49 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 09:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:49 INFO - https://queue.taskcluster.net/v1/task/bUODrfdIQQynOXWD0dtxhg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:02:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUODrfdIQQynOXWD0dtxhg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:02:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUODrfdIQQynOXWD0dtxhg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:02:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUODrfdIQQynOXWD0dtxhg/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 09:02:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUODrfdIQQynOXWD0dtxhg/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 09:02:50 INFO - Downloaded 23159892 bytes. 09:02:50 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 09:02:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:02:50 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 09:02:52 INFO - Return code: 0 09:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:52 INFO - https://queue.taskcluster.net/v1/task/bUODrfdIQQynOXWD0dtxhg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:02:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUODrfdIQQynOXWD0dtxhg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:02:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUODrfdIQQynOXWD0dtxhg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:02:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUODrfdIQQynOXWD0dtxhg/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 09:02:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUODrfdIQQynOXWD0dtxhg/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 09:02:53 INFO - Downloaded 11132038 bytes. 09:02:53 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 09:02:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:02:53 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 09:02:53 INFO - Return code: 0 09:02: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')]} 09:02:53 INFO - https://queue.taskcluster.net/v1/task/bUODrfdIQQynOXWD0dtxhg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:02:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUODrfdIQQynOXWD0dtxhg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:02:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUODrfdIQQynOXWD0dtxhg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:02:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUODrfdIQQynOXWD0dtxhg/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 09:02:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUODrfdIQQynOXWD0dtxhg/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 09:02:54 INFO - Downloaded 58170318 bytes. 09:02:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bUODrfdIQQynOXWD0dtxhg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:02:54 INFO - mkdir: /builds/slave/test-pgo/properties 09:02:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:02:54 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:02:54 INFO - Contents: 09:02:54 INFO - build_url:https://queue.taskcluster.net/v1/task/bUODrfdIQQynOXWD0dtxhg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:02:54 INFO - Running post-action listener: _resource_record_post_action 09:02:54 INFO - Running post-action listener: set_extra_try_arguments 09:02:54 INFO - ##### 09:02:54 INFO - ##### Running populate-webroot step. 09:02:54 INFO - ##### 09:02:54 INFO - Running pre-action listener: _resource_record_pre_action 09:02:54 INFO - Running main action method: populate_webroot 09:02:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:02:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:02:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:02:54 INFO - '--tppagecycles', 09:02:54 INFO - '7'], 09:02:54 INFO - 'tests': ['tsvgm']}}, 09:02:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:02:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:02:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:02:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:02:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:02:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:02:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:02:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:54 INFO - 'talos_options': ['--e10s'], 09:02:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:02:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:54 INFO - 'tests': ['damp', 'tps']}, 09:02:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:54 INFO - 'talos_options': ['--e10s'], 09:02:54 INFO - 'tests': ['damp', 'tps']}, 09:02:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:02:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:02:54 INFO - 'other': {'tests': ['a11yr', 09:02:54 INFO - 'ts_paint', 09:02:54 INFO - 'tpaint', 09:02:54 INFO - 'sessionrestore', 09:02:54 INFO - 'sessionrestore_no_auto_restore']}, 09:02:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:02:54 INFO - 'tests': ['a11yr', 09:02:54 INFO - 'ts_paint', 09:02:54 INFO - 'tpaint', 09:02:54 INFO - 'sessionrestore', 09:02:54 INFO - 'sessionrestore_no_auto_restore']}, 09:02:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:02:54 INFO - 'tests': ['a11yr', 09:02:54 INFO - 'ts_paint', 09:02:54 INFO - 'tpaint', 09:02:54 INFO - 'sessionrestore', 09:02:54 INFO - 'sessionrestore_no_auto_restore']}, 09:02:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:02:54 INFO - 'tests': ['a11yr', 09:02:54 INFO - 'ts_paint', 09:02:54 INFO - 'tpaint', 09:02:54 INFO - 'sessionrestore', 09:02:54 INFO - 'sessionrestore_no_auto_restore']}, 09:02:54 INFO - 'other_l64': {'tests': ['a11yr', 09:02:54 INFO - 'ts_paint', 09:02:54 INFO - 'tpaint', 09:02:54 INFO - 'sessionrestore', 09:02:54 INFO - 'sessionrestore_no_auto_restore']}, 09:02:54 INFO - 'other_nol64': {'tests': ['a11yr', 09:02:54 INFO - 'ts_paint', 09:02:54 INFO - 'tpaint', 09:02:54 INFO - 'sessionrestore', 09:02:54 INFO - 'sessionrestore_no_auto_restore']}, 09:02:54 INFO - 'svgr': {'tests': ['tsvgx', 09:02:54 INFO - 'tsvgr_opacity', 09:02:54 INFO - 'tart', 09:02:54 INFO - 'tscrollx', 09:02:54 INFO - 'cart']}, 09:02:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:02:54 INFO - 'tests': ['tsvgx', 09:02:54 INFO - 'tsvgr_opacity', 09:02:54 INFO - 'tart', 09:02:54 INFO - 'tscrollx', 09:02:54 INFO - 'cart']}, 09:02:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:54 INFO - 'tests': ['tp5o']}, 09:02:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:54 INFO - 'talos_options': ['--e10s'], 09:02:54 INFO - 'tests': ['tp5o']}, 09:02:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:54 INFO - 'talos_options': ['--xperf_path', 09:02:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:02:54 INFO - 'tests': ['tp5n']}, 09:02:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:54 INFO - 'talos_options': ['--e10s', 09:02:54 INFO - '--xperf_path', 09:02:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:02:54 INFO - 'tests': ['tp5n']}}, 09:02:54 INFO - 'talos.zip': {'path': '', 09:02:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:02:54 INFO - Running post-action listener: _resource_record_post_action 09:02:54 INFO - ##### 09:02:54 INFO - ##### Running create-virtualenv step. 09:02:54 INFO - ##### 09:02:54 INFO - Running pre-action listener: _resource_record_pre_action 09:02:54 INFO - Running main action method: create_virtualenv 09:02:54 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:02:54 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 09:02:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:02:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:02:54 INFO - Using real prefix '/usr' 09:02:54 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:02:55 INFO - Installing distribute.............................................................................................................................................................................................done. 09:02:57 INFO - Installing pip.................done. 09:02:57 INFO - Return code: 0 09:02:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:02:57 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')]} 09:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:57 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')]} 09:02:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:57 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 0x7fad30d05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdea50>, '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 0x1b4a550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a9e0>, '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': 'df17445c3590ff7897617a0e00000225-1453482162.836543-559619016', '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 09:02:57 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 09:02:57 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 09:02:57 INFO - Using env: {'DISPLAY': ':0', 09:02:57 INFO - 'HOME': '/home/cltbld', 09:02:57 INFO - 'LANG': 'en_US.UTF-8', 09:02:57 INFO - 'LANGUAGE': 'en_US:en', 09:02:57 INFO - 'LOGNAME': 'cltbld', 09:02:57 INFO - 'MAIL': '/var/mail/cltbld', 09:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:57 INFO - 'MOZ_NO_REMOTE': '1', 09:02:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:57 INFO - 'NO_EM_RESTART': '1', 09:02:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:02:57 INFO - 'PWD': '/builds/slave/test-pgo', 09:02:57 INFO - 'SHELL': '/bin/bash', 09:02:57 INFO - 'SHLVL': '1', 09:02:57 INFO - 'TERM': 'linux', 09:02:57 INFO - 'TMOUT': '86400', 09:02:57 INFO - 'USER': 'cltbld', 09:02:57 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1453482162.836543-559619016', 09:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:57 INFO - '_': '/tools/buildbot/bin/python'} 09:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:57 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 09:02:57 INFO - Cleaning up... 09:02:57 INFO - Return code: 0 09:02:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:02:57 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')]} 09:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:57 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')]} 09:02:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:57 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 0x7fad30d05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdea50>, '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 0x1b4a550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a9e0>, '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': 'df17445c3590ff7897617a0e00000225-1453482162.836543-559619016', '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 09:02:57 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 09:02:57 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 09:02:57 INFO - Using env: {'DISPLAY': ':0', 09:02:57 INFO - 'HOME': '/home/cltbld', 09:02:57 INFO - 'LANG': 'en_US.UTF-8', 09:02:57 INFO - 'LANGUAGE': 'en_US:en', 09:02:57 INFO - 'LOGNAME': 'cltbld', 09:02:57 INFO - 'MAIL': '/var/mail/cltbld', 09:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:57 INFO - 'MOZ_NO_REMOTE': '1', 09:02:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:57 INFO - 'NO_EM_RESTART': '1', 09:02:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:02:57 INFO - 'PWD': '/builds/slave/test-pgo', 09:02:57 INFO - 'SHELL': '/bin/bash', 09:02:57 INFO - 'SHLVL': '1', 09:02:57 INFO - 'TERM': 'linux', 09:02:57 INFO - 'TMOUT': '86400', 09:02:57 INFO - 'USER': 'cltbld', 09:02:57 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1453482162.836543-559619016', 09:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:57 INFO - '_': '/tools/buildbot/bin/python'} 09:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:57 INFO - Downloading/unpacking psutil>=0.7.1 09:02:57 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 09:02:57 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 09:02:57 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 09:02:57 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 09:02:57 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 09:02:57 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 09:02:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:02:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:02:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:02:59 INFO - Installing collected packages: psutil 09:02:59 INFO - Running setup.py install for psutil 09:02:59 INFO - building 'psutil._psutil_linux' extension 09:02:59 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 09:02:59 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 09:02:59 INFO - building 'psutil._psutil_posix' extension 09:02:59 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 09:03:00 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 09:03:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:03:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:03:00 INFO - Successfully installed psutil 09:03:00 INFO - Cleaning up... 09:03:00 INFO - Return code: 0 09:03:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:03:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fad30d05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdea50>, '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 0x1b4a550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a9e0>, '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': 'df17445c3590ff7897617a0e00000225-1453482162.836543-559619016', '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 09:03:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 09:03:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:03:00 INFO - Using env: {'DISPLAY': ':0', 09:03:00 INFO - 'HOME': '/home/cltbld', 09:03:00 INFO - 'LANG': 'en_US.UTF-8', 09:03:00 INFO - 'LANGUAGE': 'en_US:en', 09:03:00 INFO - 'LOGNAME': 'cltbld', 09:03:00 INFO - 'MAIL': '/var/mail/cltbld', 09:03:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:00 INFO - 'MOZ_NO_REMOTE': '1', 09:03:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:00 INFO - 'NO_EM_RESTART': '1', 09:03:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:03:00 INFO - 'PWD': '/builds/slave/test-pgo', 09:03:00 INFO - 'SHELL': '/bin/bash', 09:03:00 INFO - 'SHLVL': '1', 09:03:00 INFO - 'TERM': 'linux', 09:03:00 INFO - 'TMOUT': '86400', 09:03:00 INFO - 'USER': 'cltbld', 09:03:00 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1453482162.836543-559619016', 09:03:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:00 INFO - '_': '/tools/buildbot/bin/python'} 09:03:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:03:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:03:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:03:02 INFO - Installing collected packages: mozsystemmonitor 09:03:02 INFO - Running setup.py install for mozsystemmonitor 09:03:02 INFO - Successfully installed mozsystemmonitor 09:03:02 INFO - Cleaning up... 09:03:02 INFO - Return code: 0 09:03:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:03:02 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')]} 09:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:02 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')]} 09:03:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:02 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 0x7fad30d05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdea50>, '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 0x1b4a550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a9e0>, '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': 'df17445c3590ff7897617a0e00000225-1453482162.836543-559619016', '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 09:03:02 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 09:03:02 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 09:03:02 INFO - Using env: {'DISPLAY': ':0', 09:03:02 INFO - 'HOME': '/home/cltbld', 09:03:02 INFO - 'LANG': 'en_US.UTF-8', 09:03:02 INFO - 'LANGUAGE': 'en_US:en', 09:03:02 INFO - 'LOGNAME': 'cltbld', 09:03:02 INFO - 'MAIL': '/var/mail/cltbld', 09:03:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:02 INFO - 'MOZ_NO_REMOTE': '1', 09:03:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:02 INFO - 'NO_EM_RESTART': '1', 09:03:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:03:02 INFO - 'PWD': '/builds/slave/test-pgo', 09:03:02 INFO - 'SHELL': '/bin/bash', 09:03:02 INFO - 'SHLVL': '1', 09:03:02 INFO - 'TERM': 'linux', 09:03:02 INFO - 'TMOUT': '86400', 09:03:02 INFO - 'USER': 'cltbld', 09:03:02 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1453482162.836543-559619016', 09:03:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:02 INFO - '_': '/tools/buildbot/bin/python'} 09:03:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:02 INFO - Downloading/unpacking blobuploader==1.2.4 09:03:02 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 09:03:02 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 09:03:02 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 09:03:02 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 09:03:02 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 09:03:02 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 09:03:04 INFO - Downloading blobuploader-1.2.4.tar.gz 09:03:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:03:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:03:04 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 09:03:04 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 09:03:04 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 09:03:04 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 09:03:04 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 09:03:04 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 09:03:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:03:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:03:04 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 09:03:04 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 09:03:04 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 09:03:04 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 09:03:04 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 09:03:04 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 09:03:05 INFO - Downloading docopt-0.6.1.tar.gz 09:03:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:03:05 INFO - Installing collected packages: blobuploader, requests, docopt 09:03:05 INFO - Running setup.py install for blobuploader 09:03:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:03:05 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:03:05 INFO - Running setup.py install for requests 09:03:05 INFO - Running setup.py install for docopt 09:03:05 INFO - Successfully installed blobuploader requests docopt 09:03:05 INFO - Cleaning up... 09:03:05 INFO - Return code: 0 09:03:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:03:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:05 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 0x7fad30d05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdea50>, '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 0x1b4a550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a9e0>, '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': 'df17445c3590ff7897617a0e00000225-1453482162.836543-559619016', '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 09:03:05 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 09:03:05 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 09:03:05 INFO - Using env: {'DISPLAY': ':0', 09:03:05 INFO - 'HOME': '/home/cltbld', 09:03:05 INFO - 'LANG': 'en_US.UTF-8', 09:03:05 INFO - 'LANGUAGE': 'en_US:en', 09:03:05 INFO - 'LOGNAME': 'cltbld', 09:03:05 INFO - 'MAIL': '/var/mail/cltbld', 09:03:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:05 INFO - 'MOZ_NO_REMOTE': '1', 09:03:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:05 INFO - 'NO_EM_RESTART': '1', 09:03:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:03:05 INFO - 'PWD': '/builds/slave/test-pgo', 09:03:05 INFO - 'SHELL': '/bin/bash', 09:03:05 INFO - 'SHLVL': '1', 09:03:05 INFO - 'TERM': 'linux', 09:03:05 INFO - 'TMOUT': '86400', 09:03:05 INFO - 'USER': 'cltbld', 09:03:05 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1453482162.836543-559619016', 09:03:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:05 INFO - '_': '/tools/buildbot/bin/python'} 09:03:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:03:05 INFO - Running setup.py (path:/tmp/pip-81KpWO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:03:06 INFO - Running setup.py (path:/tmp/pip-KlljVp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:03:06 INFO - Running setup.py (path:/tmp/pip-lcwanA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:03:06 INFO - Running setup.py (path:/tmp/pip-ZgWJQT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:03:06 INFO - Running setup.py (path:/tmp/pip-LLks_G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:03:06 INFO - Running setup.py (path:/tmp/pip-uYLhym-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:03:06 INFO - Running setup.py (path:/tmp/pip-1KQuU8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:03:06 INFO - Running setup.py (path:/tmp/pip-jOXrtm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:03:06 INFO - Running setup.py (path:/tmp/pip-c2gwFy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:03:06 INFO - Running setup.py (path:/tmp/pip-F4cKDq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:03:06 INFO - Running setup.py (path:/tmp/pip-gajgwr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:03:06 INFO - Running setup.py (path:/tmp/pip-CV07sW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:03:06 INFO - Running setup.py (path:/tmp/pip-d2zsc3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:03:06 INFO - Running setup.py (path:/tmp/pip-TaSxHi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:03:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:03:06 INFO - Running setup.py (path:/tmp/pip-JUVCh6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:03:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:03:07 INFO - Running setup.py (path:/tmp/pip-r4deEZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:03:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:03:07 INFO - Running setup.py (path:/tmp/pip-1wH4EN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:03:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:03:07 INFO - Running setup.py install for manifestparser 09:03:07 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:03:07 INFO - Running setup.py install for mozcrash 09:03:07 INFO - Running setup.py install for mozdebug 09:03:07 INFO - Running setup.py install for mozdevice 09:03:07 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:03:07 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:03:07 INFO - Running setup.py install for mozfile 09:03:07 INFO - Running setup.py install for mozhttpd 09:03:07 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:03:07 INFO - Running setup.py install for mozinfo 09:03:07 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:03:07 INFO - Running setup.py install for mozInstall 09:03:08 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:03:08 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:03:08 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:03:08 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:03:08 INFO - Running setup.py install for mozleak 09:03:08 INFO - Running setup.py install for mozlog 09:03:08 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:03:08 INFO - Running setup.py install for moznetwork 09:03:08 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:03:08 INFO - Running setup.py install for mozprocess 09:03:08 INFO - Running setup.py install for mozprofile 09:03:08 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:03:08 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:03:08 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:03:08 INFO - Running setup.py install for mozrunner 09:03:08 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:03:08 INFO - Running setup.py install for mozscreenshot 09:03:08 INFO - Running setup.py install for moztest 09:03:08 INFO - Running setup.py install for mozversion 09:03:08 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:03:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:03:08 INFO - Cleaning up... 09:03:09 INFO - Return code: 0 09:03:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:03:09 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')]} 09:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:09 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')]} 09:03:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:09 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 0x7fad30d05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdea50>, '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 0x1b4a550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a9e0>, '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': 'df17445c3590ff7897617a0e00000225-1453482162.836543-559619016', '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 09:03:09 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 09:03:09 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 09:03:09 INFO - Using env: {'DISPLAY': ':0', 09:03:09 INFO - 'HOME': '/home/cltbld', 09:03:09 INFO - 'LANG': 'en_US.UTF-8', 09:03:09 INFO - 'LANGUAGE': 'en_US:en', 09:03:09 INFO - 'LOGNAME': 'cltbld', 09:03:09 INFO - 'MAIL': '/var/mail/cltbld', 09:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:09 INFO - 'MOZ_NO_REMOTE': '1', 09:03:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:09 INFO - 'NO_EM_RESTART': '1', 09:03:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:03:09 INFO - 'PWD': '/builds/slave/test-pgo', 09:03:09 INFO - 'SHELL': '/bin/bash', 09:03:09 INFO - 'SHLVL': '1', 09:03:09 INFO - 'TERM': 'linux', 09:03:09 INFO - 'TMOUT': '86400', 09:03:09 INFO - 'USER': 'cltbld', 09:03:09 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1453482162.836543-559619016', 09:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:09 INFO - '_': '/tools/buildbot/bin/python'} 09:03:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:03:09 INFO - Running setup.py (path:/tmp/pip-6v6C39-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:03:09 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)) 09:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:03:09 INFO - Running setup.py (path:/tmp/pip-qBb0CY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:03:09 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)) 09:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:03:09 INFO - Running setup.py (path:/tmp/pip-dWoUVX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:03:09 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)) 09:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:03:09 INFO - Running setup.py (path:/tmp/pip-a6wnXC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:03:09 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)) 09:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:03:09 INFO - Running setup.py (path:/tmp/pip-7zVGmA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:03:09 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)) 09:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:03:09 INFO - Running setup.py (path:/tmp/pip-G9b9Rr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:03:09 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)) 09:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:03:09 INFO - Running setup.py (path:/tmp/pip-Akx4EE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:03:09 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)) 09:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:03:09 INFO - Running setup.py (path:/tmp/pip-znx1ut-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:03:09 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)) 09:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:03:09 INFO - Running setup.py (path:/tmp/pip-jX8t6s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:03:09 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)) 09:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:03:09 INFO - Running setup.py (path:/tmp/pip-_sYHe3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:03:09 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)) 09:03:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:03:09 INFO - Running setup.py (path:/tmp/pip-rdi8eD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:03:10 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)) 09:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:03:10 INFO - Running setup.py (path:/tmp/pip-uCFp3g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:03:10 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)) 09:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:03:10 INFO - Running setup.py (path:/tmp/pip-hJWvQN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:03:10 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)) 09:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:03:10 INFO - Running setup.py (path:/tmp/pip-9RB8CN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:03:10 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)) 09:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:03:10 INFO - Running setup.py (path:/tmp/pip-B2DSL_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:03:10 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)) 09:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:03:10 INFO - Running setup.py (path:/tmp/pip-QKXwNW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:03:10 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)) 09:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:03:10 INFO - Running setup.py (path:/tmp/pip-BN746D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:03:10 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)) 09:03:10 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)) 09:03:10 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)) 09:03:10 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)) 09:03:10 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)) 09:03:10 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)) 09:03:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:03:10 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 09:03:10 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 09:03:10 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 09:03:10 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 09:03:10 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 09:03:10 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 09:03:12 INFO - Downloading blessings-1.6.tar.gz 09:03:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:03:12 INFO - Installing collected packages: blessings 09:03:12 INFO - Running setup.py install for blessings 09:03:12 INFO - Successfully installed blessings 09:03:12 INFO - Cleaning up... 09:03:12 INFO - Return code: 0 09:03:12 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:03:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:03:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:03:12 INFO - Reading from file tmpfile_stdout 09:03:12 INFO - Current package versions: 09:03:12 INFO - argparse == 1.2.1 09:03:12 INFO - blessings == 1.6 09:03:12 INFO - blobuploader == 1.2.4 09:03:12 INFO - docopt == 0.6.1 09:03:12 INFO - manifestparser == 1.1 09:03:12 INFO - mozInstall == 1.12 09:03:12 INFO - mozcrash == 0.16 09:03:12 INFO - mozdebug == 0.1 09:03:12 INFO - mozdevice == 0.47 09:03:12 INFO - mozfile == 1.2 09:03:12 INFO - mozhttpd == 0.7 09:03:12 INFO - mozinfo == 0.9 09:03:12 INFO - mozleak == 0.1 09:03:12 INFO - mozlog == 3.1 09:03:12 INFO - moznetwork == 0.27 09:03:12 INFO - mozprocess == 0.22 09:03:12 INFO - mozprofile == 0.27 09:03:12 INFO - mozrunner == 6.11 09:03:12 INFO - mozscreenshot == 0.1 09:03:12 INFO - mozsystemmonitor == 0.0 09:03:12 INFO - moztest == 0.7 09:03:12 INFO - mozversion == 1.4 09:03:12 INFO - psutil == 3.1.1 09:03:12 INFO - requests == 1.2.3 09:03:12 INFO - wsgiref == 0.1.2 09:03:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:03:12 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')]} 09:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:12 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')]} 09:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:12 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 0x7fad30d05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdea50>, '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 0x1b4a550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a9e0>, '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': 'df17445c3590ff7897617a0e00000225-1453482162.836543-559619016', '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 09:03:12 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 09:03:12 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 09:03:12 INFO - Using env: {'DISPLAY': ':0', 09:03:12 INFO - 'HOME': '/home/cltbld', 09:03:12 INFO - 'LANG': 'en_US.UTF-8', 09:03:12 INFO - 'LANGUAGE': 'en_US:en', 09:03:12 INFO - 'LOGNAME': 'cltbld', 09:03:12 INFO - 'MAIL': '/var/mail/cltbld', 09:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:12 INFO - 'MOZ_NO_REMOTE': '1', 09:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:12 INFO - 'NO_EM_RESTART': '1', 09:03:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:03:12 INFO - 'PWD': '/builds/slave/test-pgo', 09:03:12 INFO - 'SHELL': '/bin/bash', 09:03:12 INFO - 'SHLVL': '1', 09:03:12 INFO - 'TERM': 'linux', 09:03:12 INFO - 'TMOUT': '86400', 09:03:12 INFO - 'USER': 'cltbld', 09:03:12 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1453482162.836543-559619016', 09:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:12 INFO - '_': '/tools/buildbot/bin/python'} 09:03:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:12 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)) 09:03:12 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)) 09:03:12 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)) 09:03:12 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)) 09:03:12 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)) 09:03:12 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)) 09:03:12 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)) 09:03:12 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)) 09:03:12 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)) 09:03:12 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)) 09:03:12 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)) 09:03:12 INFO - Cleaning up... 09:03:12 INFO - Return code: 0 09:03:12 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:03:12 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')]} 09:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:12 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')]} 09:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:12 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 0x7fad30d05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdea50>, '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 0x1b4a550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a9e0>, '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': 'df17445c3590ff7897617a0e00000225-1453482162.836543-559619016', '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 09:03:12 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 09:03:12 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 09:03:12 INFO - Using env: {'DISPLAY': ':0', 09:03:12 INFO - 'HOME': '/home/cltbld', 09:03:12 INFO - 'LANG': 'en_US.UTF-8', 09:03:12 INFO - 'LANGUAGE': 'en_US:en', 09:03:12 INFO - 'LOGNAME': 'cltbld', 09:03:12 INFO - 'MAIL': '/var/mail/cltbld', 09:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:12 INFO - 'MOZ_NO_REMOTE': '1', 09:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:12 INFO - 'NO_EM_RESTART': '1', 09:03:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:03:12 INFO - 'PWD': '/builds/slave/test-pgo', 09:03:12 INFO - 'SHELL': '/bin/bash', 09:03:12 INFO - 'SHLVL': '1', 09:03:12 INFO - 'TERM': 'linux', 09:03:12 INFO - 'TMOUT': '86400', 09:03:12 INFO - 'USER': 'cltbld', 09:03:12 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1453482162.836543-559619016', 09:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:12 INFO - '_': '/tools/buildbot/bin/python'} 09:03:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:13 INFO - Downloading/unpacking jsonschema 09:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:03:14 INFO - Downloading/unpacking functools32 (from jsonschema) 09:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:15 INFO - Downloading functools32-3.2.3-2.tar.gz 09:03:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:03:15 INFO - warning: no files found matching '*.txt' 09:03:15 INFO - no previously-included directories found matching 'build' 09:03:15 INFO - no previously-included directories found matching 'dist' 09:03:15 INFO - no previously-included directories found matching '.git*' 09:03:15 INFO - Installing collected packages: jsonschema, functools32 09:03:15 INFO - Running setup.py install for functools32 09:03:15 INFO - warning: no files found matching '*.txt' 09:03:15 INFO - no previously-included directories found matching 'build' 09:03:15 INFO - no previously-included directories found matching 'dist' 09:03:15 INFO - no previously-included directories found matching '.git*' 09:03:15 INFO - Successfully installed jsonschema functools32 09:03:15 INFO - Cleaning up... 09:03:15 INFO - Return code: 0 09:03:15 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:03:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:15 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 0x7fad30d05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdea50>, '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 0x1b4a550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a9e0>, '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': 'df17445c3590ff7897617a0e00000225-1453482162.836543-559619016', '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 09:03:15 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 09:03:15 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 09:03:15 INFO - Using env: {'DISPLAY': ':0', 09:03:15 INFO - 'HOME': '/home/cltbld', 09:03:15 INFO - 'LANG': 'en_US.UTF-8', 09:03:15 INFO - 'LANGUAGE': 'en_US:en', 09:03:15 INFO - 'LOGNAME': 'cltbld', 09:03:15 INFO - 'MAIL': '/var/mail/cltbld', 09:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:15 INFO - 'MOZ_NO_REMOTE': '1', 09:03:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:15 INFO - 'NO_EM_RESTART': '1', 09:03:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:03:15 INFO - 'PWD': '/builds/slave/test-pgo', 09:03:15 INFO - 'SHELL': '/bin/bash', 09:03:15 INFO - 'SHLVL': '1', 09:03:15 INFO - 'TERM': 'linux', 09:03:15 INFO - 'TMOUT': '86400', 09:03:15 INFO - 'USER': 'cltbld', 09:03:15 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1453482162.836543-559619016', 09:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:15 INFO - '_': '/tools/buildbot/bin/python'} 09:03:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:15 INFO - Downloading/unpacking flake8 09:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:03:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:03:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:03:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:03:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:03:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:03:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:03:17 INFO - no previously-included directories found matching 'docs/_build' 09:03:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:03:18 INFO - Running setup.py install for pep8 09:03:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:03:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:03:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:03:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:03:18 INFO - no previously-included directories found matching 'docs/_build' 09:03:18 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:03:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:03:18 INFO - Cleaning up... 09:03:18 INFO - Return code: 0 09:03:18 INFO - Running post-action listener: _resource_record_post_action 09:03:18 INFO - Running post-action listener: _start_resource_monitoring 09:03:18 INFO - Starting resource monitoring. 09:03:18 INFO - ##### 09:03:18 INFO - ##### Running install step. 09:03:18 INFO - ##### 09:03:18 INFO - Running pre-action listener: _resource_record_pre_action 09:03:18 INFO - Running main action method: install 09:03:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:03:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:03:18 INFO - Reading from file tmpfile_stdout 09:03:18 INFO - Detecting whether we're running mozinstall >=1.0... 09:03:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:03:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:03:18 INFO - Reading from file tmpfile_stdout 09:03:18 INFO - Output received: 09:03:18 INFO - Usage: mozinstall [options] installer 09:03:18 INFO - Options: 09:03:18 INFO - -h, --help show this help message and exit 09:03:18 INFO - -d DEST, --destination=DEST 09:03:18 INFO - Directory to install application into. [default: 09:03:18 INFO - "/builds/slave/test-pgo"] 09:03:18 INFO - --app=APP Application being installed. [default: firefox] 09:03:18 INFO - mkdir: /builds/slave/test-pgo/build/application 09:03:18 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'] 09:03:18 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 09:03:34 INFO - Reading from file tmpfile_stdout 09:03:34 INFO - Output received: 09:03:34 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:03:34 INFO - Running post-action listener: _resource_record_post_action 09:03:34 INFO - ##### 09:03:34 INFO - ##### Running run-tests step. 09:03:34 INFO - ##### 09:03:34 INFO - Running pre-action listener: _resource_record_pre_action 09:03:34 INFO - Running main action method: run_tests 09:03:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:03:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:03:34 INFO - Python 2.7.3 09:03:34 INFO - Return code: 0 09:03:34 INFO - grabbing minidump binary from tooltool 09:03:34 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')]} 09:03:34 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 0x1bdea50>, '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 0x1b4a550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a9e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:03:34 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 09:03:34 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 09:03:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:03:34 INFO - Return code: 0 09:03:34 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:03:34 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:03:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:03:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:03:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:03:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:03:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:03:36 INFO - Return code: 0 09:03:36 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/bUODrfdIQQynOXWD0dtxhg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 09:03:36 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/bUODrfdIQQynOXWD0dtxhg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost 09:03:36 INFO - Using env: {'DISPLAY': ':0', 09:03:36 INFO - 'HOME': '/home/cltbld', 09:03:36 INFO - 'LANG': 'en_US.UTF-8', 09:03:36 INFO - 'LANGUAGE': 'en_US:en', 09:03:36 INFO - 'LOGNAME': 'cltbld', 09:03:36 INFO - 'MAIL': '/var/mail/cltbld', 09:03:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:03:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:03:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:36 INFO - 'MOZ_NO_REMOTE': '1', 09:03:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:03:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:36 INFO - 'NO_EM_RESTART': '1', 09:03:36 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:03:36 INFO - 'PWD': '/builds/slave/test-pgo', 09:03:36 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:03:36 INFO - 'SHELL': '/bin/bash', 09:03:36 INFO - 'SHLVL': '1', 09:03:36 INFO - 'TERM': 'linux', 09:03:36 INFO - 'TMOUT': '86400', 09:03:36 INFO - 'USER': 'cltbld', 09:03:36 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1453482162.836543-559619016', 09:03:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:36 INFO - '_': '/tools/buildbot/bin/python'} 09:03:36 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/bUODrfdIQQynOXWD0dtxhg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost'] with output_timeout 3600 09:03:36 INFO - mozversion INFO | application_buildid: 20160122063728 09:03:36 INFO - mozversion INFO | application_changeset: 0ce166f4fec610dd1b3a99f348f19811c571b51b 09:03:36 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 09:03:36 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:03:36 INFO - mozversion INFO | application_name: Firefox 09:03:36 INFO - mozversion INFO | application_remotingname: firefox-dev 09:03:36 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:03:36 INFO - mozversion INFO | application_vendor: Mozilla 09:03:36 INFO - mozversion INFO | application_version: 45.0a2 09:03:36 INFO - mozversion INFO | platform_buildid: 20160122063728 09:03:36 INFO - mozversion INFO | platform_changeset: 0ce166f4fec610dd1b3a99f348f19811c571b51b 09:03:36 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:03:36 INFO - mozversion INFO | platform_version: 45.0a2 09:03:36 INFO - 2016-01-22 09:03:36,279 DEBUG : using testdate: 1453482216 09:03:36 INFO - 2016-01-22 09:03:36,279 DEBUG : actual date: 1453482216 09:03:36 INFO - 2016-01-22 09:03:36,288 INFO : starting webserver on 'localhost:53454' 09:03:36 INFO - 2016-01-22 09:03:36,289 INFO : Starting test suite talos-linux64-ix-021.e 09:03:36 INFO - 2016-01-22 09:03:36,289 INFO : Starting test dromaeo_css 09:03:36 INFO - 2016-01-22 09:03:36,289 DEBUG : operating with platform_type : linux_ 09:03:36 INFO - 2016-01-22 09:03:36,290 INFO : Initialising browser for dromaeo_css test... 09:03:36 INFO - 2016-01-22 09:03:36,304 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuM0SvU/profile http://localhost:53454/getInfo.html 09:03:40 INFO - 2016-01-22 09:03:40,707 DEBUG : BROWSER_OUTPUT: 09:03:40 INFO - 2016-01-22 09:03:40,707 DEBUG : BROWSER_OUTPUT: (process:18019): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:03:41 INFO - 2016-01-22 09:03:41,612 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:03:41 INFO - 2016-01-22 09:03:41,612 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:03:41 INFO - 2016-01-22 09:03:41,612 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:03:41 INFO - 2016-01-22 09:03:41,613 DEBUG : BROWSER_OUTPUT: __metrics 09:03:42 INFO - 2016-01-22 09:03:42,655 INFO : Browser initialized. 09:03:42 INFO - 2016-01-22 09:03:42,655 INFO : Running cycle 1/1 for dromaeo_css test... 09:03:42 INFO - 2016-01-22 09:03:42,655 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuM0SvU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:03:44 INFO - 2016-01-22 09:03:44,012 DEBUG : BROWSER_OUTPUT: 09:03:44 INFO - 2016-01-22 09:03:44,013 DEBUG : BROWSER_OUTPUT: (process:18133): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:03:54 INFO - 2016-01-22 09:03:54,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 136974336 09:03:54 INFO - 2016-01-22 09:03:54,521 DEBUG : BROWSER_OUTPUT: 09:04:44 INFO - 2016-01-22 09:04:44,118 DEBUG : BROWSER_OUTPUT: 1453482284116 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] 09:06:52 INFO - 2016-01-22 09:06:52,034 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53454/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53454/tests/dromaeo/cssquery-ext.html) 09:06:53 INFO - 2016-01-22 09:06:53,044 DEBUG : BROWSER_OUTPUT: RSS: Main: 141578240 09:06:53 INFO - 2016-01-22 09:06:53,044 DEBUG : BROWSER_OUTPUT: 09:09:54 INFO - 2016-01-22 09:09:54,829 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53454/tests/dromaeo/cssquery-ext.html (next: http://localhost:53454/tests/dromaeo/cssquery-jquery.html) 09:09:55 INFO - 2016-01-22 09:09:55,419 DEBUG : BROWSER_OUTPUT: RSS: Main: 139436032 09:09:55 INFO - 2016-01-22 09:09:55,419 DEBUG : BROWSER_OUTPUT: 09:12:56 INFO - 2016-01-22 09:12:56,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53454/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53454/tests/dromaeo/cssquery-mootools.html) 09:12:57 INFO - 2016-01-22 09:12:57,556 DEBUG : BROWSER_OUTPUT: RSS: Main: 139804672 09:12:57 INFO - 2016-01-22 09:12:57,557 DEBUG : BROWSER_OUTPUT: 09:15:59 INFO - 2016-01-22 09:15:59,138 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53454/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53454/tests/dromaeo/cssquery-prototype.html) 09:15:59 INFO - 2016-01-22 09:15:59,725 DEBUG : BROWSER_OUTPUT: RSS: Main: 140079104 09:15:59 INFO - 2016-01-22 09:15:59,725 DEBUG : BROWSER_OUTPUT: 09:19:01 INFO - 2016-01-22 09:19:01,878 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53454/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53454/tests/dromaeo/cssquery-yui.html) 09:19:02 INFO - 2016-01-22 09:19:02,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 138973184 09:19:02 INFO - 2016-01-22 09:19:02,472 DEBUG : BROWSER_OUTPUT: 09:22:04 INFO - 2016-01-22 09:22:04,603 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53454/tests/dromaeo/cssquery-yui.html (next: http://localhost:53454/tests/dromaeo/cssquery-dojo.html) 09:22:04 INFO - 2016-01-22 09:22:04,854 DEBUG : BROWSER_OUTPUT: RSS: Main: 141660160 09:22:04 INFO - 2016-01-22 09:22:04,854 DEBUG : BROWSER_OUTPUT: 09:22:04 INFO - 2016-01-22 09:22:04,854 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:22:04 INFO - 2016-01-22 09:22:04,854 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:22:04 INFO - 2016-01-22 09:22:04,855 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:22:04 INFO - 2016-01-22 09:22:04,855 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:22:04 INFO - 2016-01-22 09:22:04,855 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3342.882999095031;3417.5044618530314;3436.570428696413;3437.1235334989574;3442.2082920928187;5579.358373787016;5586.972065139674;5588.720563971795;5592.720363981794;5601.29983752031;5531.778728850841;5618.859528511779;5628.831135065944;5652.830415087544;5677.744501497432;5104.999999999991;5147.0992576298995;5162.741862906859;5173.275741396207;5209.192575150839;4977.701337919718;5044.82343117991;5082.51716086973;5098.847034588968;5156.8710782230555;5064.518870707277;5136.666116702421;5140.614453915971;5141.228815677659;5146.125158723007;5123.308353372285;5126.461721519243;5177.456367081478;5179.766910488999;5199.454057324002;4881.292212629149;4945.9258111128365;4988.127077761414;5005.974970125162;5092.26162206478;5375.005623959541;5400.351957765054;5420.07858664028;5439.5376393006645;5444.8366549003595;5952.523798096142;5967.343592204854;5995.400459953969;6002.3697511761075;6043.3956604339655;5729.484346408802;5920.082387229986;6023.939760602381;6121;6123.87752244957;5611.719414029323;5618.185363122325;5626.634268772557;5637.069883469223;5640.7743690252755;5697.686627235459;6134.9079763803575;6147.0779383092;6147.846303842351;6159.938400615936;5759.078547432475;5896.64620122794;5998.520118390518;6015.819525414245;6027.367126451747;6072.817815465543;6073.301570319381;6080.57435979486;6080.665563394055;6091.269047714302;5765.308163020381;6038.426349496791;6050.969745151334;6075.453209211104;6078.787242446493;5932.228810254639;6038.758449661965;6085.056816193497;6107.389261073857;6143.293521245114;4569.588737013684;4577.153226653079;4587.449506059227;4593.219152744042;4607.861764147081;3996.4604778355133;4075.1849630074103;4126.958730412717;4155.189738001121;4173;5727.971360143256;5729.369769325371;5731.054376027909;5812.796552120655;5837.036888913367;6043.153958445821;6048.455638992512;6048.576599637983;6050.788222412194;6064.48451881595;5569.053260945568;5667.744951477193;5671.943280567224;5694.1458781183155;5706;5211.270422140903;5228.9477105229225;5267.236250743697;5313.920291195635;5335.013022590833;6058.606190597597;6094.908576371358;6097.542684298606;6103.877922441527;6121.908171377433;5853.64878107315;5940.108983652487;6002.429769171922;6002.579819412599;6002.669853157943;6005.129256257906;6085.779948862308;6109.725062372293;6138.785142520169;6149.938500614937;5939.049752039653;5988.981873081674;6010.639361638316;6016.42843929826;6024.789132380346;5843.590948633555;5941.049432090845;6138.478229350555;6161.876762464815;6163.229596300463;5728.513076388387;5853.180554722428;5862.120681897579;5862.765489380377;5888.263967004124;5942.881142377042;5968.701564921824;6009.729562169626;6013.579049466495;6018.729157188025;5685.687287199078;5706.80026199081;5791.189233507396;5862.530997520274;5905.084711869667;5914.497267732118;5958.940410595838;5960.850978725566;5974.044152935509;6024.307204671519;5765.8558536036935;5804.6807425592;5810.82567522975;5821.534277257894;5832.883342333214 09:22:04 INFO - 2016-01-22 09:22:04,856 DEBUG : BROWSER_OUTPUT: |1;ext.html;611.71249512729;641.5990006246096;655.9048937904004;663.7112855907684;695.5096656856916;32747.50878736818;41659;41765.373519397195;41825.790871045676;42136.15727685444;46076.07847843041;46449.53550464503;46525.53474465254;46597.53402465974;46767.766161169144;9035.63857445703;9121.817563648723;9211.493367864765;9235.353525253235;9244;8957.283417326598;9029.819403611957;9058.365914385995;9100.772480688003;9110.544472776368;9051.411658242194;9112.908870911306;9113;9126.269898408145;9128.817423651522;8953.865692014593;8981.865272020892;8987.595558199831;8994.775130621754;9016;8857.247133993618;8986.14631609996;9006.684766033222;9064.229540489066;9091.818163636757;42348.153036939395;42709.35935960963;42720.35919461211;43038.35442468365;43148.78425607852;3474.3919814032442;3529.2412131391875;3567.3935430976794;3714.609965953563;3845.6346647068485;32114.678853211404;32419.51370729441;32496.837515812505;32749.345013099843;33302.666973330444;3766.322062028834;3935;4016.6786657067364;4087.7747912304444;4135.875923722263;289432;291998;292265;292327;293035.99999999785;45607.543924560996;45685.314720279224;45697;45721;66024.33975660279;44844.32733509;44905.55094449079;44990.100197996515;45086.32370514445;45123.29260244396;16327.510174694778;16374.099424531527;16428.342866285213;16481.587960301087;16521;13193.538226162038;13349.799753003712;13385.397657105454;13389.66525836862;13505.594832155051;15682.215889205721;15713.371465141496;15714.135722535142;15846.683066338608;15854.286557104728;6223.222097237845;6365.631389251241;6367.363263673596;6376.84057898547;6483.448906842877;1026.071405378134;1038.8909164537765;1139.7549526851767;1152.7118220444888;1186.7389174381622;29566.852165739034;33477.33045339128;34357;34686.306273874885;34946;1119.2109562758399;1131.4908291268962;1156.647222597116;1204.4278967490548;1217.6590554644713;15332.463363782213;15541.533753987398;15572.096174732764;15576.299066542033;15902.44341448067;450858;543362;551341;553613;580683;58634.7068264656;59521.70239148863;59561;59589.70205148947;59642.403575964556;1488.5906375746756;1496.124767011289;1500.579837645461;1502.2263534279855;1509.5094094419358;30771.69228307688;31375.686243137276;31446.371072578877;31715.20711982219;31882.36235275328;48574;49119.50880491149;49195.26207106968;49246.26130607972;49262.26106608476;331584;331941;332406;334142;334601;33382.66617333796;33510.66489335075;33662.49506257457;33723.98828035163;33803.4929476063;54360;54448;55131.44868551424;55364.44635553754;56134.157987631035;37135.44296835495;38459.23081538297;38962.02594935149;39296;40250.1949961005;40138;40268;40722.389164163156;40940.38589421102;41105.588944110175;39326.80336598299;43641.34537981996;43899.56100438955;43917.560824391345;44839;34616.30767384588;34637.1340716474;34810.47784283289;34846.65153348434;39268;26433.73566264313;27203;27410.451790964467;27429.45141097207;27471.31321716973 09:22:04 INFO - 2016-01-22 09:22:04,860 DEBUG : BROWSER_OUTPUT: |2;jquery.html;381.77475289579144;383.5914750790406;387.16758968218335;388.40186113385386;391.15900813251505;16458.259378327974;17369;18672.439826805185;20508.384748457534;20544.07551660177;11595.652130436101;11747.530098796038;13461.730765384711;18156.273749050055;18181.545461363472;4427.535108813577;5169.457206993258;5246.921296180561;5699.943000570003;5722.484976352128;5633.126865335859;5707.115397113434;5713.114467257582;5714.685692286923;5718.914216286759;5522.420145884685;5610.214569960209;5614.242077319571;5633.943660563404;5657.547396208293;5533.529649979737;5546.306711661043;5547.694876781776;5555.444455554452;5581.944180558224;4923.483034281385;5000.5249501297685;5010.89978200434;5028.7737051832755;5044.621653376012;21308.254211102536;21832;21894.671579926315;21952.780472195234;22499.437514062116;2182.476205710634;2218.9556208875733;2242.383344580237;2351.988240058806;2363.1492662641435;10545.84181237282;13337.86662133376;13953.930230348884;14175.291235438186;14310.499132530416;1935;1979.0896187753651;1993.6909778984282;2009.5578972626;2025.4430031741242;63612.68193659048;64038;65796.34203657902;65915.67042164759;67862;10536.947315263375;10725.302855314536;10750.408727520062;10771.192160587987;10911.56353745857;14325.283735813377;14437.422503099759;14510;14537.709245815236;14559.126452412676;8508;8533.658653653783;8561.0582835888;8619.094995025558;8651.95674021626;8556.871646925301;8559.614817333111;8604.225619694133;8620.224179823721;8635.309175265964;4537.977310113428;4557.95442045582;4563.429571303587;4622.098690755271;4629.305604159335;1810.8913465192131;1818.2363407368937;1883.5667796406628;1902.73361729358;1926.1909997800958;987.8468837330225;998.55065220651;1020.9948950255201;1035.8967699400114;1111.6720567432626;17771.378001770136;17879.195436205402;17979.550511237063;18385.356512521998;18652.533686657942;986.3539381704994;995.6863587969766;1077.7067518977258;1078.6278733836814;1094.6497120921388;9842.80314393708;10194.388336699822;10197.694069177787;10232.437215953194;10234.897651023395;619862;620402;631625;638265;644810;69358;70474.29525704678;73645.6317718408;85471.14528854756;86326;1153.7115721069733;1176.9764604707857;1191.684203686024;1196.6589521986366;1203.0616119427036;15808.92095539515;15920.601984950006;15975.600609984844;16024.599385015468;16633.750493742846;36742.44886326654;36988.81505592455;37573.81213093917;38493.615063849;38857.6114238854;48708.756456217496;49731.254031190285;49929.750351249466;50536;50597.747011264706;9894.406335619886;10003.099721025143;10353.223508237063;10420.739481513023;10422.426766527913;17963.461096167135;18260.817391826444;18846;18891.338803142375;19319.51701207481;15733.606659833596;15825.52523424299;15907.363705451653;16030.519084427486;16168.67662646764;14713.92643036778;15089.39642414335;15448.845511544741;15919.920400397923;16019.679606407573;15465.845341546441;15838.52484425469;15864.286107125437;15972.440964566184;16365.918170409072;13564.93217533906;14217.715645687234;15538.378464861278;15612.4535641252;16034.278457469209;16988.49034528966;17171;17558.29766809313;18081.547961301072;18201.726974095134 09:22:04 INFO - 2016-01-22 09:22:04,860 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1557.7351850185476;1605.9919700401497;1867.5611231360629;1892.7823300320463;1893.9147738351774;8187.345012398994;8284.792880177998;8350.95824520878;8515.148485151482;8525.062243153256;8400.789980250482;8416.83166336673;8516.31869450444;8522.105178956213;8531.146885311466;2275.2036787124457;2320.8607483550954;2325.593021221288;2332.230363979891;2335.100986120339;2409.8072154227707;2420.3707036170636;2421.842580232288;2431.4772323950347;2456.754324567547;2309.595820731374;2337.0651739304244;2349.765023497645;2358.3278765551822;2374.3114496795906;2303.9539209215804;2347.460084180648;2371.442710962931;2372.691550098476;2379.167291447997;2364.125273648761;2387.4866903615634;2388.0328466970905;2388.1522059668914;2390.9163179288817;8254;8321.500709957421;8322.583870806435;8329.0421601516;8342.582870856433;4859.927101093486;4918.163912134945;4946.752662366867;4982.77577509013;4984.551390374883;3157.684231576824;3161.541576471399;3189.8245596492184;3202.055393658853;3202.823844688541;1025.933314334566;1031.2523420520138;1031.283258135596;1067.119626308291;1087.9891201087967;11408.087353011822;11449.313041217554;11532.884671153264;11564.13269004828;11574;4237.152569486115;4299.957000429956;4306.763128027988;4337.60961513459;4357.891052723708;9355.766105847408;9356;9358.766030849147;9364.25085993119;9375.531223438937;4857.80568777252;4870.6103511718975;4879.243717223836;4900.117978763857;4911.214205727067;4453.576910193591;4462.776861156929;4495.865124046284;4500;4506.954930450654;3489.3021395720957;3503.211777350127;3518.437050071976;3521.5774107107313;3569.5716514018486;1046.529061922138;1047.2930771729052;1052.9420881851572;1074.8817630060687;1211.8727533609022;1116.0959622705634;1146.7190538317998;1152.4698638626326;1154.722866512031;1182.3142577305143;7784.961075194701;7805.453618246782;7867.9606601966625;7875.842483150305;7906.209379062047;1158.9942050289694;1172.5075468303332;1176.0944073063863;1192.3382522699985;1201.759648070372;6163.414475624898;6193.287771906198;6202.81391558254;6219.191505104398;6258.249010118815;9908.355956862924;9915.80168396628;9928.056834600702;9998.500074996367;10042.447665378475;9682.177014953808;9812.26408019387;9816.901830981742;9956.103950644478;9966.152877005536;7788.454808163374;7890;7900.249476299742;7913.089994650573;7921.485103468372;7719.189485103983;7793.571353575381;7818.882716759139;7833.37333013369;7836.80407989782;8918.331125165509;8931.508767017876;8944.552772361487;8979.551022448983;8988.505632190292;9046.411983221069;9140.314476414163;9148.405353651991;9156.496392698466;9340.065993400605;7347.55914645123;7454.92545074564;7490.288422599844;7519.924800751923;7521.323080922743;7735.149133595188;7750.379969602531;7781.688732450639;7789;8039.236272554098;7200.8919866201;7380.889286660812;7486.326230639269;7501.812454688458;7519.586422746802;7356.816079598053;7359.742409015659;7403.444741644506;7475.4019678426685;7512.624368781429;7629.923700762922;7636.160022397643;7654.081510218809;7687.2697093776005;7690.730824421118;6628.370304821035;6635.270120286861;6686.7993960181275;6688.7324507019175;6695.397414232742;6700.899486507804;6752.561083529555;6765.898511522233;6772;6784.3215678433735 09:22:04 INFO - 2016-01-22 09:22:04,861 DEBUG : BROWSER_OUTPUT: |4;prototype.html;356.15768707007936;356.75740496462396;358.1690478090829;360.21293473759835;364.74467872489265;6289.433950944425;6364.299927008031;6398.488120950325;6411.9679401602925;6445.323241059691;6181.28915174755;6360.745570177199;6363.618182909017;6370;6373.681315934208;4849.199882019462;4891.1195984722735;4891.48639392864;4895;4901.362822833027;4899.48555401683;4901.289313049606;4903.141950158708;4906.067847109038;4915.3855768029;4655.720656760588;4807.759612019402;4827.951720482803;4830.9516904831025;4832.806687732486;4784.091022705675;4806.759662016902;4812.783424745895;4813.542713442217;4819.542143496362;4170.9582904170875;4176.4570605821355;4180.581941805795;4190.350495673176;4191.1827193697245;5963.850903727398;6055.212822333068;6062.060380641008;6062.181605483292;6068.575199735976;5571.415001424833;5586.832395028156;5590.944090559083;5595.860103497404;5607.018771714975;6675.7997260082275;6717.529772915897;6731.831704207434;6738.326167383271;6775.593464392152;4616.76916154191;4621.098885717286;4628.32889231063;4632.652551058651;4635.8377456789185;6829.214640316378;6929.514933954625;6978.685959131852;6998.895016574756;6998.8950165748065;4590.609798167193;4608.815647374135;4609.861704148881;4610.446746390455;4616.261398176276;4646.279826626878;4661.27750198713;4670.299455081765;4671.929921051187;4671.953280467152;5460.945390546123;5464.590155738336;5468.91796623051;5484.177373393943;5487.067198576252;6643.86712265752;6810.761623343159;6812.591244525344;6822.590644561342;6825.044493770876;1629.8859079864533;1653.9338426463048;1654.2390500369966;1654.495378909444;1654.619437529375;1115.068917453935;1119.4850368830266;1127.785720713062;1142.8628564572305;1150.5225331487338;6543.149390579194;6551.508636852255;6567.179102612174;6577.473802095821;6591.670416479157;6915.377616014583;6959.478039147084;6967.303269673093;6969.721211151598;6978.337057979484;6480.643564603992;6559.868802623921;6567.507436942248;6568.047633093175;6575.375339342755;3765.4351847223134;3781.0736369589627;3806.467094606757;3810.047488127968;3815.6184381562175;7106.644667766591;7114.608696521741;7118.216996130422;7145.356917877416;7148.320144765976;6926.411255043277;7105.076340075757;7105.786826395217;7136.929460580851;7147.499675022698;7107.218205997337;7111.146662400545;7111.217766045731;7122.394596459359;7162.7493037743425;6906.447484201352;6945.340192681687;6978.860422791618;6981.441484681315;6989;6721.294264102199;6828.112345395266;6867.862642747017;6890.035395044798;6894.724211031503;7092.326229008236;7134.1795693495915;7137.714491420285;7139.785806425608;7155.212926578176;4730.881727956691;4738.597219236403;4744.881377965578;4749.073930583503;4752;6783.084283621648;6957.339052789976;6959.61722105289;6973.476989225727;6985.650717464208;6697.464202863662;6757.054012438361;6758.493113016445;6769.492288078315;6775.288594697683;6697.698603562949;6745.392914637706;6753.594784312957;6767.661616919233;6769.1876974763345;6520.902186467112;6628.767993120217;6659.134312539339;6660.333966603301;6671.232808227116;6798.626075565891;6807.523473357016;6807.897881531682;6813.216480104851;6825.761098361533;6592.241892182268;6626.53614246998;6643.70103345341;6649.102371180023;6663.966680166568 09:22:04 INFO - 2016-01-22 09:22:04,861 DEBUG : BROWSER_OUTPUT: |5;yui.html;776.1346099099505;803.4817542684968;815.2214635023553;861.1560670542872;939.4738946190137;13091.607251782438;13286.33568321585;13310.534131305381;13329.866701332983;13343.666408339795;12347.876521234808;12721.618351449448;12740.681482962931;12806.29565373904;13701.314934253272;903.056306160061;911.5715613661569;917.8485549884294;923.1599244687336;924.5839372282467;904.0913881549034;915.2174890468654;917.3165991336464;920.4385324951774;923.1414784250644;958.3435346787438;963.3208587945517;965.715114041356;966.8936416994125;967.4775621164598;955.1880901233965;958.1807554540837;961.053362437998;963.1379914976092;965.034965034965;702.153904545022;703.9120109986252;704.8625518023987;706.936375726182;708.1679027143086;12726.236425814388;12748.617541473677;12804.80792788109;12845.293508857103;12907;12964;13078.738425231442;13080.934595326962;13148;13212.339383030907;10294.220560448712;10389.584416623402;10437.843432348522;10454.477276136162;10492;3817.7136714746225;3887.1448281378052;3907.9218415631526;3912.8434862605463;3915.040815000343;47685.76157119227;47850.5214947853;49483;51956.740216299055;51996.22005669918;9782.315237933419;9800.950995244979;9983.600655973825;10005.499725013866;10061.4466204358;17317.307307707804;17320.566985825455;17381.391651292397;17423.39018134359;17425.82574174242;6795.18457785059;6817.625030623264;6836.418904393083;6886.48351373649;7085.751998680124;4744.596709279681;4883.4628190898975;4948.356713627206;4977.1538838397555;5018.623603229772;3249.7400207983305;3264.1186879542392;3269.4115059289556;3288.556044933951;3291.5556399886186;582.7435928191667;589.4694774702801;602.8342205893414;623.0342968398963;633.2622494793605;571.7398583644432;679.3851564334285;685.8525417035262;704.383664293743;753.1263734068455;8871.645134194689;9387.061293870694;9591.280653950982;9658.082482164184;9948.35335703177;603.5081408651935;668.7726173101072;686.2451303566038;716.7240612364277;735.6064505489644;4392.209402307615;4420.270655341897;4520.118576877543;4630.930536041962;4684.648651351163;55968;60100;60216;61116.694416527636;61332;50315.24527132096;51018;51452;56367.617942923556;57970.71014644984;46616.76691616588;46759.532404676196;47082;47547.524524754306;47616.5238347619;9020.954895225745;9350.345475816628;9525.476098814355;9593.90406095958;9827.656032038843;35098.298034038664;35318;35623.28753424865;37412.25175496529;38297.23405531818;44698;45402;45817.312740309586;45913.31130033119;46087.308690369;11666.416679166177;11696.532138714356;11853.881461185278;12116.515339386326;12140.635780926586;12623.431945562288;13042.347882606022;13141.802872956721;13382;13433.462661493822;11468.541258349573;11960.880391195977;11977;12122.393880305774;12758.872411275768;11314.660560183207;11457.484413201259;11563.768724625628;11599.188056835941;11654.592089276835;10646.520906559379;10683.145348372267;10712;11573.826392603949;11730.296182229093;9924.206063515046;10388.636397726043;10548.367097974146;11097.445127743742;11243.887561124284;9275.25797936177;9717.465539395402;9757.56090975922;9854.802903941738;9894.406335619886 09:22:04 INFO - 2016-01-22 09:22:04,861 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:22:04 INFO - 2016-01-22 09:22:04,861 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:22:04 INFO - 2016-01-22 09:22:04,862 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,310 09:22:04 INFO - 2016-01-22 09:22:04,862 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:22:04 INFO - 2016-01-22 09:22:04,862 DEBUG : BROWSER_OUTPUT: __startTimestamp1453483324851__endTimestamp 09:22:04 INFO - 2016-01-22 09:22:04,862 DEBUG : BROWSER_OUTPUT: 09:22:04 INFO - 2016-01-22 09:22:04,862 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:22:04 INFO - 2016-01-22 09:22:04,862 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:22:04 INFO - 2016-01-22 09:22:04,862 DEBUG : BROWSER_OUTPUT: 09:22:04 INFO - 2016-01-22 09:22:04,862 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5585.58 Median:5804.68 stddev:616.38 (10.6%) stddev-sans-first:592.63 09:22:04 INFO - 2016-01-22 09:22:04,862 DEBUG : BROWSER_OUTPUT: Values: 3342.9 3417.5 3436.6 3437.1 3442.2 5579.4 5587.0 5588.7 5592.7 5601.3 5531.8 5618.9 5628.8 5652.8 5677.7 5105.0 5147.1 5162.7 5173.3 5209.2 4977.7 5044.8 5082.5 5098.8 5156.9 5064.5 5136.7 5140.6 5141.2 5146.1 5123.3 5126.5 5177.5 5179.8 5199.5 4881.3 4945.9 4988.1 5006.0 5092.3 5375.0 5400.4 5420.1 5439.5 5444.8 5952.5 5967.3 5995.4 6002.4 6043.4 5729.5 5920.1 6023.9 6121.0 6123.9 5611.7 5618.2 5626.6 5637.1 5640.8 5697.7 6134.9 6147.1 6147.8 6159.9 5759.1 5896.6 5998.5 6015.8 6027.4 6072.8 6073.3 6080.6 6080.7 6091.3 5765.3 6038.4 6051.0 6075.5 6078.8 5932.2 6038.8 6085.1 6107.4 6143.3 4569.6 4577.2 4587.4 4593.2 4607.9 3996.5 4075.2 4127.0 4155.2 4173.0 5728.0 5729.4 5731.1 5812.8 5837.0 6043.2 6048.5 6048.6 6050.8 6064.5 5569.1 5667.7 5671.9 5694.1 5706.0 5211.3 5228.9 5267.2 5313.9 5335.0 6058.6 6094.9 6097.5 6103.9 6121.9 5853.6 5940.1 6002.4 6002.6 6002.7 6005.1 6085.8 6109.7 6138.8 6149.9 5939.0 5989.0 6010.6 6016.4 6024.8 5843.6 5941.0 6138.5 6161.9 6163.2 5728.5 5853.2 5862.1 5862.8 5888.3 5942.9 5968.7 6009.7 6013.6 6018.7 5685.7 5706.8 5791.2 5862.5 5905.1 5914.5 5958.9 5960.9 5974.0 6024.3 5765.9 5804.7 5810.8 5821.5 5832.9 09:22:04 INFO - 2016-01-22 09:22:04,862 DEBUG : BROWSER_OUTPUT: 09:22:04 INFO - 2016-01-22 09:22:04,862 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:55268.29 Median:40259.10 stddev:106647.68 (264.9%) stddev-sans-first:106867.90 09:22:04 INFO - 2016-01-22 09:22:04,864 DEBUG : BROWSER_OUTPUT: Values: 611.7 641.6 655.9 663.7 695.5 32747.5 41659.0 41765.4 41825.8 42136.2 46076.1 46449.5 46525.5 46597.5 46767.8 9035.6 9121.8 9211.5 9235.4 9244.0 8957.3 9029.8 9058.4 9100.8 9110.5 9051.4 9112.9 9113.0 9126.3 9128.8 8953.9 8981.9 8987.6 8994.8 9016.0 8857.2 8986.1 9006.7 9064.2 9091.8 42348.2 42709.4 42720.4 43038.4 43148.8 3474.4 3529.2 3567.4 3714.6 3845.6 32114.7 32419.5 32496.8 32749.3 33302.7 3766.3 3935.0 4016.7 4087.8 4135.9 289432.0 291998.0 292265.0 292327.0 293036.0 45607.5 45685.3 45697.0 45721.0 66024.3 44844.3 44905.6 44990.1 45086.3 45123.3 16327.5 16374.1 16428.3 16481.6 16521.0 13193.5 13349.8 13385.4 13389.7 13505.6 15682.2 15713.4 15714.1 15846.7 15854.3 6223.2 6365.6 6367.4 6376.8 6483.4 1026.1 1038.9 1139.8 1152.7 1186.7 29566.9 33477.3 34357.0 34686.3 34946.0 1119.2 1131.5 1156.6 1204.4 1217.7 15332.5 15541.5 15572.1 15576.3 15902.4 450858.0 543362.0 551341.0 553613.0 580683.0 58634.7 59521.7 59561.0 59589.7 59642.4 1488.6 1496.1 1500.6 1502.2 1509.5 30771.7 31375.7 31446.4 31715.2 31882.4 48574.0 49119.5 49195.3 49246.3 49262.3 331584.0 331941.0 332406.0 334142.0 334601.0 33382.7 33510.7 33662.5 33724.0 33803.5 54360.0 54448.0 55131.4 55364.4 56134.2 37135.4 38459.2 38962.0 39296.0 40250.2 40138.0 40268.0 40722.4 40940.4 41105.6 39326.8 43641.3 43899.6 43917.6 44839.0 34616.3 34637.1 34810.5 34846.7 39268.0 26433.7 27203.0 27410.5 27429.5 27471.3 09:22:04 INFO - 2016-01-22 09:22:04,864 DEBUG : BROWSER_OUTPUT: 09:22:04 INFO - 2016-01-22 09:22:04,864 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32404.71 Median:2017.50 stddev:102884.63 (5099.6%) stddev-sans-first:103145.15 09:22:04 INFO - 2016-01-22 09:22:04,864 DEBUG : BROWSER_OUTPUT: Values: 381.8 383.6 387.2 388.4 391.2 16458.3 17369.0 18672.4 20508.4 20544.1 11595.7 11747.5 13461.7 18156.3 18181.5 4427.5 5169.5 5246.9 5699.9 5722.5 5633.1 5707.1 5713.1 5714.7 5718.9 5522.4 5610.2 5614.2 5633.9 5657.5 5533.5 5546.3 5547.7 5555.4 5581.9 4923.5 5000.5 5010.9 5028.8 5044.6 21308.3 21832.0 21894.7 21952.8 22499.4 2182.5 2219.0 2242.4 2352.0 2363.1 10545.8 13337.9 13953.9 14175.3 14310.5 1935.0 1979.1 1993.7 2009.6 2025.4 63612.7 64038.0 65796.3 65915.7 67862.0 10536.9 10725.3 10750.4 10771.2 10911.6 14325.3 14437.4 14510.0 14537.7 14559.1 8508.0 8533.7 8561.1 8619.1 8652.0 8556.9 8559.6 8604.2 8620.2 8635.3 4538.0 4558.0 4563.4 4622.1 4629.3 1810.9 1818.2 1883.6 1902.7 1926.2 987.8 998.6 1021.0 1035.9 1111.7 17771.4 17879.2 17979.6 18385.4 18652.5 986.4 995.7 1077.7 1078.6 1094.6 9842.8 10194.4 10197.7 10232.4 10234.9 619862.0 620402.0 631625.0 638265.0 644810.0 69358.0 70474.3 73645.6 85471.1 86326.0 1153.7 1177.0 1191.7 1196.7 1203.1 15808.9 15920.6 15975.6 16024.6 16633.8 36742.4 36988.8 37573.8 38493.6 38857.6 48708.8 49731.3 49929.8 50536.0 50597.7 9894.4 10003.1 10353.2 10420.7 10422.4 17963.5 18260.8 18846.0 18891.3 19319.5 15733.6 15825.5 15907.4 16030.5 16168.7 14713.9 15089.4 15448.8 15919.9 16019.7 15465.8 15838.5 15864.3 15972.4 16365.9 13564.9 14217.7 15538.4 15612.5 16034.3 16988.5 17171.0 17558.3 18081.5 18201.7 09:22:04 INFO - 2016-01-22 09:22:04,864 DEBUG : BROWSER_OUTPUT: 09:22:04 INFO - 2016-01-22 09:22:04,864 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5785.52 Median:6443.31 stddev:3040.38 (47.2%) stddev-sans-first:3032.30 09:22:04 INFO - 2016-01-22 09:22:04,866 DEBUG : BROWSER_OUTPUT: Values: 1557.7 1606.0 1867.6 1892.8 1893.9 8187.3 8284.8 8351.0 8515.1 8525.1 8400.8 8416.8 8516.3 8522.1 8531.1 2275.2 2320.9 2325.6 2332.2 2335.1 2409.8 2420.4 2421.8 2431.5 2456.8 2309.6 2337.1 2349.8 2358.3 2374.3 2304.0 2347.5 2371.4 2372.7 2379.2 2364.1 2387.5 2388.0 2388.2 2390.9 8254.0 8321.5 8322.6 8329.0 8342.6 4859.9 4918.2 4946.8 4982.8 4984.6 3157.7 3161.5 3189.8 3202.1 3202.8 1025.9 1031.3 1031.3 1067.1 1088.0 11408.1 11449.3 11532.9 11564.1 11574.0 4237.2 4300.0 4306.8 4337.6 4357.9 9355.8 9356.0 9358.8 9364.3 9375.5 4857.8 4870.6 4879.2 4900.1 4911.2 4453.6 4462.8 4495.9 4500.0 4507.0 3489.3 3503.2 3518.4 3521.6 3569.6 1046.5 1047.3 1052.9 1074.9 1211.9 1116.1 1146.7 1152.5 1154.7 1182.3 7785.0 7805.5 7868.0 7875.8 7906.2 1159.0 1172.5 1176.1 1192.3 1201.8 6163.4 6193.3 6202.8 6219.2 6258.2 9908.4 9915.8 9928.1 9998.5 10042.4 9682.2 9812.3 9816.9 9956.1 9966.2 7788.5 7890.0 7900.2 7913.1 7921.5 7719.2 7793.6 7818.9 7833.4 7836.8 8918.3 8931.5 8944.6 8979.6 8988.5 9046.4 9140.3 9148.4 9156.5 9340.1 7347.6 7454.9 7490.3 7519.9 7521.3 7735.1 7750.4 7781.7 7789.0 8039.2 7200.9 7380.9 7486.3 7501.8 7519.6 7356.8 7359.7 7403.4 7475.4 7512.6 7629.9 7636.2 7654.1 7687.3 7690.7 6628.4 6635.3 6686.8 6688.7 6695.4 6700.9 6752.6 6765.9 6772.0 6784.3 09:22:04 INFO - 2016-01-22 09:22:04,866 DEBUG : BROWSER_OUTPUT: 09:22:04 INFO - 2016-01-22 09:22:04,866 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5618.57 Median:6500.77 stddev:1706.77 (26.3%) stddev-sans-first:1665.23 09:22:04 INFO - 2016-01-22 09:22:04,866 DEBUG : BROWSER_OUTPUT: Values: 356.2 356.8 358.2 360.2 364.7 6289.4 6364.3 6398.5 6412.0 6445.3 6181.3 6360.7 6363.6 6370.0 6373.7 4849.2 4891.1 4891.5 4895.0 4901.4 4899.5 4901.3 4903.1 4906.1 4915.4 4655.7 4807.8 4828.0 4831.0 4832.8 4784.1 4806.8 4812.8 4813.5 4819.5 4171.0 4176.5 4180.6 4190.4 4191.2 5963.9 6055.2 6062.1 6062.2 6068.6 5571.4 5586.8 5590.9 5595.9 5607.0 6675.8 6717.5 6731.8 6738.3 6775.6 4616.8 4621.1 4628.3 4632.7 4635.8 6829.2 6929.5 6978.7 6998.9 6998.9 4590.6 4608.8 4609.9 4610.4 4616.3 4646.3 4661.3 4670.3 4671.9 4672.0 5460.9 5464.6 5468.9 5484.2 5487.1 6643.9 6810.8 6812.6 6822.6 6825.0 1629.9 1653.9 1654.2 1654.5 1654.6 1115.1 1119.5 1127.8 1142.9 1150.5 6543.1 6551.5 6567.2 6577.5 6591.7 6915.4 6959.5 6967.3 6969.7 6978.3 6480.6 6559.9 6567.5 6568.0 6575.4 3765.4 3781.1 3806.5 3810.0 3815.6 7106.6 7114.6 7118.2 7145.4 7148.3 6926.4 7105.1 7105.8 7136.9 7147.5 7107.2 7111.1 7111.2 7122.4 7162.7 6906.4 6945.3 6978.9 6981.4 6989.0 6721.3 6828.1 6867.9 6890.0 6894.7 7092.3 7134.2 7137.7 7139.8 7155.2 4730.9 4738.6 4744.9 4749.1 4752.0 6783.1 6957.3 6959.6 6973.5 6985.7 6697.5 6757.1 6758.5 6769.5 6775.3 6697.7 6745.4 6753.6 6767.7 6769.2 6520.9 6628.8 6659.1 6660.3 6671.2 6798.6 6807.5 6807.9 6813.2 6825.8 6592.2 6626.5 6643.7 6649.1 6664.0 09:22:04 INFO - 2016-01-22 09:22:04,866 DEBUG : BROWSER_OUTPUT: 09:22:04 INFO - 2016-01-22 09:22:04,866 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14208.17 Median:47582.02 stddev:16449.89 (34.6%) stddev-sans-first:16465.11 09:22:04 INFO - 2016-01-22 09:22:04,867 DEBUG : BROWSER_OUTPUT: Values: 776.1 803.5 815.2 861.2 939.5 13091.6 13286.3 13310.5 13329.9 13343.7 12347.9 12721.6 12740.7 12806.3 13701.3 903.1 911.6 917.8 923.2 924.6 904.1 915.2 917.3 920.4 923.1 958.3 963.3 965.7 966.9 967.5 955.2 958.2 961.1 963.1 965.0 702.2 703.9 704.9 706.9 708.2 12726.2 12748.6 12804.8 12845.3 12907.0 12964.0 13078.7 13080.9 13148.0 13212.3 10294.2 10389.6 10437.8 10454.5 10492.0 3817.7 3887.1 3907.9 3912.8 3915.0 47685.8 47850.5 49483.0 51956.7 51996.2 9782.3 9801.0 9983.6 10005.5 10061.4 17317.3 17320.6 17381.4 17423.4 17425.8 6795.2 6817.6 6836.4 6886.5 7085.8 4744.6 4883.5 4948.4 4977.2 5018.6 3249.7 3264.1 3269.4 3288.6 3291.6 582.7 589.5 602.8 623.0 633.3 571.7 679.4 685.9 704.4 753.1 8871.6 9387.1 9591.3 9658.1 9948.4 603.5 668.8 686.2 716.7 735.6 4392.2 4420.3 4520.1 4630.9 4684.6 55968.0 60100.0 60216.0 61116.7 61332.0 50315.2 51018.0 51452.0 56367.6 57970.7 46616.8 46759.5 47082.0 47547.5 47616.5 9021.0 9350.3 9525.5 9593.9 9827.7 35098.3 35318.0 35623.3 37412.3 38297.2 44698.0 45402.0 45817.3 45913.3 46087.3 11666.4 11696.5 11853.9 12116.5 12140.6 12623.4 13042.3 13141.8 13382.0 13433.5 11468.5 11960.9 11977.0 12122.4 12758.9 11314.7 11457.5 11563.8 11599.2 11654.6 10646.5 10683.1 10712.0 11573.8 11730.3 9924.2 10388.6 10548.4 11097.4 11243.9 9275.3 9717.5 9757.6 9854.8 9894.4 09:22:04 INFO - 2016-01-22 09:22:04,867 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:22:04 INFO - 2016-01-22 09:22:04,867 DEBUG : BROWSER_OUTPUT: 09:22:05 INFO - 2016-01-22 09:22:05,487 INFO : Browser exited with error code: 0 09:22:05 INFO - 2016-01-22 09:22:05,510 INFO : Completed test dromaeo_css (00:18:29) 09:22:05 INFO - 2016-01-22 09:22:05,511 INFO : Starting test kraken 09:22:05 INFO - 2016-01-22 09:22:05,511 DEBUG : operating with platform_type : linux_ 09:22:05 INFO - 2016-01-22 09:22:05,511 INFO : Initialising browser for kraken test... 09:22:05 INFO - 2016-01-22 09:22:05,517 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkCBoq_/profile http://localhost:53454/getInfo.html 09:22:09 INFO - 2016-01-22 09:22:09,796 DEBUG : BROWSER_OUTPUT: 09:22:09 INFO - 2016-01-22 09:22:09,797 DEBUG : BROWSER_OUTPUT: (process:18401): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:22:10 INFO - 2016-01-22 09:22:10,886 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:22:10 INFO - 2016-01-22 09:22:10,887 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:22:10 INFO - 2016-01-22 09:22:10,887 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:22:10 INFO - 2016-01-22 09:22:10,887 DEBUG : BROWSER_OUTPUT: __metrics 09:22:11 INFO - 2016-01-22 09:22:11,835 INFO : Browser initialized. 09:22:11 INFO - 2016-01-22 09:22:11,835 INFO : Running cycle 1/1 for kraken test... 09:22:11 INFO - 2016-01-22 09:22:11,836 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkCBoq_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:22:13 INFO - 2016-01-22 09:22:13,121 DEBUG : BROWSER_OUTPUT: 09:22:13 INFO - 2016-01-22 09:22:13,121 DEBUG : BROWSER_OUTPUT: (process:18519): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:22:23 INFO - 2016-01-22 09:22:23,630 DEBUG : BROWSER_OUTPUT: RSS: Main: 136851456 09:22:23 INFO - 2016-01-22 09:22:23,630 DEBUG : BROWSER_OUTPUT: 09:22:26 INFO - 2016-01-22 09:22:26,137 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53454/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53454/tests/kraken/driver.html?testName=audio-beat-detection) 09:22:26 INFO - 2016-01-22 09:22:26,740 DEBUG : BROWSER_OUTPUT: RSS: Main: 139051008 09:22:26 INFO - 2016-01-22 09:22:26,740 DEBUG : BROWSER_OUTPUT: 09:22:29 INFO - 2016-01-22 09:22:29,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53454/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53454/tests/kraken/driver.html?testName=audio-dft) 09:22:29 INFO - 2016-01-22 09:22:29,929 DEBUG : BROWSER_OUTPUT: RSS: Main: 137564160 09:22:29 INFO - 2016-01-22 09:22:29,929 DEBUG : BROWSER_OUTPUT: 09:22:32 INFO - 2016-01-22 09:22:32,749 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53454/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53454/tests/kraken/driver.html?testName=audio-fft) 09:22:33 INFO - 2016-01-22 09:22:33,320 DEBUG : BROWSER_OUTPUT: RSS: Main: 138878976 09:22:33 INFO - 2016-01-22 09:22:33,320 DEBUG : BROWSER_OUTPUT: 09:22:35 INFO - 2016-01-22 09:22:35,305 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53454/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53454/tests/kraken/driver.html?testName=audio-oscillator) 09:22:35 INFO - 2016-01-22 09:22:35,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 139624448 09:22:35 INFO - 2016-01-22 09:22:35,891 DEBUG : BROWSER_OUTPUT: 09:22:38 INFO - 2016-01-22 09:22:38,073 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53454/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53454/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:22:38 INFO - 2016-01-22 09:22:38,648 DEBUG : BROWSER_OUTPUT: RSS: Main: 138657792 09:22:38 INFO - 2016-01-22 09:22:38,648 DEBUG : BROWSER_OUTPUT: 09:22:41 INFO - 2016-01-22 09:22:41,588 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53454/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53454/tests/kraken/driver.html?testName=imaging-darkroom) 09:22:42 INFO - 2016-01-22 09:22:42,174 DEBUG : BROWSER_OUTPUT: RSS: Main: 138403840 09:22:42 INFO - 2016-01-22 09:22:42,174 DEBUG : BROWSER_OUTPUT: 09:22:45 INFO - 2016-01-22 09:22:45,557 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53454/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53454/tests/kraken/driver.html?testName=imaging-desaturate) 09:22:46 INFO - 2016-01-22 09:22:46,146 DEBUG : BROWSER_OUTPUT: RSS: Main: 138514432 09:22:46 INFO - 2016-01-22 09:22:46,147 DEBUG : BROWSER_OUTPUT: 09:22:48 INFO - 2016-01-22 09:22:48,949 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53454/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53454/tests/kraken/driver.html?testName=json-parse-financial) 09:22:49 INFO - 2016-01-22 09:22:49,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 138403840 09:22:49 INFO - 2016-01-22 09:22:49,537 DEBUG : BROWSER_OUTPUT: 09:22:51 INFO - 2016-01-22 09:22:51,125 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53454/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53454/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:22:51 INFO - 2016-01-22 09:22:51,692 DEBUG : BROWSER_OUTPUT: RSS: Main: 139546624 09:22:51 INFO - 2016-01-22 09:22:51,692 DEBUG : BROWSER_OUTPUT: 09:22:53 INFO - 2016-01-22 09:22:53,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53454/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53454/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:22:54 INFO - 2016-01-22 09:22:54,069 DEBUG : BROWSER_OUTPUT: RSS: Main: 139112448 09:22:54 INFO - 2016-01-22 09:22:54,069 DEBUG : BROWSER_OUTPUT: 09:22:56 INFO - 2016-01-22 09:22:56,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53454/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53454/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:22:56 INFO - 2016-01-22 09:22:56,717 DEBUG : BROWSER_OUTPUT: RSS: Main: 139010048 09:22:56 INFO - 2016-01-22 09:22:56,717 DEBUG : BROWSER_OUTPUT: 09:22:59 INFO - 2016-01-22 09:22:59,105 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53454/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53454/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:22:59 INFO - 2016-01-22 09:22:59,699 DEBUG : BROWSER_OUTPUT: RSS: Main: 138702848 09:22:59 INFO - 2016-01-22 09:22:59,699 DEBUG : BROWSER_OUTPUT: 09:23:02 INFO - 2016-01-22 09:23:02,226 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53454/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53454/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:23:02 INFO - 2016-01-22 09:23:02,813 DEBUG : BROWSER_OUTPUT: RSS: Main: 139599872 09:23:02 INFO - 2016-01-22 09:23:02,813 DEBUG : BROWSER_OUTPUT: 09:23:04 INFO - 2016-01-22 09:23:04,470 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53454/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53454/tests/kraken/driver.html?testName=ai-astar) 09:23:04 INFO - 2016-01-22 09:23:04,720 DEBUG : BROWSER_OUTPUT: RSS: Main: 139710464 09:23:04 INFO - 2016-01-22 09:23:04,721 DEBUG : BROWSER_OUTPUT: 09:23:04 INFO - 2016-01-22 09:23:04,722 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:23:04 INFO - 2016-01-22 09:23:04,722 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:23:04 INFO - 2016-01-22 09:23:04,722 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:23:04 INFO - 2016-01-22 09:23:04,722 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:23:04 INFO - 2016-01-22 09:23:04,723 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;104;110;112;110;122;113;110;109;111 09:23:04 INFO - 2016-01-22 09:23:04,723 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;142;128;152;156;124;146;157;128;179;127 09:23:04 INFO - 2016-01-22 09:23:04,723 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;162;161;163;164;162;160;164;163 09:23:04 INFO - 2016-01-22 09:23:04,723 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;73;72;152;72;76;71;74;161;74 09:23:04 INFO - 2016-01-22 09:23:04,723 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;138;92;92;93;134;93;92;135 09:23:04 INFO - 2016-01-22 09:23:04,724 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;109;113;110;110;110;109 09:23:04 INFO - 2016-01-22 09:23:04,724 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;145;147;147;148;146;146;148;146;146 09:23:04 INFO - 2016-01-22 09:23:04,724 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;96;97;96;96;98;96;96;96 09:23:04 INFO - 2016-01-22 09:23:04,724 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;61;59;60;61;62;64;60;57;62 09:23:04 INFO - 2016-01-22 09:23:04,724 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;63;64;63;64;64;66;64;63 09:23:04 INFO - 2016-01-22 09:23:04,724 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;90;83;82;82;82;83;85;91 09:23:04 INFO - 2016-01-22 09:23:04,725 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;114;114;113;118;123;118;120;114;118 09:23:04 INFO - 2016-01-22 09:23:04,725 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;146;151;145;146;142;157;136;148;148 09:23:04 INFO - 2016-01-22 09:23:04,725 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;66;67;65;66;65;64;67;64;64 09:23:04 INFO - 2016-01-22 09:23:04,725 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:23:04 INFO - 2016-01-22 09:23:04,725 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:23:04 INFO - 2016-01-22 09:23:04,725 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,706 09:23:04 INFO - 2016-01-22 09:23:04,725 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:23:04 INFO - 2016-01-22 09:23:04,726 DEBUG : BROWSER_OUTPUT: __startTimestamp1453483384721__endTimestamp 09:23:04 INFO - 2016-01-22 09:23:04,726 DEBUG : BROWSER_OUTPUT: 09:23:04 INFO - 2016-01-22 09:23:04,729 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:23:04 INFO - 2016-01-22 09:23:04,729 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:23:04 INFO - 2016-01-22 09:23:04,729 DEBUG : BROWSER_OUTPUT: 09:23:04 INFO - 2016-01-22 09:23:04,729 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.30 Median:111.50 stddev:4.50 (4.0%) stddev-sans-first:4.76 09:23:04 INFO - 2016-01-22 09:23:04,729 DEBUG : BROWSER_OUTPUT: Values: 112.0 104.0 110.0 112.0 110.0 122.0 113.0 110.0 109.0 111.0 09:23:04 INFO - 2016-01-22 09:23:04,729 DEBUG : BROWSER_OUTPUT: 09:23:04 INFO - 2016-01-22 09:23:04,730 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.90 Median:149.00 stddev:17.67 (11.9%) stddev-sans-first:18.73 09:23:04 INFO - 2016-01-22 09:23:04,730 DEBUG : BROWSER_OUTPUT: Values: 142.0 128.0 152.0 156.0 124.0 146.0 157.0 128.0 179.0 127.0 09:23:04 INFO - 2016-01-22 09:23:04,730 DEBUG : BROWSER_OUTPUT: 09:23:04 INFO - 2016-01-22 09:23:04,730 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.00 Median:162.50 stddev:1.49 (0.9%) stddev-sans-first:1.54 09:23:04 INFO - 2016-01-22 09:23:04,730 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 162.0 161.0 163.0 164.0 162.0 160.0 164.0 163.0 09:23:04 INFO - 2016-01-22 09:23:04,730 DEBUG : BROWSER_OUTPUT: 09:23:04 INFO - 2016-01-22 09:23:04,730 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.90 Median:73.50 stddev:35.19 (47.9%) stddev-sans-first:36.85 09:23:04 INFO - 2016-01-22 09:23:04,730 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 72.0 152.0 72.0 76.0 71.0 74.0 161.0 74.0 09:23:04 INFO - 2016-01-22 09:23:04,730 DEBUG : BROWSER_OUTPUT: 09:23:04 INFO - 2016-01-22 09:23:04,731 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.50 Median:92.50 stddev:20.84 (22.5%) stddev-sans-first:21.61 09:23:04 INFO - 2016-01-22 09:23:04,731 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 138.0 92.0 92.0 93.0 134.0 93.0 92.0 135.0 09:23:04 INFO - 2016-01-22 09:23:04,731 DEBUG : BROWSER_OUTPUT: 09:23:04 INFO - 2016-01-22 09:23:04,731 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:1.10 (1.0%) stddev-sans-first:1.17 09:23:04 INFO - 2016-01-22 09:23:04,731 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 109.0 113.0 110.0 110.0 110.0 109.0 09:23:04 INFO - 2016-01-22 09:23:04,732 DEBUG : BROWSER_OUTPUT: 09:23:04 INFO - 2016-01-22 09:23:04,732 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 09:23:04 INFO - 2016-01-22 09:23:04,732 DEBUG : BROWSER_OUTPUT: Values: 147.0 145.0 147.0 147.0 148.0 146.0 146.0 148.0 146.0 146.0 09:23:04 INFO - 2016-01-22 09:23:04,732 DEBUG : BROWSER_OUTPUT: 09:23:04 INFO - 2016-01-22 09:23:04,732 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 09:23:04 INFO - 2016-01-22 09:23:04,732 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 96.0 97.0 96.0 96.0 98.0 96.0 96.0 96.0 09:23:04 INFO - 2016-01-22 09:23:04,732 DEBUG : BROWSER_OUTPUT: 09:23:04 INFO - 2016-01-22 09:23:04,732 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.40 Median:61.00 stddev:2.07 (3.4%) stddev-sans-first:2.00 09:23:04 INFO - 2016-01-22 09:23:04,732 DEBUG : BROWSER_OUTPUT: Values: 58.0 61.0 59.0 60.0 61.0 62.0 64.0 60.0 57.0 62.0 09:23:04 INFO - 2016-01-22 09:23:04,732 DEBUG : BROWSER_OUTPUT: 09:23:04 INFO - 2016-01-22 09:23:04,732 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:64.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 09:23:04 INFO - 2016-01-22 09:23:04,732 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 63.0 64.0 63.0 64.0 64.0 66.0 64.0 63.0 09:23:04 INFO - 2016-01-22 09:23:04,732 DEBUG : BROWSER_OUTPUT: 09:23:04 INFO - 2016-01-22 09:23:04,732 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:83.00 stddev:3.46 (4.2%) stddev-sans-first:3.57 09:23:04 INFO - 2016-01-22 09:23:04,732 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 90.0 83.0 82.0 82.0 82.0 83.0 85.0 91.0 09:23:04 INFO - 2016-01-22 09:23:04,733 DEBUG : BROWSER_OUTPUT: 09:23:04 INFO - 2016-01-22 09:23:04,733 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:116.80 Median:118.00 stddev:3.19 (2.7%) stddev-sans-first:3.37 09:23:04 INFO - 2016-01-22 09:23:04,733 DEBUG : BROWSER_OUTPUT: Values: 116.0 114.0 114.0 113.0 118.0 123.0 118.0 120.0 114.0 118.0 09:23:04 INFO - 2016-01-22 09:23:04,733 DEBUG : BROWSER_OUTPUT: 09:23:04 INFO - 2016-01-22 09:23:04,733 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.50 Median:147.00 stddev:6.40 (4.4%) stddev-sans-first:5.79 09:23:04 INFO - 2016-01-22 09:23:04,733 DEBUG : BROWSER_OUTPUT: Values: 136.0 146.0 151.0 145.0 146.0 142.0 157.0 136.0 148.0 148.0 09:23:04 INFO - 2016-01-22 09:23:04,733 DEBUG : BROWSER_OUTPUT: 09:23:04 INFO - 2016-01-22 09:23:04,733 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:1.43 (2.2%) stddev-sans-first:1.22 09:23:04 INFO - 2016-01-22 09:23:04,733 DEBUG : BROWSER_OUTPUT: Values: 68.0 66.0 67.0 65.0 66.0 65.0 64.0 67.0 64.0 64.0 09:23:04 INFO - 2016-01-22 09:23:04,733 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:23:04 INFO - 2016-01-22 09:23:04,733 DEBUG : BROWSER_OUTPUT: 09:23:05 INFO - 2016-01-22 09:23:05,743 INFO : Browser exited with error code: 0 09:23:05 INFO - 2016-01-22 09:23:05,797 INFO : Completed test kraken (00:01:00) 09:23:05 INFO - 2016-01-22 09:23:05,797 INFO : Starting test v8_7 09:23:05 INFO - 2016-01-22 09:23:05,797 DEBUG : operating with platform_type : linux_ 09:23:05 INFO - 2016-01-22 09:23:05,797 INFO : Initialising browser for v8_7 test... 09:23:05 INFO - 2016-01-22 09:23:05,803 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyfv49B/profile http://localhost:53454/getInfo.html 09:23:09 INFO - 2016-01-22 09:23:09,933 DEBUG : BROWSER_OUTPUT: 09:23:09 INFO - 2016-01-22 09:23:09,933 DEBUG : BROWSER_OUTPUT: (process:18831): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:23:10 INFO - 2016-01-22 09:23:10,958 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:23:10 INFO - 2016-01-22 09:23:10,958 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:23:10 INFO - 2016-01-22 09:23:10,958 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:23:10 INFO - 2016-01-22 09:23:10,958 DEBUG : BROWSER_OUTPUT: __metrics 09:23:12 INFO - 2016-01-22 09:23:12,031 INFO : Browser initialized. 09:23:12 INFO - 2016-01-22 09:23:12,031 INFO : Running cycle 1/1 for v8_7 test... 09:23:12 INFO - 2016-01-22 09:23:12,032 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyfv49B/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:23:13 INFO - 2016-01-22 09:23:13,388 DEBUG : BROWSER_OUTPUT: 09:23:13 INFO - 2016-01-22 09:23:13,389 DEBUG : BROWSER_OUTPUT: (process:18944): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:23:23 INFO - 2016-01-22 09:23:23,894 DEBUG : BROWSER_OUTPUT: RSS: Main: 137265152 09:23:23 INFO - 2016-01-22 09:23:23,895 DEBUG : BROWSER_OUTPUT: 09:23:45 INFO - 2016-01-22 09:23:45,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53454/tests/v8_7/run.html (next: http://localhost:53454/tests/v8_7/run.html) 09:23:45 INFO - 2016-01-22 09:23:45,497 DEBUG : BROWSER_OUTPUT: RSS: Main: 137240576 09:23:45 INFO - 2016-01-22 09:23:45,497 DEBUG : BROWSER_OUTPUT: 09:23:45 INFO - 2016-01-22 09:23:45,499 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:23:45 INFO - 2016-01-22 09:23:45,499 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:23:45 INFO - 2016-01-22 09:23:45,499 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:23:45 INFO - 2016-01-22 09:23:45,499 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:23:45 INFO - 2016-01-22 09:23:45,499 DEBUG : BROWSER_OUTPUT: |0;Richards;164.41959881617888 09:23:45 INFO - 2016-01-22 09:23:45,499 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;167.0564650851988 09:23:45 INFO - 2016-01-22 09:23:45,499 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.3296089385475 09:23:45 INFO - 2016-01-22 09:23:45,500 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 09:23:45 INFO - 2016-01-22 09:23:45,500 DEBUG : BROWSER_OUTPUT: |4;RayTrace;911.5770282588878 09:23:45 INFO - 2016-01-22 09:23:45,500 DEBUG : BROWSER_OUTPUT: |5;Earley;547.0459518599563 09:23:45 INFO - 2016-01-22 09:23:45,500 DEBUG : BROWSER_OUTPUT: |6;Boyer;11144.444444444445 09:23:45 INFO - 2016-01-22 09:23:45,500 DEBUG : BROWSER_OUTPUT: |7;RegExp;24951.219512195123 09:23:45 INFO - 2016-01-22 09:23:45,500 DEBUG : BROWSER_OUTPUT: |8;Splay;519.2107995846313 09:23:45 INFO - 2016-01-22 09:23:45,500 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 09:23:45 INFO - 2016-01-22 09:23:45,500 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:23:45 INFO - 2016-01-22 09:23:45,500 DEBUG : BROWSER_OUTPUT: __startTimestamp1453483425497__endTimestamp 09:23:45 INFO - 2016-01-22 09:23:45,501 DEBUG : BROWSER_OUTPUT: 09:23:45 INFO - 2016-01-22 09:23:45,501 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:23:45 INFO - 2016-01-22 09:23:45,501 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:23:45 INFO - 2016-01-22 09:23:45,501 DEBUG : BROWSER_OUTPUT: 09:23:45 INFO - 2016-01-22 09:23:45,501 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.42 Median:164.42 stddev:0.00 (0.0%) 09:23:45 INFO - 2016-01-22 09:23:45,501 DEBUG : BROWSER_OUTPUT: Values: 164.4 09:23:45 INFO - 2016-01-22 09:23:45,501 DEBUG : BROWSER_OUTPUT: 09:23:45 INFO - 2016-01-22 09:23:45,501 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:167.06 Median:167.06 stddev:0.00 (0.0%) 09:23:45 INFO - 2016-01-22 09:23:45,501 DEBUG : BROWSER_OUTPUT: Values: 167.1 09:23:45 INFO - 2016-01-22 09:23:45,502 DEBUG : BROWSER_OUTPUT: 09:23:45 INFO - 2016-01-22 09:23:45,502 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.33 Median:279.33 stddev:0.00 (0.0%) 09:23:45 INFO - 2016-01-22 09:23:45,502 DEBUG : BROWSER_OUTPUT: Values: 279.3 09:23:45 INFO - 2016-01-22 09:23:45,502 DEBUG : BROWSER_OUTPUT: 09:23:45 INFO - 2016-01-22 09:23:45,502 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 09:23:45 INFO - 2016-01-22 09:23:45,502 DEBUG : BROWSER_OUTPUT: Values: 5133.3 09:23:45 INFO - 2016-01-22 09:23:45,502 DEBUG : BROWSER_OUTPUT: 09:23:45 INFO - 2016-01-22 09:23:45,502 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:911.58 Median:911.58 stddev:0.00 (0.0%) 09:23:45 INFO - 2016-01-22 09:23:45,502 DEBUG : BROWSER_OUTPUT: Values: 911.6 09:23:45 INFO - 2016-01-22 09:23:45,502 DEBUG : BROWSER_OUTPUT: 09:23:45 INFO - 2016-01-22 09:23:45,502 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:547.05 Median:547.05 stddev:0.00 (0.0%) 09:23:45 INFO - 2016-01-22 09:23:45,502 DEBUG : BROWSER_OUTPUT: Values: 547.0 09:23:45 INFO - 2016-01-22 09:23:45,503 DEBUG : BROWSER_OUTPUT: 09:23:45 INFO - 2016-01-22 09:23:45,503 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11144.44 Median:11144.44 stddev:0.00 (0.0%) 09:23:45 INFO - 2016-01-22 09:23:45,503 DEBUG : BROWSER_OUTPUT: Values: 11144.4 09:23:45 INFO - 2016-01-22 09:23:45,503 DEBUG : BROWSER_OUTPUT: 09:23:45 INFO - 2016-01-22 09:23:45,503 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24951.22 Median:24951.22 stddev:0.00 (0.0%) 09:23:45 INFO - 2016-01-22 09:23:45,503 DEBUG : BROWSER_OUTPUT: Values: 24951.2 09:23:45 INFO - 2016-01-22 09:23:45,503 DEBUG : BROWSER_OUTPUT: 09:23:45 INFO - 2016-01-22 09:23:45,503 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:519.21 Median:519.21 stddev:0.00 (0.0%) 09:23:45 INFO - 2016-01-22 09:23:45,503 DEBUG : BROWSER_OUTPUT: Values: 519.2 09:23:45 INFO - 2016-01-22 09:23:45,503 DEBUG : BROWSER_OUTPUT: 09:23:45 INFO - 2016-01-22 09:23:45,503 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 09:23:45 INFO - 2016-01-22 09:23:45,503 DEBUG : BROWSER_OUTPUT: Values: 4845.4 09:23:45 INFO - 2016-01-22 09:23:45,504 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:23:45 INFO - 2016-01-22 09:23:45,504 DEBUG : BROWSER_OUTPUT: 09:23:46 INFO - 2016-01-22 09:23:46,419 INFO : Browser exited with error code: 0 09:23:46 INFO - 2016-01-22 09:23:46,431 INFO : Completed test v8_7 (00:00:40) 09:23:46 INFO - 2016-01-22 09:23:46,539 INFO : Completed test suite (00:20:10) 09:23:46 INFO - 2016-01-22 09:23:46,539 DEBUG : Working with test: dromaeo_css 09:23:46 INFO - 2016-01-22 09:23:46,539 DEBUG : Generating results file: dromaeo_css 09:23:46 INFO - 2016-01-22 09:23:46,540 DEBUG : Working with test: kraken 09:23:46 INFO - 2016-01-22 09:23:46,540 DEBUG : Generating results file: kraken 09:23:46 INFO - 2016-01-22 09:23:46,541 INFO : javascript benchmark 09:23:46 INFO - 2016-01-22 09:23:46,541 DEBUG : Working with test: v8_7 09:23:46 INFO - 2016-01-22 09:23:46,541 DEBUG : Generating results file: v8_7 09:23:46 INFO - 2016-01-22 09:23:46,541 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:23:46 INFO - 2016-01-22 09:23:46,599 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 09:23:46 INFO - 2016-01-22 09:23:46,599 DEBUG : process_Request line: dromaeo_css 7423.15 graph.html#tests=[[72,52,43]] 09:23:46 INFO - 2016-01-22 09:23:46,599 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:23:46 INFO - 2016-01-22 09:23:46,630 DEBUG : process_Request line: kraken 1502.00 graph.html#tests=[[232,52,43]] 09:23:46 INFO - 2016-01-22 09:23:46,630 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:23:46 INFO - 2016-01-22 09:23:46,658 DEBUG : process_Request line: v8_7 23208.79 graph.html#tests=[[230,52,43]] 09:23:46 INFO - 2016-01-22 09:23:46,660 INFO : javascript benchmark 09:23:46 INFO - 2016-01-22 09:23:46,663 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3342.882999095031, 3417.5044618530314, 3436.570428696413, 3437.1235334989574, 3442.2082920928187, 5579.358373787016, 5586.972065139674, 5588.720563971795, 5592.720363981794, 5601.29983752031, 5531.778728850841, 5618.859528511779, 5628.831135065944, 5652.830415087544, 5677.744501497432, 5104.999999999991, 5147.0992576298995, 5162.741862906859, 5173.275741396207, 5209.192575150839, 4977.701337919718, 5044.82343117991, 5082.51716086973, 5098.847034588968, 5156.8710782230555, 5064.518870707277, 5136.666116702421, 5140.614453915971, 5141.228815677659, 5146.125158723007, 5123.308353372285, 5126.461721519243, 5177.456367081478, 5179.766910488999, 5199.454057324002, 4881.292212629149, 4945.9258111128365, 4988.127077761414, 5005.974970125162, 5092.26162206478, 5375.005623959541, 5400.351957765054, 5420.07858664028, 5439.5376393006645, 5444.8366549003595, 5952.523798096142, 5967.343592204854, 5995.400459953969, 6002.3697511761075, 6043.3956604339655, 5729.484346408802, 5920.082387229986, 6023.939760602381, 6121.0, 6123.87752244957, 5611.719414029323, 5618.185363122325, 5626.634268772557, 5637.069883469223, 5640.7743690252755, 5697.686627235459, 6134.9079763803575, 6147.0779383092, 6147.846303842351, 6159.938400615936, 5759.078547432475, 5896.64620122794, 5998.520118390518, 6015.819525414245, 6027.367126451747, 6072.817815465543, 6073.301570319381, 6080.57435979486, 6080.665563394055, 6091.269047714302, 5765.308163020381, 6038.426349496791, 6050.969745151334, 6075.453209211104, 6078.787242446493, 5932.228810254639, 6038.758449661965, 6085.056816193497, 6107.389261073857, 6143.293521245114, 4569.588737013684, 4577.153226653079, 4587.449506059227, 4593.219152744042, 4607.861764147081, 3996.4604778355133, 4075.1849630074103, 4126.958730412717, 4155.189738001121, 4173.0, 5727.971360143256, 5729.369769325371, 5731.054376027909, 5812.796552120655, 5837.036888913367, 6043.153958445821, 6048.455638992512, 6048.576599637983, 6050.788222412194, 6064.48451881595, 5569.053260945568, 5667.744951477193, 5671.943280567224, 5694.1458781183155, 5706.0, 5211.270422140903, 5228.9477105229225, 5267.236250743697, 5313.920291195635, 5335.013022590833, 6058.606190597597, 6094.908576371358, 6097.542684298606, 6103.877922441527, 6121.908171377433, 5853.64878107315, 5940.108983652487, 6002.429769171922, 6002.579819412599, 6002.669853157943, 6005.129256257906, 6085.779948862308, 6109.725062372293, 6138.785142520169, 6149.938500614937, 5939.049752039653, 5988.981873081674, 6010.639361638316, 6016.42843929826, 6024.789132380346, 5843.590948633555, 5941.049432090845, 6138.478229350555, 6161.876762464815, 6163.229596300463, 5728.513076388387, 5853.180554722428, 5862.120681897579, 5862.765489380377, 5888.263967004124, 5942.881142377042, 5968.701564921824, 6009.729562169626, 6013.579049466495, 6018.729157188025, 5685.687287199078, 5706.80026199081, 5791.189233507396, 5862.530997520274, 5905.084711869667, 5914.497267732118, 5958.940410595838, 5960.850978725566, 5974.044152935509, 6024.307204671519, 5765.8558536036935, 5804.6807425592, 5810.82567522975, 5821.534277257894, 5832.883342333214], "unit": "ms", "name": "dojo.html", "value": 5546.107438273182}, {"lowerIsBetter": false, "replicates": [611.71249512729, 641.5990006246096, 655.9048937904004, 663.7112855907684, 695.5096656856916, 32747.50878736818, 41659.0, 41765.373519397195, 41825.790871045676, 42136.15727685444, 46076.07847843041, 46449.53550464503, 46525.53474465254, 46597.53402465974, 46767.766161169144, 9035.63857445703, 9121.817563648723, 9211.493367864765, 9235.353525253235, 9244.0, 8957.283417326598, 9029.819403611957, 9058.365914385995, 9100.772480688003, 9110.544472776368, 9051.411658242194, 9112.908870911306, 9113.0, 9126.269898408145, 9128.817423651522, 8953.865692014593, 8981.865272020892, 8987.595558199831, 8994.775130621754, 9016.0, 8857.247133993618, 8986.14631609996, 9006.684766033222, 9064.229540489066, 9091.818163636757, 42348.153036939395, 42709.35935960963, 42720.35919461211, 43038.35442468365, 43148.78425607852, 3474.3919814032442, 3529.2412131391875, 3567.3935430976794, 3714.609965953563, 3845.6346647068485, 32114.678853211404, 32419.51370729441, 32496.837515812505, 32749.345013099843, 33302.666973330444, 3766.322062028834, 3935.0, 4016.6786657067364, 4087.7747912304444, 4135.875923722263, 289432.0, 291998.0, 292265.0, 292327.0, 293035.99999999785, 45607.543924560996, 45685.314720279224, 45697.0, 45721.0, 66024.33975660279, 44844.32733509, 44905.55094449079, 44990.100197996515, 45086.32370514445, 45123.29260244396, 16327.510174694778, 16374.099424531527, 16428.342866285213, 16481.587960301087, 16521.0, 13193.538226162038, 13349.799753003712, 13385.397657105454, 13389.66525836862, 13505.594832155051, 15682.215889205721, 15713.371465141496, 15714.135722535142, 15846.683066338608, 15854.286557104728, 6223.222097237845, 6365.631389251241, 6367.363263673596, 6376.84057898547, 6483.448906842877, 1026.071405378134, 1038.8909164537765, 1139.7549526851767, 1152.7118220444888, 1186.7389174381622, 29566.852165739034, 33477.33045339128, 34357.0, 34686.306273874885, 34946.0, 1119.2109562758399, 1131.4908291268962, 1156.647222597116, 1204.4278967490548, 1217.6590554644713, 15332.463363782213, 15541.533753987398, 15572.096174732764, 15576.299066542033, 15902.44341448067, 450858.0, 543362.0, 551341.0, 553613.0, 580683.0, 58634.7068264656, 59521.70239148863, 59561.0, 59589.70205148947, 59642.403575964556, 1488.5906375746756, 1496.124767011289, 1500.579837645461, 1502.2263534279855, 1509.5094094419358, 30771.69228307688, 31375.686243137276, 31446.371072578877, 31715.20711982219, 31882.36235275328, 48574.0, 49119.50880491149, 49195.26207106968, 49246.26130607972, 49262.26106608476, 331584.0, 331941.0, 332406.0, 334142.0, 334601.0, 33382.66617333796, 33510.66489335075, 33662.49506257457, 33723.98828035163, 33803.4929476063, 54360.0, 54448.0, 55131.44868551424, 55364.44635553754, 56134.157987631035, 37135.44296835495, 38459.23081538297, 38962.02594935149, 39296.0, 40250.1949961005, 40138.0, 40268.0, 40722.389164163156, 40940.38589421102, 41105.588944110175, 39326.80336598299, 43641.34537981996, 43899.56100438955, 43917.560824391345, 44839.0, 34616.30767384588, 34637.1340716474, 34810.47784283289, 34846.65153348434, 39268.0, 26433.73566264313, 27203.0, 27410.451790964467, 27429.45141097207, 27471.31321716973], "unit": "ms", "name": "ext.html", "value": 19749.59954277319}, {"lowerIsBetter": false, "replicates": [381.77475289579144, 383.5914750790406, 387.16758968218335, 388.40186113385386, 391.15900813251505, 16458.259378327974, 17369.0, 18672.439826805185, 20508.384748457534, 20544.07551660177, 11595.652130436101, 11747.530098796038, 13461.730765384711, 18156.273749050055, 18181.545461363472, 4427.535108813577, 5169.457206993258, 5246.921296180561, 5699.943000570003, 5722.484976352128, 5633.126865335859, 5707.115397113434, 5713.114467257582, 5714.685692286923, 5718.914216286759, 5522.420145884685, 5610.214569960209, 5614.242077319571, 5633.943660563404, 5657.547396208293, 5533.529649979737, 5546.306711661043, 5547.694876781776, 5555.444455554452, 5581.944180558224, 4923.483034281385, 5000.5249501297685, 5010.89978200434, 5028.7737051832755, 5044.621653376012, 21308.254211102536, 21832.0, 21894.671579926315, 21952.780472195234, 22499.437514062116, 2182.476205710634, 2218.9556208875733, 2242.383344580237, 2351.988240058806, 2363.1492662641435, 10545.84181237282, 13337.86662133376, 13953.930230348884, 14175.291235438186, 14310.499132530416, 1935.0, 1979.0896187753651, 1993.6909778984282, 2009.5578972626, 2025.4430031741242, 63612.68193659048, 64038.0, 65796.34203657902, 65915.67042164759, 67862.0, 10536.947315263375, 10725.302855314536, 10750.408727520062, 10771.192160587987, 10911.56353745857, 14325.283735813377, 14437.422503099759, 14510.0, 14537.709245815236, 14559.126452412676, 8508.0, 8533.658653653783, 8561.0582835888, 8619.094995025558, 8651.95674021626, 8556.871646925301, 8559.614817333111, 8604.225619694133, 8620.224179823721, 8635.309175265964, 4537.977310113428, 4557.95442045582, 4563.429571303587, 4622.098690755271, 4629.305604159335, 1810.8913465192131, 1818.2363407368937, 1883.5667796406628, 1902.73361729358, 1926.1909997800958, 987.8468837330225, 998.55065220651, 1020.9948950255201, 1035.8967699400114, 1111.6720567432626, 17771.378001770136, 17879.195436205402, 17979.550511237063, 18385.356512521998, 18652.533686657942, 986.3539381704994, 995.6863587969766, 1077.7067518977258, 1078.6278733836814, 1094.6497120921388, 9842.80314393708, 10194.388336699822, 10197.694069177787, 10232.437215953194, 10234.897651023395, 619862.0, 620402.0, 631625.0, 638265.0, 644810.0, 69358.0, 70474.29525704678, 73645.6317718408, 85471.14528854756, 86326.0, 1153.7115721069733, 1176.9764604707857, 1191.684203686024, 1196.6589521986366, 1203.0616119427036, 15808.92095539515, 15920.601984950006, 15975.600609984844, 16024.599385015468, 16633.750493742846, 36742.44886326654, 36988.81505592455, 37573.81213093917, 38493.615063849, 38857.6114238854, 48708.756456217496, 49731.254031190285, 49929.750351249466, 50536.0, 50597.747011264706, 9894.406335619886, 10003.099721025143, 10353.223508237063, 10420.739481513023, 10422.426766527913, 17963.461096167135, 18260.817391826444, 18846.0, 18891.338803142375, 19319.51701207481, 15733.606659833596, 15825.52523424299, 15907.363705451653, 16030.519084427486, 16168.67662646764, 14713.92643036778, 15089.39642414335, 15448.845511544741, 15919.920400397923, 16019.679606407573, 15465.845341546441, 15838.52484425469, 15864.286107125437, 15972.440964566184, 16365.918170409072, 13564.93217533906, 14217.715645687234, 15538.378464861278, 15612.4535641252, 16034.278457469209, 16988.49034528966, 17171.0, 17558.29766809313, 18081.547961301072, 18201.726974095134], "unit": "ms", "name": "jquery.html", "value": 9656.517380364965}, {"lowerIsBetter": false, "replicates": [1557.7351850185476, 1605.9919700401497, 1867.5611231360629, 1892.7823300320463, 1893.9147738351774, 8187.345012398994, 8284.792880177998, 8350.95824520878, 8515.148485151482, 8525.062243153256, 8400.789980250482, 8416.83166336673, 8516.31869450444, 8522.105178956213, 8531.146885311466, 2275.2036787124457, 2320.8607483550954, 2325.593021221288, 2332.230363979891, 2335.100986120339, 2409.8072154227707, 2420.3707036170636, 2421.842580232288, 2431.4772323950347, 2456.754324567547, 2309.595820731374, 2337.0651739304244, 2349.765023497645, 2358.3278765551822, 2374.3114496795906, 2303.9539209215804, 2347.460084180648, 2371.442710962931, 2372.691550098476, 2379.167291447997, 2364.125273648761, 2387.4866903615634, 2388.0328466970905, 2388.1522059668914, 2390.9163179288817, 8254.0, 8321.500709957421, 8322.583870806435, 8329.0421601516, 8342.582870856433, 4859.927101093486, 4918.163912134945, 4946.752662366867, 4982.77577509013, 4984.551390374883, 3157.684231576824, 3161.541576471399, 3189.8245596492184, 3202.055393658853, 3202.823844688541, 1025.933314334566, 1031.2523420520138, 1031.283258135596, 1067.119626308291, 1087.9891201087967, 11408.087353011822, 11449.313041217554, 11532.884671153264, 11564.13269004828, 11574.0, 4237.152569486115, 4299.957000429956, 4306.763128027988, 4337.60961513459, 4357.891052723708, 9355.766105847408, 9356.0, 9358.766030849147, 9364.25085993119, 9375.531223438937, 4857.80568777252, 4870.6103511718975, 4879.243717223836, 4900.117978763857, 4911.214205727067, 4453.576910193591, 4462.776861156929, 4495.865124046284, 4500.0, 4506.954930450654, 3489.3021395720957, 3503.211777350127, 3518.437050071976, 3521.5774107107313, 3569.5716514018486, 1046.529061922138, 1047.2930771729052, 1052.9420881851572, 1074.8817630060687, 1211.8727533609022, 1116.0959622705634, 1146.7190538317998, 1152.4698638626326, 1154.722866512031, 1182.3142577305143, 7784.961075194701, 7805.453618246782, 7867.9606601966625, 7875.842483150305, 7906.209379062047, 1158.9942050289694, 1172.5075468303332, 1176.0944073063863, 1192.3382522699985, 1201.759648070372, 6163.414475624898, 6193.287771906198, 6202.81391558254, 6219.191505104398, 6258.249010118815, 9908.355956862924, 9915.80168396628, 9928.056834600702, 9998.500074996367, 10042.447665378475, 9682.177014953808, 9812.26408019387, 9816.901830981742, 9956.103950644478, 9966.152877005536, 7788.454808163374, 7890.0, 7900.249476299742, 7913.089994650573, 7921.485103468372, 7719.189485103983, 7793.571353575381, 7818.882716759139, 7833.37333013369, 7836.80407989782, 8918.331125165509, 8931.508767017876, 8944.552772361487, 8979.551022448983, 8988.505632190292, 9046.411983221069, 9140.314476414163, 9148.405353651991, 9156.496392698466, 9340.065993400605, 7347.55914645123, 7454.92545074564, 7490.288422599844, 7519.924800751923, 7521.323080922743, 7735.149133595188, 7750.379969602531, 7781.688732450639, 7789.0, 8039.236272554098, 7200.8919866201, 7380.889286660812, 7486.326230639269, 7501.812454688458, 7519.586422746802, 7356.816079598053, 7359.742409015659, 7403.444741644506, 7475.4019678426685, 7512.624368781429, 7629.923700762922, 7636.160022397643, 7654.081510218809, 7687.2697093776005, 7690.730824421118, 6628.370304821035, 6635.270120286861, 6686.7993960181275, 6688.7324507019175, 6695.397414232742, 6700.899486507804, 6752.561083529555, 6765.898511522233, 6772.0, 6784.3215678433735], "unit": "ms", "name": "mootools.html", "value": 4717.866291903587}, {"lowerIsBetter": false, "replicates": [356.15768707007936, 356.75740496462396, 358.1690478090829, 360.21293473759835, 364.74467872489265, 6289.433950944425, 6364.299927008031, 6398.488120950325, 6411.9679401602925, 6445.323241059691, 6181.28915174755, 6360.745570177199, 6363.618182909017, 6370.0, 6373.681315934208, 4849.199882019462, 4891.1195984722735, 4891.48639392864, 4895.0, 4901.362822833027, 4899.48555401683, 4901.289313049606, 4903.141950158708, 4906.067847109038, 4915.3855768029, 4655.720656760588, 4807.759612019402, 4827.951720482803, 4830.9516904831025, 4832.806687732486, 4784.091022705675, 4806.759662016902, 4812.783424745895, 4813.542713442217, 4819.542143496362, 4170.9582904170875, 4176.4570605821355, 4180.581941805795, 4190.350495673176, 4191.1827193697245, 5963.850903727398, 6055.212822333068, 6062.060380641008, 6062.181605483292, 6068.575199735976, 5571.415001424833, 5586.832395028156, 5590.944090559083, 5595.860103497404, 5607.018771714975, 6675.7997260082275, 6717.529772915897, 6731.831704207434, 6738.326167383271, 6775.593464392152, 4616.76916154191, 4621.098885717286, 4628.32889231063, 4632.652551058651, 4635.8377456789185, 6829.214640316378, 6929.514933954625, 6978.685959131852, 6998.895016574756, 6998.8950165748065, 4590.609798167193, 4608.815647374135, 4609.861704148881, 4610.446746390455, 4616.261398176276, 4646.279826626878, 4661.27750198713, 4670.299455081765, 4671.929921051187, 4671.953280467152, 5460.945390546123, 5464.590155738336, 5468.91796623051, 5484.177373393943, 5487.067198576252, 6643.86712265752, 6810.761623343159, 6812.591244525344, 6822.590644561342, 6825.044493770876, 1629.8859079864533, 1653.9338426463048, 1654.2390500369966, 1654.495378909444, 1654.619437529375, 1115.068917453935, 1119.4850368830266, 1127.785720713062, 1142.8628564572305, 1150.5225331487338, 6543.149390579194, 6551.508636852255, 6567.179102612174, 6577.473802095821, 6591.670416479157, 6915.377616014583, 6959.478039147084, 6967.303269673093, 6969.721211151598, 6978.337057979484, 6480.643564603992, 6559.868802623921, 6567.507436942248, 6568.047633093175, 6575.375339342755, 3765.4351847223134, 3781.0736369589627, 3806.467094606757, 3810.047488127968, 3815.6184381562175, 7106.644667766591, 7114.608696521741, 7118.216996130422, 7145.356917877416, 7148.320144765976, 6926.411255043277, 7105.076340075757, 7105.786826395217, 7136.929460580851, 7147.499675022698, 7107.218205997337, 7111.146662400545, 7111.217766045731, 7122.394596459359, 7162.7493037743425, 6906.447484201352, 6945.340192681687, 6978.860422791618, 6981.441484681315, 6989.0, 6721.294264102199, 6828.112345395266, 6867.862642747017, 6890.035395044798, 6894.724211031503, 7092.326229008236, 7134.1795693495915, 7137.714491420285, 7139.785806425608, 7155.212926578176, 4730.881727956691, 4738.597219236403, 4744.881377965578, 4749.073930583503, 4752.0, 6783.084283621648, 6957.339052789976, 6959.61722105289, 6973.476989225727, 6985.650717464208, 6697.464202863662, 6757.054012438361, 6758.493113016445, 6769.492288078315, 6775.288594697683, 6697.698603562949, 6745.392914637706, 6753.594784312957, 6767.661616919233, 6769.1876974763345, 6520.902186467112, 6628.767993120217, 6659.134312539339, 6660.333966603301, 6671.232808227116, 6798.626075565891, 6807.523473357016, 6807.897881531682, 6813.216480104851, 6825.761098361533, 6592.241892182268, 6626.53614246998, 6643.70103345341, 6649.102371180023, 6663.966680166568], "unit": "ms", "name": "prototype.html", "value": 5062.285730080327}, {"lowerIsBetter": false, "replicates": [776.1346099099505, 803.4817542684968, 815.2214635023553, 861.1560670542872, 939.4738946190137, 13091.607251782438, 13286.33568321585, 13310.534131305381, 13329.866701332983, 13343.666408339795, 12347.876521234808, 12721.618351449448, 12740.681482962931, 12806.29565373904, 13701.314934253272, 903.056306160061, 911.5715613661569, 917.8485549884294, 923.1599244687336, 924.5839372282467, 904.0913881549034, 915.2174890468654, 917.3165991336464, 920.4385324951774, 923.1414784250644, 958.3435346787438, 963.3208587945517, 965.715114041356, 966.8936416994125, 967.4775621164598, 955.1880901233965, 958.1807554540837, 961.053362437998, 963.1379914976092, 965.034965034965, 702.153904545022, 703.9120109986252, 704.8625518023987, 706.936375726182, 708.1679027143086, 12726.236425814388, 12748.617541473677, 12804.80792788109, 12845.293508857103, 12907.0, 12964.0, 13078.738425231442, 13080.934595326962, 13148.0, 13212.339383030907, 10294.220560448712, 10389.584416623402, 10437.843432348522, 10454.477276136162, 10492.0, 3817.7136714746225, 3887.1448281378052, 3907.9218415631526, 3912.8434862605463, 3915.040815000343, 47685.76157119227, 47850.5214947853, 49483.0, 51956.740216299055, 51996.22005669918, 9782.315237933419, 9800.950995244979, 9983.600655973825, 10005.499725013866, 10061.4466204358, 17317.307307707804, 17320.566985825455, 17381.391651292397, 17423.39018134359, 17425.82574174242, 6795.18457785059, 6817.625030623264, 6836.418904393083, 6886.48351373649, 7085.751998680124, 4744.596709279681, 4883.4628190898975, 4948.356713627206, 4977.1538838397555, 5018.623603229772, 3249.7400207983305, 3264.1186879542392, 3269.4115059289556, 3288.556044933951, 3291.5556399886186, 582.7435928191667, 589.4694774702801, 602.8342205893414, 623.0342968398963, 633.2622494793605, 571.7398583644432, 679.3851564334285, 685.8525417035262, 704.383664293743, 753.1263734068455, 8871.645134194689, 9387.061293870694, 9591.280653950982, 9658.082482164184, 9948.35335703177, 603.5081408651935, 668.7726173101072, 686.2451303566038, 716.7240612364277, 735.6064505489644, 4392.209402307615, 4420.270655341897, 4520.118576877543, 4630.930536041962, 4684.648651351163, 55968.0, 60100.0, 60216.0, 61116.694416527636, 61332.0, 50315.24527132096, 51018.0, 51452.0, 56367.617942923556, 57970.71014644984, 46616.76691616588, 46759.532404676196, 47082.0, 47547.524524754306, 47616.5238347619, 9020.954895225745, 9350.345475816628, 9525.476098814355, 9593.90406095958, 9827.656032038843, 35098.298034038664, 35318.0, 35623.28753424865, 37412.25175496529, 38297.23405531818, 44698.0, 45402.0, 45817.312740309586, 45913.31130033119, 46087.308690369, 11666.416679166177, 11696.532138714356, 11853.881461185278, 12116.515339386326, 12140.635780926586, 12623.431945562288, 13042.347882606022, 13141.802872956721, 13382.0, 13433.462661493822, 11468.541258349573, 11960.880391195977, 11977.0, 12122.393880305774, 12758.872411275768, 11314.660560183207, 11457.484413201259, 11563.768724625628, 11599.188056835941, 11654.592089276835, 10646.520906559379, 10683.145348372267, 10712.0, 11573.826392603949, 11730.296182229093, 9924.206063515046, 10388.636397726043, 10548.367097974146, 11097.445127743742, 11243.887561124284, 9275.25797936177, 9717.465539395402, 9757.56090975922, 9854.802903941738, 9894.406335619886], "unit": "ms", "name": "yui.html", "value": 6622.65994618131}], "name": "dromaeo_css", "value": 7423.150193043543}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 104.0, 110.0, 112.0, 110.0, 122.0, 113.0, 110.0, 109.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [142.0, 128.0, 152.0, 156.0, 124.0, 146.0, 157.0, 128.0, 179.0, 127.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.9}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 162.0, 161.0, 163.0, 164.0, 162.0, 160.0, 164.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 72.0, 152.0, 72.0, 76.0, 71.0, 74.0, 161.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 89.9}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 138.0, 92.0, 92.0, 93.0, 134.0, 93.0, 92.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 105.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 109.0, 113.0, 110.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 147.0, 147.0, 148.0, 146.0, 146.0, 148.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 97.0, 96.0, 96.0, 98.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [58.0, 61.0, 59.0, 60.0, 61.0, 62.0, 64.0, 60.0, 57.0, 62.0], "unit": "ms", "name": "json-parse-financial", "value": 60.4}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 64.0, 63.0, 64.0, 64.0, 66.0, 64.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.8}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 90.0, 83.0, 82.0, 82.0, 82.0, 83.0, 85.0, 91.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [116.0, 114.0, 114.0, 113.0, 118.0, 123.0, 118.0, 120.0, 114.0, 118.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 116.8}, {"lowerIsBetter": true, "replicates": [136.0, 146.0, 151.0, 145.0, 146.0, 142.0, 157.0, 136.0, 148.0, 148.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.5}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 67.0, 65.0, 66.0, 65.0, 64.0, 67.0, 64.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.6}], "name": "kraken", "value": 1502.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.41959881617888], "unit": "score", "name": "Richards", "value": 214.70676399999994}, {"lowerIsBetter": false, "replicates": [167.0564650851988], "unit": "score", "name": "DeltaBlue", "value": 395.7823480000001}, {"lowerIsBetter": false, "replicates": [279.3296089385475], "unit": "score", "name": "Encrypt", "value": 952.9279799999998}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [911.5770282588878], "unit": "score", "name": "RayTrace", "value": 811.7679330000002}, {"lowerIsBetter": false, "replicates": [547.0459518599563], "unit": "score", "name": "Earley", "value": 1218.294364}, {"lowerIsBetter": false, "replicates": [11144.444444444445], "unit": "score", "name": "Boyer", "value": 59.80226321036885}, {"lowerIsBetter": false, "replicates": [24951.219512195123], "unit": "score", "name": "RegExp", "value": 36.51064027370476}, {"lowerIsBetter": false, "replicates": [519.2107995846313], "unit": "score", "name": "Splay", "value": 156.95166600000005}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 23208.791362720844}]} 09:23:46 INFO - RETURN: dromaeo_css: 7423.15 09:23:46 INFO - RETURN: kraken: 1502.00 09:23:46 INFO - RETURN: v8_7: 23208.79 09:23:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23208.79"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1502.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7423.15"}}} 09:23:46 INFO - Return code: 0 09:23:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:23:46 INFO - # TBPL SUCCESS # 09:23:46 INFO - Running post-action listener: _resource_record_post_action 09:23:46 INFO - Running post-run listener: _resource_record_post_run 09:23:47 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 262144; Write bytes: 518377472; Read time: 20; Write time: 1387120 09:23:47 INFO - install - Wall time: 17s; CPU: 18.0%; Read bytes: 0; Write bytes: 244961280; Read time: 0; Write time: 967240 09:23:47 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 262144; Write bytes: 273313792; Read time: 20; Write time: 419880 09:23:47 INFO - Running post-run listener: _upload_blobber_files 09:23:47 INFO - Blob upload gear active. 09:23:47 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:23:47 INFO - Copying logs to upload dir... 09:23:47 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1263.116168 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-22 09:23:47.190764) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-22 09:23:47.194168) ========= 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=df17445c3590ff7897617a0e00000225-1453482162.836543-559619016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/bUODrfdIQQynOXWD0dtxhg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.008755 build_url: 'https://queue.taskcluster.net/v1/task/bUODrfdIQQynOXWD0dtxhg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-22 09:23:47.245290) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:23:47.245682) ========= 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=df17445c3590ff7897617a0e00000225-1453482162.836543-559619016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004392 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:23:47.296115) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 09:23:47.296489) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 09:23:47.296840) ========= ========= Total master_lag: 0.27 =========