builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1453483407.51 results: success (0) buildid: 20160122065828 builduid: 3d3b5011b7644a1e8b60ac2ad98ea64c revision: 8e913ace1e198c34423bfadc807296f6400078bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 09:23:27.508809) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 09:23:27.509313) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 09:23:27.509641) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1453483374.787094-52715717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006357 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 09:23:27.540342) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 09:23:27.543735) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 09:23:27.558307) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:23:27.558638) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1453483374.787094-52715717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:23:27.608469) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 09:23:27.608777) ========= 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:23:27.609167) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:23:27.609472) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1453483374.787094-52715717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-22 09:23:28-- 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% 54.0M=0s 2016-01-22 09:23:28 (54.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.417565 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:23:28.046750) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:23:28.047163) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1453483374.787094-52715717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015796 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:23:28.108763) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:23:28.109139) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8e913ace1e198c34423bfadc807296f6400078bd --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 8e913ace1e198c34423bfadc807296f6400078bd --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=8c6b6742ce8f6f39ef4ce27d000001f1-1453483374.787094-52715717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-22 09:23:28,662 truncating revision to first 12 chars 2016-01-22 09:23:28,662 Setting DEBUG logging. 2016-01-22 09:23:28,662 attempt 1/10 2016-01-22 09:23:28,662 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8e913ace1e19?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-22 09:23:28,926 unpacking tar archive at: mozilla-aurora-8e913ace1e19/testing/mozharness/ program finished with exit code 0 elapsedTime=0.564526 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:23:28.689964) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 09:23:28.690475) ========= echo 8e913ace1e198c34423bfadc807296f6400078bd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8e913ace1e198c34423bfadc807296f6400078bd'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1453483374.787094-52715717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 8e913ace1e198c34423bfadc807296f6400078bd program finished with exit code 0 elapsedTime=0.004676 script_repo_revision: '8e913ace1e198c34423bfadc807296f6400078bd' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 09:23:28.741089) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 09:23:28.741437) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 09:23:28.752117) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-01-22 09:23:28.752445) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1453483374.787094-52715717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:23:29 INFO - MultiFileLogger online at 20160122 09:23:29 in /builds/slave/test-pgo 09:23:29 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:23:29 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:23:29 INFO - {'append_to_log': False, 09:23:29 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:23:29 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:23:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:23:29 INFO - 'branch': 'Mozilla-Aurora', 09:23:29 INFO - 'buildbot_json_path': 'buildprops.json', 09:23:29 INFO - 'config_files': ('talos/linux_config.py',), 09:23:29 INFO - 'default_actions': ('clobber', 09:23:29 INFO - 'read-buildbot-config', 09:23:29 INFO - 'download-and-extract', 09:23:29 INFO - 'populate-webroot', 09:23:29 INFO - 'create-virtualenv', 09:23:29 INFO - 'install', 09:23:29 INFO - 'run-tests'), 09:23:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:23:29 INFO - 'download_minidump_stackwalk': True, 09:23:29 INFO - 'download_symbols': 'ondemand', 09:23:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:23:29 INFO - 'tooltool.py': '/tools/tooltool.py', 09:23:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:23:29 INFO - '/tools/misc-python/virtualenv.py')}, 09:23:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:23:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:23:29 INFO - 'installer_path': 'installer.exe', 09:23:29 INFO - 'log_level': 'info', 09:23:29 INFO - 'log_name': 'talos', 09:23:29 INFO - 'log_to_console': True, 09:23:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:23:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:23:29 INFO - 'opt_config_files': (), 09:23:29 INFO - 'pip_index': False, 09:23:29 INFO - 'sps_profile': False, 09:23:29 INFO - 'sps_profile_interval': 0, 09:23:29 INFO - 'suite': 'dromaeojs-e10s', 09:23:29 INFO - 'system_bits': '32', 09:23:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:23:29 INFO - 'title': 'talos-linux64-ix-041', 09:23:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:23:29 INFO - 'use_talos_json': True, 09:23:29 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:23:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:23:29 INFO - 'work_dir': 'build'} 09:23:29 INFO - ##### 09:23:29 INFO - ##### Running clobber step. 09:23:29 INFO - ##### 09:23:29 INFO - Running pre-action listener: _resource_record_pre_action 09:23:29 INFO - Running main action method: clobber 09:23:29 INFO - rmtree: /builds/slave/test-pgo/build 09:23:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:23:30 INFO - Running post-action listener: _resource_record_post_action 09:23:30 INFO - ##### 09:23:30 INFO - ##### Running read-buildbot-config step. 09:23:30 INFO - ##### 09:23:30 INFO - Running pre-action listener: _resource_record_pre_action 09:23:30 INFO - Running main action method: read_buildbot_config 09:23:30 INFO - Using buildbot properties: 09:23:30 INFO - { 09:23:30 INFO - "properties": { 09:23:30 INFO - "buildnumber": 102, 09:23:30 INFO - "product": "firefox", 09:23:30 INFO - "script_repo_revision": "production", 09:23:30 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:23:30 INFO - "repository": "", 09:23:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:23:30 INFO - "buildid": "20160122065828", 09:23:30 INFO - "slavename": "talos-linux64-ix-041", 09:23:30 INFO - "pgo_build": "True", 09:23:30 INFO - "basedir": "/builds/slave/test-pgo", 09:23:30 INFO - "project": "", 09:23:30 INFO - "platform": "ubuntu64_hw", 09:23:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:23:30 INFO - "slavebuilddir": "test", 09:23:30 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:23:30 INFO - "branch": "mozilla-aurora", 09:23:30 INFO - "repo_path": "releases/mozilla-aurora", 09:23:30 INFO - "stage_platform": "linux64-pgo", 09:23:30 INFO - "builduid": "3d3b5011b7644a1e8b60ac2ad98ea64c", 09:23:30 INFO - "revision": "8e913ace1e198c34423bfadc807296f6400078bd" 09:23:30 INFO - }, 09:23:30 INFO - "sourcestamp": { 09:23:30 INFO - "repository": "", 09:23:30 INFO - "hasPatch": false, 09:23:30 INFO - "project": "", 09:23:30 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 09:23:30 INFO - "changes": [ 09:23:30 INFO - { 09:23:30 INFO - "category": null, 09:23:30 INFO - "files": [ 09:23:30 INFO - { 09:23:30 INFO - "url": null, 09:23:30 INFO - "name": "https://queue.taskcluster.net/v1/task/ZDxVibeIQAelFrXkPXgRVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 09:23:30 INFO - } 09:23:30 INFO - ], 09:23:30 INFO - "repository": "", 09:23:30 INFO - "rev": "8e913ace1e198c34423bfadc807296f6400078bd", 09:23:30 INFO - "who": "cbook@mozilla.com", 09:23:30 INFO - "when": 1453483352, 09:23:30 INFO - "number": 7501535, 09:23:30 INFO - "comments": "Bug 1230857 - Make GMPInstallManager enforce sensible permissions on GMP files at install time. r=spohl, a=sylvestre\n\nThis ensures that GMP packages with bad permissions will still be usable. For\nexample, a GMP without execute/read permissions in its zip won't work without\nthis.", 09:23:30 INFO - "project": "", 09:23:30 INFO - "at": "Fri 22 Jan 2016 09:22:32", 09:23:30 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 09:23:30 INFO - "revlink": "", 09:23:30 INFO - "properties": [ 09:23:30 INFO - [ 09:23:30 INFO - "buildid", 09:23:30 INFO - "20160122065828", 09:23:30 INFO - "Change" 09:23:30 INFO - ], 09:23:30 INFO - [ 09:23:30 INFO - "builduid", 09:23:30 INFO - "3d3b5011b7644a1e8b60ac2ad98ea64c", 09:23:30 INFO - "Change" 09:23:30 INFO - ], 09:23:30 INFO - [ 09:23:30 INFO - "pgo_build", 09:23:30 INFO - "True", 09:23:30 INFO - "Change" 09:23:30 INFO - ] 09:23:30 INFO - ], 09:23:30 INFO - "revision": "8e913ace1e198c34423bfadc807296f6400078bd" 09:23:30 INFO - } 09:23:30 INFO - ], 09:23:30 INFO - "revision": "8e913ace1e198c34423bfadc807296f6400078bd" 09:23:30 INFO - } 09:23:30 INFO - } 09:23:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZDxVibeIQAelFrXkPXgRVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 09:23:30 INFO - Running post-action listener: _resource_record_post_action 09:23:30 INFO - ##### 09:23:30 INFO - ##### Running download-and-extract step. 09:23:30 INFO - ##### 09:23:30 INFO - Running pre-action listener: _resource_record_pre_action 09:23:30 INFO - Running main action method: download_and_extract 09:23:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:23:30 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:23:30 INFO - https://queue.taskcluster.net/v1/task/ZDxVibeIQAelFrXkPXgRVQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:23:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDxVibeIQAelFrXkPXgRVQ/artifacts/public/build/test_packages.json 09:23:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDxVibeIQAelFrXkPXgRVQ/artifacts/public/build/test_packages.json 09:23:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDxVibeIQAelFrXkPXgRVQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:23:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDxVibeIQAelFrXkPXgRVQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:23:33 INFO - Downloaded 1302 bytes. 09:23:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:23:34 INFO - Using the following test package requirements: 09:23:34 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 09:23:34 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:23:34 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:23:34 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:23:34 INFO - u'jsshell-linux-x86_64.zip'], 09:23:34 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:23:34 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:23:34 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 09:23:34 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:23:34 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:23:34 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:23:34 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:23:34 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:23:34 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:23:34 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 09:23:34 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:23:34 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:23:34 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:23: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:23:34 INFO - https://queue.taskcluster.net/v1/task/ZDxVibeIQAelFrXkPXgRVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:23:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDxVibeIQAelFrXkPXgRVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:23:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDxVibeIQAelFrXkPXgRVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:23:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDxVibeIQAelFrXkPXgRVQ/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:23:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDxVibeIQAelFrXkPXgRVQ/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:23:35 INFO - Downloaded 23159075 bytes. 09:23:35 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:23:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:23:35 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:23:36 INFO - Return code: 0 09:23:36 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:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:36 INFO - https://queue.taskcluster.net/v1/task/ZDxVibeIQAelFrXkPXgRVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:23:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDxVibeIQAelFrXkPXgRVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:23:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDxVibeIQAelFrXkPXgRVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:23:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDxVibeIQAelFrXkPXgRVQ/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:23:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDxVibeIQAelFrXkPXgRVQ/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:23:39 INFO - Downloaded 23159075 bytes. 09:23:39 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:23:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:23:39 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:23:40 INFO - Return code: 0 09:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:40 INFO - https://queue.taskcluster.net/v1/task/ZDxVibeIQAelFrXkPXgRVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:23:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDxVibeIQAelFrXkPXgRVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:23:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDxVibeIQAelFrXkPXgRVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:23:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDxVibeIQAelFrXkPXgRVQ/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:23:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDxVibeIQAelFrXkPXgRVQ/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:23:41 INFO - Downloaded 11132038 bytes. 09:23:41 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:23:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:23:41 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:23:41 INFO - Return code: 0 09:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:41 INFO - https://queue.taskcluster.net/v1/task/ZDxVibeIQAelFrXkPXgRVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:23:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDxVibeIQAelFrXkPXgRVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:23:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDxVibeIQAelFrXkPXgRVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:23:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDxVibeIQAelFrXkPXgRVQ/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:23:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZDxVibeIQAelFrXkPXgRVQ/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:23:44 INFO - Downloaded 58175751 bytes. 09:23:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZDxVibeIQAelFrXkPXgRVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:23:44 INFO - mkdir: /builds/slave/test-pgo/properties 09:23:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:23:44 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:23:44 INFO - Contents: 09:23:44 INFO - build_url:https://queue.taskcluster.net/v1/task/ZDxVibeIQAelFrXkPXgRVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:23:44 INFO - Running post-action listener: _resource_record_post_action 09:23:44 INFO - Running post-action listener: set_extra_try_arguments 09:23:44 INFO - ##### 09:23:44 INFO - ##### Running populate-webroot step. 09:23:44 INFO - ##### 09:23:44 INFO - Running pre-action listener: _resource_record_pre_action 09:23:44 INFO - Running main action method: populate_webroot 09:23:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:23:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:23:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:23:44 INFO - '--tppagecycles', 09:23:44 INFO - '7'], 09:23:44 INFO - 'tests': ['tsvgm']}}, 09:23:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:23:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:23:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:23:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:23:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:23:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:23:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:44 INFO - 'talos_options': ['--e10s'], 09:23:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:44 INFO - 'tests': ['damp', 'tps']}, 09:23:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:44 INFO - 'talos_options': ['--e10s'], 09:23:44 INFO - 'tests': ['damp', 'tps']}, 09:23:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:23:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:23:44 INFO - 'other': {'tests': ['a11yr', 09:23:44 INFO - 'ts_paint', 09:23:44 INFO - 'tpaint', 09:23:44 INFO - 'sessionrestore', 09:23:44 INFO - 'sessionrestore_no_auto_restore']}, 09:23:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:23:44 INFO - 'tests': ['a11yr', 09:23:44 INFO - 'ts_paint', 09:23:44 INFO - 'tpaint', 09:23:44 INFO - 'sessionrestore', 09:23:44 INFO - 'sessionrestore_no_auto_restore']}, 09:23:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:23:44 INFO - 'tests': ['a11yr', 09:23:44 INFO - 'ts_paint', 09:23:44 INFO - 'tpaint', 09:23:44 INFO - 'sessionrestore', 09:23:44 INFO - 'sessionrestore_no_auto_restore']}, 09:23:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:23:44 INFO - 'tests': ['a11yr', 09:23:44 INFO - 'ts_paint', 09:23:44 INFO - 'tpaint', 09:23:44 INFO - 'sessionrestore', 09:23:44 INFO - 'sessionrestore_no_auto_restore']}, 09:23:44 INFO - 'other_l64': {'tests': ['a11yr', 09:23:44 INFO - 'ts_paint', 09:23:44 INFO - 'tpaint', 09:23:44 INFO - 'sessionrestore', 09:23:44 INFO - 'sessionrestore_no_auto_restore']}, 09:23:44 INFO - 'other_nol64': {'tests': ['a11yr', 09:23:44 INFO - 'ts_paint', 09:23:44 INFO - 'tpaint', 09:23:44 INFO - 'sessionrestore', 09:23:44 INFO - 'sessionrestore_no_auto_restore']}, 09:23:44 INFO - 'svgr': {'tests': ['tsvgx', 09:23:44 INFO - 'tsvgr_opacity', 09:23:44 INFO - 'tart', 09:23:44 INFO - 'tscrollx', 09:23:44 INFO - 'cart']}, 09:23:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:23:44 INFO - 'tests': ['tsvgx', 09:23:44 INFO - 'tsvgr_opacity', 09:23:44 INFO - 'tart', 09:23:44 INFO - 'tscrollx', 09:23:44 INFO - 'cart']}, 09:23:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:44 INFO - 'tests': ['tp5o']}, 09:23:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:44 INFO - 'talos_options': ['--e10s'], 09:23:44 INFO - 'tests': ['tp5o']}, 09:23:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:44 INFO - 'talos_options': ['--xperf_path', 09:23:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:44 INFO - 'tests': ['tp5n']}, 09:23:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:44 INFO - 'talos_options': ['--e10s', 09:23:44 INFO - '--xperf_path', 09:23:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:44 INFO - 'tests': ['tp5n']}}, 09:23:44 INFO - 'talos.zip': {'path': '', 09:23:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:23:44 INFO - Running post-action listener: _resource_record_post_action 09:23:44 INFO - ##### 09:23:44 INFO - ##### Running create-virtualenv step. 09:23:44 INFO - ##### 09:23:44 INFO - Running pre-action listener: _resource_record_pre_action 09:23:44 INFO - Running main action method: create_virtualenv 09:23:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:23:44 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:23:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:23:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:23:44 INFO - Using real prefix '/usr' 09:23:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:23:44 INFO - Installing distribute.............................................................................................................................................................................................done. 09:23:46 INFO - Installing pip.................done. 09:23:46 INFO - Return code: 0 09:23:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:23: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:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23: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:23:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:46 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 0x7f22ecc7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf27500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf246a0>, '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 0xf255a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf25a30>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1453483374.787094-52715717', '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:23:46 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:23:46 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:23:46 INFO - Using env: {'DISPLAY': ':0', 09:23:46 INFO - 'HOME': '/home/cltbld', 09:23:46 INFO - 'LANG': 'en_US.UTF-8', 09:23:46 INFO - 'LANGUAGE': 'en_US:en', 09:23:46 INFO - 'LOGNAME': 'cltbld', 09:23:46 INFO - 'MAIL': '/var/mail/cltbld', 09:23:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:46 INFO - 'MOZ_NO_REMOTE': '1', 09:23:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:46 INFO - 'NO_EM_RESTART': '1', 09:23:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:23:46 INFO - 'PWD': '/builds/slave/test-pgo', 09:23:46 INFO - 'SHELL': '/bin/bash', 09:23:46 INFO - 'SHLVL': '1', 09:23:46 INFO - 'TERM': 'linux', 09:23:46 INFO - 'TMOUT': '86400', 09:23:46 INFO - 'USER': 'cltbld', 09:23:46 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1453483374.787094-52715717', 09:23:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:46 INFO - '_': '/tools/buildbot/bin/python'} 09:23:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:46 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:23:46 INFO - Cleaning up... 09:23:46 INFO - Return code: 0 09:23:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:23: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:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23: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:23:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:46 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 0x7f22ecc7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf27500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf246a0>, '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 0xf255a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf25a30>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1453483374.787094-52715717', '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:23:46 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:23:46 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:23:46 INFO - Using env: {'DISPLAY': ':0', 09:23:46 INFO - 'HOME': '/home/cltbld', 09:23:46 INFO - 'LANG': 'en_US.UTF-8', 09:23:46 INFO - 'LANGUAGE': 'en_US:en', 09:23:46 INFO - 'LOGNAME': 'cltbld', 09:23:46 INFO - 'MAIL': '/var/mail/cltbld', 09:23:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:46 INFO - 'MOZ_NO_REMOTE': '1', 09:23:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:46 INFO - 'NO_EM_RESTART': '1', 09:23:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:23:46 INFO - 'PWD': '/builds/slave/test-pgo', 09:23:46 INFO - 'SHELL': '/bin/bash', 09:23:46 INFO - 'SHLVL': '1', 09:23:46 INFO - 'TERM': 'linux', 09:23:46 INFO - 'TMOUT': '86400', 09:23:46 INFO - 'USER': 'cltbld', 09:23:46 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1453483374.787094-52715717', 09:23:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:46 INFO - '_': '/tools/buildbot/bin/python'} 09:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:47 INFO - Downloading/unpacking psutil>=0.7.1 09:23:47 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:23:47 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:23:47 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:23:47 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:23:47 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:23:47 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:23:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:23:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:49 INFO - Installing collected packages: psutil 09:23:49 INFO - Running setup.py install for psutil 09:23:49 INFO - building 'psutil._psutil_linux' extension 09:23:49 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:23:49 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:23:49 INFO - building 'psutil._psutil_posix' extension 09:23:49 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:23:49 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:23:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:49 INFO - Successfully installed psutil 09:23:49 INFO - Cleaning up... 09:23:49 INFO - Return code: 0 09:23:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:23: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:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23: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:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:49 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 0x7f22ecc7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf27500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf246a0>, '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 0xf255a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf25a30>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1453483374.787094-52715717', '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:23:49 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:23:49 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:23:49 INFO - Using env: {'DISPLAY': ':0', 09:23:49 INFO - 'HOME': '/home/cltbld', 09:23:49 INFO - 'LANG': 'en_US.UTF-8', 09:23:49 INFO - 'LANGUAGE': 'en_US:en', 09:23:49 INFO - 'LOGNAME': 'cltbld', 09:23:49 INFO - 'MAIL': '/var/mail/cltbld', 09:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:49 INFO - 'MOZ_NO_REMOTE': '1', 09:23:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:49 INFO - 'NO_EM_RESTART': '1', 09:23:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:23:49 INFO - 'PWD': '/builds/slave/test-pgo', 09:23:49 INFO - 'SHELL': '/bin/bash', 09:23:49 INFO - 'SHLVL': '1', 09:23:49 INFO - 'TERM': 'linux', 09:23:49 INFO - 'TMOUT': '86400', 09:23:49 INFO - 'USER': 'cltbld', 09:23:49 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1453483374.787094-52715717', 09:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:49 INFO - '_': '/tools/buildbot/bin/python'} 09:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:23:49 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:23:49 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:23:49 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:23:49 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:23:49 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:23:49 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:23:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:23:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:23:51 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:23:51 INFO - Installing collected packages: mozsystemmonitor 09:23:51 INFO - Running setup.py install for mozsystemmonitor 09:23:51 INFO - Successfully installed mozsystemmonitor 09:23:51 INFO - Cleaning up... 09:23:51 INFO - Return code: 0 09:23:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f22ecc7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf27500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf246a0>, '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 0xf255a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf25a30>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1453483374.787094-52715717', '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:23:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 09:23:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:23:51 INFO - Using env: {'DISPLAY': ':0', 09:23:51 INFO - 'HOME': '/home/cltbld', 09:23:51 INFO - 'LANG': 'en_US.UTF-8', 09:23:51 INFO - 'LANGUAGE': 'en_US:en', 09:23:51 INFO - 'LOGNAME': 'cltbld', 09:23:51 INFO - 'MAIL': '/var/mail/cltbld', 09:23:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:51 INFO - 'MOZ_NO_REMOTE': '1', 09:23:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:51 INFO - 'NO_EM_RESTART': '1', 09:23:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:23:51 INFO - 'PWD': '/builds/slave/test-pgo', 09:23:51 INFO - 'SHELL': '/bin/bash', 09:23:51 INFO - 'SHLVL': '1', 09:23:51 INFO - 'TERM': 'linux', 09:23:51 INFO - 'TMOUT': '86400', 09:23:51 INFO - 'USER': 'cltbld', 09:23:51 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1453483374.787094-52715717', 09:23:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:51 INFO - '_': '/tools/buildbot/bin/python'} 09:23:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:51 INFO - Downloading/unpacking blobuploader==1.2.4 09:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:53 INFO - Downloading blobuploader-1.2.4.tar.gz 09:23:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:23:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:23:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:23:54 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:23:54 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:23:54 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:23:54 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:23:54 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:23:54 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:23:54 INFO - Downloading docopt-0.6.1.tar.gz 09:23:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:23:54 INFO - Installing collected packages: blobuploader, requests, docopt 09:23:54 INFO - Running setup.py install for blobuploader 09:23:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:23:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:23:54 INFO - Running setup.py install for requests 09:23:54 INFO - Running setup.py install for docopt 09:23:54 INFO - Successfully installed blobuploader requests docopt 09:23:54 INFO - Cleaning up... 09:23:55 INFO - Return code: 0 09:23:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:23:55 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:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:55 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:23:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:55 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 0x7f22ecc7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf27500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf246a0>, '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 0xf255a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf25a30>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1453483374.787094-52715717', '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:23:55 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:23:55 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:23:55 INFO - Using env: {'DISPLAY': ':0', 09:23:55 INFO - 'HOME': '/home/cltbld', 09:23:55 INFO - 'LANG': 'en_US.UTF-8', 09:23:55 INFO - 'LANGUAGE': 'en_US:en', 09:23:55 INFO - 'LOGNAME': 'cltbld', 09:23:55 INFO - 'MAIL': '/var/mail/cltbld', 09:23:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:55 INFO - 'MOZ_NO_REMOTE': '1', 09:23:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:55 INFO - 'NO_EM_RESTART': '1', 09:23:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:23:55 INFO - 'PWD': '/builds/slave/test-pgo', 09:23:55 INFO - 'SHELL': '/bin/bash', 09:23:55 INFO - 'SHLVL': '1', 09:23:55 INFO - 'TERM': 'linux', 09:23:55 INFO - 'TMOUT': '86400', 09:23:55 INFO - 'USER': 'cltbld', 09:23:55 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1453483374.787094-52715717', 09:23:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:55 INFO - '_': '/tools/buildbot/bin/python'} 09:23:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:23:55 INFO - Running setup.py (path:/tmp/pip-RIkYMz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:23:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:23:55 INFO - Running setup.py (path:/tmp/pip-v7TFvE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:23:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:23:55 INFO - Running setup.py (path:/tmp/pip-YJxFm1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:23:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:23:55 INFO - Running setup.py (path:/tmp/pip-M1yVLu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:23:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:23:55 INFO - Running setup.py (path:/tmp/pip-BnTWXo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:23:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:23:55 INFO - Running setup.py (path:/tmp/pip-wqSp7m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:23:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:23:55 INFO - Running setup.py (path:/tmp/pip-2Ga7vd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:23:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:23:55 INFO - Running setup.py (path:/tmp/pip-d0_X_0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:23:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:23:55 INFO - Running setup.py (path:/tmp/pip-SO22sG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:23:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:23:55 INFO - Running setup.py (path:/tmp/pip-_uqQ0o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:23:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:23:55 INFO - Running setup.py (path:/tmp/pip-y4arFa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:23:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:23:56 INFO - Running setup.py (path:/tmp/pip-ep6JlP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:23:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:23:56 INFO - Running setup.py (path:/tmp/pip-2XiKFN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:23:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:23:56 INFO - Running setup.py (path:/tmp/pip-S1VDhC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:23:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:23:56 INFO - Running setup.py (path:/tmp/pip-w11Ni7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:23:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:23:56 INFO - Running setup.py (path:/tmp/pip-KCLFhl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:23:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:23:56 INFO - Running setup.py (path:/tmp/pip-0IOgAK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:23:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:23:56 INFO - Running setup.py install for manifestparser 09:23:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:23:56 INFO - Running setup.py install for mozcrash 09:23:56 INFO - Running setup.py install for mozdebug 09:23:56 INFO - Running setup.py install for mozdevice 09:23:56 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:23:56 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:23:56 INFO - Running setup.py install for mozfile 09:23:56 INFO - Running setup.py install for mozhttpd 09:23:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:23:57 INFO - Running setup.py install for mozinfo 09:23:57 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:23:57 INFO - Running setup.py install for mozInstall 09:23:57 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:23:57 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:23:57 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:23:57 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:23:57 INFO - Running setup.py install for mozleak 09:23:57 INFO - Running setup.py install for mozlog 09:23:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:23:57 INFO - Running setup.py install for moznetwork 09:23:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:23:57 INFO - Running setup.py install for mozprocess 09:23:57 INFO - Running setup.py install for mozprofile 09:23:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:23:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:23:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:23:57 INFO - Running setup.py install for mozrunner 09:23:57 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:23:57 INFO - Running setup.py install for mozscreenshot 09:23:58 INFO - Running setup.py install for moztest 09:23:58 INFO - Running setup.py install for mozversion 09:23:58 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:23:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:23:58 INFO - Cleaning up... 09:23:58 INFO - Return code: 0 09:23:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:58 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 0x7f22ecc7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf27500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf246a0>, '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 0xf255a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf25a30>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1453483374.787094-52715717', '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:23:58 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:23:58 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:23:58 INFO - Using env: {'DISPLAY': ':0', 09:23:58 INFO - 'HOME': '/home/cltbld', 09:23:58 INFO - 'LANG': 'en_US.UTF-8', 09:23:58 INFO - 'LANGUAGE': 'en_US:en', 09:23:58 INFO - 'LOGNAME': 'cltbld', 09:23:58 INFO - 'MAIL': '/var/mail/cltbld', 09:23:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:58 INFO - 'MOZ_NO_REMOTE': '1', 09:23:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:58 INFO - 'NO_EM_RESTART': '1', 09:23:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:23:58 INFO - 'PWD': '/builds/slave/test-pgo', 09:23:58 INFO - 'SHELL': '/bin/bash', 09:23:58 INFO - 'SHLVL': '1', 09:23:58 INFO - 'TERM': 'linux', 09:23:58 INFO - 'TMOUT': '86400', 09:23:58 INFO - 'USER': 'cltbld', 09:23:58 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1453483374.787094-52715717', 09:23:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:58 INFO - '_': '/tools/buildbot/bin/python'} 09:23:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:23:58 INFO - Running setup.py (path:/tmp/pip-LtQfEy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:23:58 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:23:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:23:58 INFO - Running setup.py (path:/tmp/pip-_gQ5CS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:23:58 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:23:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:23:58 INFO - Running setup.py (path:/tmp/pip-BIzX1o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:23:58 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:23:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:23:58 INFO - Running setup.py (path:/tmp/pip-CbaxGF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:23:58 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:23:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:23:58 INFO - Running setup.py (path:/tmp/pip-pHeS3a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:23:58 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:23:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:23:58 INFO - Running setup.py (path:/tmp/pip-k2WLXP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:23:58 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:23:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:23:58 INFO - Running setup.py (path:/tmp/pip-36TEIG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:23:58 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:23:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:23:58 INFO - Running setup.py (path:/tmp/pip-3X3C1u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:23:59 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:23:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:23:59 INFO - Running setup.py (path:/tmp/pip-uxX_9w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:23:59 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:23:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:23:59 INFO - Running setup.py (path:/tmp/pip-a2PEM6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:23:59 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:23:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:23:59 INFO - Running setup.py (path:/tmp/pip-wqa3uc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:23:59 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:23:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:23:59 INFO - Running setup.py (path:/tmp/pip-kEjxXJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:23:59 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:23:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:23:59 INFO - Running setup.py (path:/tmp/pip-qEuCAl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:23:59 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:23:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:23:59 INFO - Running setup.py (path:/tmp/pip-9nbmQm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:23:59 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:23:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:23:59 INFO - Running setup.py (path:/tmp/pip-EFScW8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:23:59 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:23:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:23:59 INFO - Running setup.py (path:/tmp/pip-8XUtzJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:23:59 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:23:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:23:59 INFO - Running setup.py (path:/tmp/pip-n5ahqa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:23:59 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:23:59 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:23:59 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:23:59 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:23:59 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:23:59 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:23:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:01 INFO - Downloading blessings-1.6.tar.gz 09:24:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:24:01 INFO - Installing collected packages: blessings 09:24:01 INFO - Running setup.py install for blessings 09:24:01 INFO - Successfully installed blessings 09:24:01 INFO - Cleaning up... 09:24:01 INFO - Return code: 0 09:24:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:24:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:24:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:24:01 INFO - Reading from file tmpfile_stdout 09:24:01 INFO - Current package versions: 09:24:01 INFO - argparse == 1.2.1 09:24:01 INFO - blessings == 1.6 09:24:01 INFO - blobuploader == 1.2.4 09:24:01 INFO - docopt == 0.6.1 09:24:01 INFO - manifestparser == 1.1 09:24:01 INFO - mozInstall == 1.12 09:24:01 INFO - mozcrash == 0.16 09:24:01 INFO - mozdebug == 0.1 09:24:01 INFO - mozdevice == 0.47 09:24:01 INFO - mozfile == 1.2 09:24:01 INFO - mozhttpd == 0.7 09:24:01 INFO - mozinfo == 0.9 09:24:01 INFO - mozleak == 0.1 09:24:01 INFO - mozlog == 3.1 09:24:01 INFO - moznetwork == 0.27 09:24:01 INFO - mozprocess == 0.22 09:24:01 INFO - mozprofile == 0.27 09:24:01 INFO - mozrunner == 6.11 09:24:01 INFO - mozscreenshot == 0.1 09:24:01 INFO - mozsystemmonitor == 0.0 09:24:01 INFO - moztest == 0.7 09:24:01 INFO - mozversion == 1.4 09:24:01 INFO - psutil == 3.1.1 09:24:01 INFO - requests == 1.2.3 09:24:01 INFO - wsgiref == 0.1.2 09:24:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:01 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 0x7f22ecc7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf27500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf246a0>, '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 0xf255a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf25a30>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1453483374.787094-52715717', '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:24:01 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:24:01 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:24:01 INFO - Using env: {'DISPLAY': ':0', 09:24:01 INFO - 'HOME': '/home/cltbld', 09:24:01 INFO - 'LANG': 'en_US.UTF-8', 09:24:01 INFO - 'LANGUAGE': 'en_US:en', 09:24:01 INFO - 'LOGNAME': 'cltbld', 09:24:01 INFO - 'MAIL': '/var/mail/cltbld', 09:24:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:01 INFO - 'MOZ_NO_REMOTE': '1', 09:24:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:01 INFO - 'NO_EM_RESTART': '1', 09:24:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:24:01 INFO - 'PWD': '/builds/slave/test-pgo', 09:24:01 INFO - 'SHELL': '/bin/bash', 09:24:01 INFO - 'SHLVL': '1', 09:24:01 INFO - 'TERM': 'linux', 09:24:01 INFO - 'TMOUT': '86400', 09:24:01 INFO - 'USER': 'cltbld', 09:24:01 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1453483374.787094-52715717', 09:24:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:01 INFO - '_': '/tools/buildbot/bin/python'} 09:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:02 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:24:02 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:24:02 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:24:02 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:24:02 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:24:02 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:24:02 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:24:02 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:24:02 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:24:02 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:24:02 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:24:02 INFO - Cleaning up... 09:24:02 INFO - Return code: 0 09:24:02 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:24: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:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24: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:24:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f22ecc7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf27500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf246a0>, '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 0xf255a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf25a30>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1453483374.787094-52715717', '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:24: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', 'jsonschema'] in /builds/slave/test-pgo/build 09:24: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 jsonschema 09:24:02 INFO - Using env: {'DISPLAY': ':0', 09:24:02 INFO - 'HOME': '/home/cltbld', 09:24:02 INFO - 'LANG': 'en_US.UTF-8', 09:24:02 INFO - 'LANGUAGE': 'en_US:en', 09:24:02 INFO - 'LOGNAME': 'cltbld', 09:24:02 INFO - 'MAIL': '/var/mail/cltbld', 09:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:02 INFO - 'MOZ_NO_REMOTE': '1', 09:24:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:02 INFO - 'NO_EM_RESTART': '1', 09:24:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:24:02 INFO - 'PWD': '/builds/slave/test-pgo', 09:24:02 INFO - 'SHELL': '/bin/bash', 09:24:02 INFO - 'SHLVL': '1', 09:24:02 INFO - 'TERM': 'linux', 09:24:02 INFO - 'TMOUT': '86400', 09:24:02 INFO - 'USER': 'cltbld', 09:24:02 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1453483374.787094-52715717', 09:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:02 INFO - '_': '/tools/buildbot/bin/python'} 09:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:02 INFO - Downloading/unpacking jsonschema 09:24: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:24: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:24: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:24: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:24: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:24: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:24:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:24:04 INFO - Downloading/unpacking functools32 (from jsonschema) 09:24: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:24: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:24: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:24: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:24: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:24: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:24:04 INFO - Downloading functools32-3.2.3-2.tar.gz 09:24:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:24:04 INFO - warning: no files found matching '*.txt' 09:24:04 INFO - no previously-included directories found matching 'build' 09:24:04 INFO - no previously-included directories found matching 'dist' 09:24:04 INFO - no previously-included directories found matching '.git*' 09:24:04 INFO - Installing collected packages: jsonschema, functools32 09:24:04 INFO - Running setup.py install for functools32 09:24:04 INFO - warning: no files found matching '*.txt' 09:24:04 INFO - no previously-included directories found matching 'build' 09:24:04 INFO - no previously-included directories found matching 'dist' 09:24:04 INFO - no previously-included directories found matching '.git*' 09:24:04 INFO - Successfully installed jsonschema functools32 09:24:04 INFO - Cleaning up... 09:24:04 INFO - Return code: 0 09:24:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:04 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 0x7f22ecc7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf27500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf246a0>, '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 0xf255a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf25a30>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1453483374.787094-52715717', '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:24:04 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:24:04 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:24:04 INFO - Using env: {'DISPLAY': ':0', 09:24:04 INFO - 'HOME': '/home/cltbld', 09:24:04 INFO - 'LANG': 'en_US.UTF-8', 09:24:04 INFO - 'LANGUAGE': 'en_US:en', 09:24:04 INFO - 'LOGNAME': 'cltbld', 09:24:04 INFO - 'MAIL': '/var/mail/cltbld', 09:24:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:04 INFO - 'MOZ_NO_REMOTE': '1', 09:24:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:04 INFO - 'NO_EM_RESTART': '1', 09:24:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:24:04 INFO - 'PWD': '/builds/slave/test-pgo', 09:24:04 INFO - 'SHELL': '/bin/bash', 09:24:04 INFO - 'SHLVL': '1', 09:24:04 INFO - 'TERM': 'linux', 09:24:04 INFO - 'TMOUT': '86400', 09:24:04 INFO - 'USER': 'cltbld', 09:24:04 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1453483374.787094-52715717', 09:24:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:04 INFO - '_': '/tools/buildbot/bin/python'} 09:24:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:04 INFO - Downloading/unpacking flake8 09:24: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:24: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:24: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:24: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:24: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:24: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:24:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:24:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:24:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:24:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:24:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:24:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:24:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:24:07 INFO - no previously-included directories found matching 'docs/_build' 09:24:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:24:07 INFO - Running setup.py install for pep8 09:24:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:24:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:24:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:24:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:24:07 INFO - no previously-included directories found matching 'docs/_build' 09:24:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:24:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:24:07 INFO - Cleaning up... 09:24:07 INFO - Return code: 0 09:24:07 INFO - Running post-action listener: _resource_record_post_action 09:24:07 INFO - Running post-action listener: _start_resource_monitoring 09:24:07 INFO - Starting resource monitoring. 09:24:07 INFO - ##### 09:24:07 INFO - ##### Running install step. 09:24:07 INFO - ##### 09:24:07 INFO - Running pre-action listener: _resource_record_pre_action 09:24:07 INFO - Running main action method: install 09:24:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:24:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:24:07 INFO - Reading from file tmpfile_stdout 09:24:07 INFO - Detecting whether we're running mozinstall >=1.0... 09:24:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:24:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:24:07 INFO - Reading from file tmpfile_stdout 09:24:07 INFO - Output received: 09:24:07 INFO - Usage: mozinstall [options] installer 09:24:07 INFO - Options: 09:24:07 INFO - -h, --help show this help message and exit 09:24:07 INFO - -d DEST, --destination=DEST 09:24:07 INFO - Directory to install application into. [default: 09:24:07 INFO - "/builds/slave/test-pgo"] 09:24:07 INFO - --app=APP Application being installed. [default: firefox] 09:24:07 INFO - mkdir: /builds/slave/test-pgo/build/application 09:24:07 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:24:07 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:24:22 INFO - Reading from file tmpfile_stdout 09:24:22 INFO - Output received: 09:24:22 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:24:22 INFO - Running post-action listener: _resource_record_post_action 09:24:22 INFO - ##### 09:24:22 INFO - ##### Running run-tests step. 09:24:22 INFO - ##### 09:24:22 INFO - Running pre-action listener: _resource_record_pre_action 09:24:22 INFO - Running main action method: run_tests 09:24:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:24:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:24:22 INFO - Python 2.7.3 09:24:22 INFO - Return code: 0 09:24:22 INFO - grabbing minidump binary from tooltool 09:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:22 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 0xf246a0>, '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 0xf255a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf25a30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:24:22 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:24:22 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:24:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:24:22 INFO - Return code: 0 09:24:22 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:24:22 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:24:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:24:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:24:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:24:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:24:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:24:23 INFO - Return code: 0 09:24:23 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/ZDxVibeIQAelFrXkPXgRVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 09:24:23 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/ZDxVibeIQAelFrXkPXgRVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost 09:24:23 INFO - Using env: {'DISPLAY': ':0', 09:24:23 INFO - 'HOME': '/home/cltbld', 09:24:23 INFO - 'LANG': 'en_US.UTF-8', 09:24:23 INFO - 'LANGUAGE': 'en_US:en', 09:24:23 INFO - 'LOGNAME': 'cltbld', 09:24:23 INFO - 'MAIL': '/var/mail/cltbld', 09:24:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:24:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:23 INFO - 'MOZ_NO_REMOTE': '1', 09:24:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:24:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:23 INFO - 'NO_EM_RESTART': '1', 09:24:23 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:24:23 INFO - 'PWD': '/builds/slave/test-pgo', 09:24:23 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:24:23 INFO - 'SHELL': '/bin/bash', 09:24:23 INFO - 'SHLVL': '1', 09:24:23 INFO - 'TERM': 'linux', 09:24:23 INFO - 'TMOUT': '86400', 09:24:23 INFO - 'USER': 'cltbld', 09:24:23 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1453483374.787094-52715717', 09:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:23 INFO - '_': '/tools/buildbot/bin/python'} 09:24:23 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/ZDxVibeIQAelFrXkPXgRVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost'] with output_timeout 3600 09:24:23 INFO - mozversion INFO | application_buildid: 20160122065828 09:24:23 INFO - mozversion INFO | application_changeset: 8e913ace1e198c34423bfadc807296f6400078bd 09:24:23 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 09:24:23 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:24:23 INFO - mozversion INFO | application_name: Firefox 09:24:23 INFO - mozversion INFO | application_remotingname: firefox-dev 09:24:23 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:24:23 INFO - mozversion INFO | application_vendor: Mozilla 09:24:23 INFO - mozversion INFO | application_version: 45.0a2 09:24:23 INFO - mozversion INFO | platform_buildid: 20160122065828 09:24:23 INFO - mozversion INFO | platform_changeset: 8e913ace1e198c34423bfadc807296f6400078bd 09:24:23 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:24:23 INFO - mozversion INFO | platform_version: 45.0a2 09:24:23 INFO - 2016-01-22 09:24:23,787 DEBUG : using testdate: 1453483463 09:24:23 INFO - 2016-01-22 09:24:23,787 DEBUG : actual date: 1453483463 09:24:23 INFO - 2016-01-22 09:24:23,795 INFO : starting webserver on 'localhost:40743' 09:24:23 INFO - 2016-01-22 09:24:23,796 INFO : Starting test suite talos-linux64-ix-041.e 09:24:23 INFO - 2016-01-22 09:24:23,796 INFO : Starting test dromaeo_css 09:24:23 INFO - 2016-01-22 09:24:23,796 DEBUG : operating with platform_type : linux_ 09:24:23 INFO - 2016-01-22 09:24:23,797 INFO : Initialising browser for dromaeo_css test... 09:24:23 INFO - 2016-01-22 09:24:23,813 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnhbhC2/profile http://localhost:40743/getInfo.html 09:24:27 INFO - 2016-01-22 09:24:27,964 DEBUG : BROWSER_OUTPUT: 09:24:27 INFO - 2016-01-22 09:24:27,964 DEBUG : BROWSER_OUTPUT: (process:23874): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:24:28 INFO - 2016-01-22 09:24:28,995 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:24:28 INFO - 2016-01-22 09:24:28,996 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:24:28 INFO - 2016-01-22 09:24:28,996 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:24:28 INFO - 2016-01-22 09:24:28,996 DEBUG : BROWSER_OUTPUT: __metrics 09:24:30 INFO - 2016-01-22 09:24:30,021 INFO : Browser initialized. 09:24:30 INFO - 2016-01-22 09:24:30,021 INFO : Running cycle 1/1 for dromaeo_css test... 09:24:30 INFO - 2016-01-22 09:24:30,022 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnhbhC2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:24:31 INFO - 2016-01-22 09:24:31,286 DEBUG : BROWSER_OUTPUT: 09:24:31 INFO - 2016-01-22 09:24:31,287 DEBUG : BROWSER_OUTPUT: (process:23989): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:24:41 INFO - 2016-01-22 09:24:41,791 DEBUG : BROWSER_OUTPUT: RSS: Main: 136355840 09:24:41 INFO - 2016-01-22 09:24:41,791 DEBUG : BROWSER_OUTPUT: 09:25:31 INFO - 2016-01-22 09:25:31,406 DEBUG : BROWSER_OUTPUT: 1453483531402 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:27:38 INFO - 2016-01-22 09:27:38,894 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40743/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40743/tests/dromaeo/cssquery-ext.html) 09:27:39 INFO - 2016-01-22 09:27:39,887 DEBUG : BROWSER_OUTPUT: RSS: Main: 141754368 09:27:39 INFO - 2016-01-22 09:27:39,887 DEBUG : BROWSER_OUTPUT: 09:30:41 INFO - 2016-01-22 09:30:41,670 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40743/tests/dromaeo/cssquery-ext.html (next: http://localhost:40743/tests/dromaeo/cssquery-jquery.html) 09:30:42 INFO - 2016-01-22 09:30:42,256 DEBUG : BROWSER_OUTPUT: RSS: Main: 139317248 09:30:42 INFO - 2016-01-22 09:30:42,256 DEBUG : BROWSER_OUTPUT: 09:33:43 INFO - 2016-01-22 09:33:43,897 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40743/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40743/tests/dromaeo/cssquery-mootools.html) 09:33:44 INFO - 2016-01-22 09:33:44,484 DEBUG : BROWSER_OUTPUT: RSS: Main: 139259904 09:33:44 INFO - 2016-01-22 09:33:44,484 DEBUG : BROWSER_OUTPUT: 09:36:46 INFO - 2016-01-22 09:36:46,106 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40743/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40743/tests/dromaeo/cssquery-prototype.html) 09:36:46 INFO - 2016-01-22 09:36:46,694 DEBUG : BROWSER_OUTPUT: RSS: Main: 139300864 09:36:46 INFO - 2016-01-22 09:36:46,694 DEBUG : BROWSER_OUTPUT: 09:39:48 INFO - 2016-01-22 09:39:48,936 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40743/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40743/tests/dromaeo/cssquery-yui.html) 09:39:49 INFO - 2016-01-22 09:39:49,522 DEBUG : BROWSER_OUTPUT: RSS: Main: 139137024 09:39:49 INFO - 2016-01-22 09:39:49,523 DEBUG : BROWSER_OUTPUT: 09:42:51 INFO - 2016-01-22 09:42:51,458 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40743/tests/dromaeo/cssquery-yui.html (next: http://localhost:40743/tests/dromaeo/cssquery-dojo.html) 09:42:51 INFO - 2016-01-22 09:42:51,709 DEBUG : BROWSER_OUTPUT: RSS: Main: 142135296 09:42:51 INFO - 2016-01-22 09:42:51,709 DEBUG : BROWSER_OUTPUT: 09:42:51 INFO - 2016-01-22 09:42:51,710 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:42:51 INFO - 2016-01-22 09:42:51,710 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:42:51 INFO - 2016-01-22 09:42:51,711 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:42:51 INFO - 2016-01-22 09:42:51,711 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:42:51 INFO - 2016-01-22 09:42:51,712 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3273.214428537151;3294.242324265417;3319.3527262183875;3322.8868329109746;3325.268440942993;5397.811076612319;5420.403755586883;5440.5919556033305;5441;5486.177073438987;5452.073147564914;5473.397926228112;5473.972630136844;5478.096114141162;5483.259759932418;4960.156773348531;5007.599392048627;5057.974710126444;5080.872978175556;5099.235114732783;4839.128956787777;5009.173486374744;5021.422536408323;5057.721825299607;5166.5866730661455;4978.303037574742;5062.670926389791;5072.949270507284;5081.136206844827;5168.664036837612;5029.321041659402;5032.119379108642;5046.54581087702;5048.1670524363435;5071.239314102896;4860.635452341053;4914.16459201933;4950.504949505057;4961.627877909171;4998.150314446553;5298.788048478056;5325.4940780625775;5337.546308563777;5359.464053594648;5372.301600791911;5897.705114744289;5924.526037916957;5930.911036334458;5936;5943.138244954501;5677.943220567783;5863.237779088734;5874.295084589834;5984.97007514964;5985.6408615483215;5539.584531160179;5550.4449555044575;5568.638038527523;5573.9163912540935;5581.748821303051;6023.849403764941;6034.125051867454;6042.6978651067275;6047.667378294148;6051.606645568024;5669.829905102853;5755.827325180251;5789.102689083199;5789.971050144806;5871.706414679249;5876.706164691748;5914.349421563625;5923.08192230205;5926.822195334147;5959;5617.241672374259;5905.379935106752;5907.527397808165;5910.586258961917;5919.526437885045;5747.5114615257335;5791.131330300489;5828.94171058284;5830.679312637761;5849.151872978479;4560.521145279764;4566.862994110182;4595.012072404449;4595.149897268949;4604.102200071021;3970.940435893464;4083.632473077437;4111.48606424197;4128.958710412858;4140.585941405835;5511.669299842022;5569.192467092249;5620.690862002547;5639.069553523705;5647.49172574462;5866.765329386777;5936.28764548257;5941.584089113807;5941.851453713605;5949.702514874239;5457.645253058538;5565.387807341189;5586.776528938797;5605.971970140124;5618.662880227118;4964.280179373971;5067.3412456381175;5079.1365467870555;5085.160948443539;5096.643234973591;6010.278766548042;6037.0642550404755;6048.637081775108;6050.788222412194;6080.878382432326;5734.340550836707;5775.249217601685;5841.415858414124;5920.052791553331;5946.13781001761;6083.117947897618;6107.572469927062;6116.480099191618;6122.2959359674205;6125.571210015256;5780.421957804186;5895.557833162616;5902.2622172228475;5904.675242861512;5910.320313164041;5566.332040155207;5695.629784064023;5696.088625819849;5712.685802280915;5939.628051451541;5689.118186681071;5819.883602328015;5824.475797178275;5850.970745146247;5857.707114644336;5776.162456443708;5795.884082318415;5805.129230615442;5838.737256823369;5846.707664616837;5494.450554944474;5601.327840659147;5624.381318054929;5735.8852822944145;5749.396313387034;5810.215620891295;5838.503727183237;5862.648241105377;5875.3243377012195;5891.558133140117;5706.914396284142;5709.885802284014;5713.143028545752;5720.513756330759;5755.510781583613 09:42:51 INFO - 2016-01-22 09:42:51,713 DEBUG : BROWSER_OUTPUT: |1;ext.html;583.2126629050782;623.2987888625297;624.581530374649;631.1132858334042;652.2759736692274;27524.724752752467;41016.794916025414;41589.7920510397;41629.58370416295;41634.37548436776;45599;45615.31577026339;46360.536394636045;46398.536014639925;46520;9095.226905713022;9286.58210380531;9294.488803115826;9307.162355388014;9313.16181543661;8939.284857211407;9066.320025998044;9085.636574537011;9117.863232051524;9131.543422828865;9069;9188.540572971358;9195.632174713004;9204.493752843591;9212.447253164799;8992.23565996891;9134.721139040506;9147.58835852385;9179.49512776797;9185.632574697003;8997.955010224907;9073.31950103745;9104.453732776055;9125.954370228174;9159.313051521096;42092.368614470804;42225.1554968902;42447.78776106131;42515.36226956598;42543.57456425458;3490.511328413999;3490.7207423406066;3509.3858574749315;3664.926701465956;3744.2698673758628;31959.520607190912;32411.837940810146;32780.344393112246;33034.339313213604;33769.83115084434;3585.551806024247;3622.094476380905;3652.8904132876055;3653.488511608377;3670;282737;284502;284765;284915;285213;45165.322520162226;45214.32178517325;45221;45223;45235.095298094515;42752;43024.3546346805;43027;43144.35283470688;43197.78401108037;16508.25712842901;16630.3347866084;16681.582960425843;16692.666146677;16739.16304184786;13595.728085438433;13710.24593647359;13777.448902044007;13859.307034648227;14310.141391516543;15442;15491.380344786083;15499.302531386114;15505.767413488808;15628;6163.19878415803;6226.283977342573;6260.874782504325;6309.211348581427;6313.589616674902;970.4371464550544;1048.5962904281753;1083.0685610375072;1116.6650004998469;1120.176670147441;28406.71593284082;28918.710812892023;29054;29230.415391692473;29404;1110.4891749795186;1118.1334465789078;1146.696125526736;1197.108154424959;1218.06817784395;14978.251087445584;15279.61800954985;15322.310496027705;15625.921870390575;15752.842471575137;321515;523115;524780;526742;552308;58875.11687324694;59575.404245957856;59728.70135649381;59731.70134149301;59980;1472.8158980127484;1479.2973337664523;1501.4144483651385;1501.909885406879;1509.5018643847504;30474.695253047186;31082.844585776926;31310.843445782626;31576.368472629958;31812;53015;53388.73305633447;53602;53727.46272537224;53994;309131;310258;310899;311148;311895;44922.77538612286;44972.77513612542;45278;45468.545314546434;45700;48457;48526;48903.75548122237;48990.75504622454;49676.25485617646;38255.8523244292;40822.59177408307;41282.587174127875;41424.37863431991;41704.165916682105;40636.75081538829;41593.168136636494;42171;44868;45776.31335529903;38226.80886595549;38419.42370864384;38551.6144838548;38659.42010869783;38697.41953870638;34412.65587344095;34468.827655862566;34571.13572160716;38313.808430957666;39892.0030342965;27080.864595677685;27162;27197.592036119077;27279.77241024119;27293.590596140675 09:42:51 INFO - 2016-01-22 09:42:51,715 DEBUG : BROWSER_OUTPUT: |2;jquery.html;386.79499865071506;388.7181793199929;391.3093390166357;392.9017745563609;393.55921368067766;17169.914150429246;17628.471145865613;18939.905300473514;19134.808651913478;19150.808491915075;12137.939310303458;12185.512579496832;12329.753404931897;12339.62981110568;12392.194507357015;5079.644424890268;5173.870653233662;5174.948250517503;5192.169252919533;5196.0647083524955;5151.227315902626;5260.368755749316;5395.325584301962;5397.595180361469;5405.783768649249;5331.360236771573;5371.4897084776885;5384.811531596395;5391.757370918299;5549.94551035302;5542.418046105161;5564.693941833198;5567.805126820583;5573.777048918038;5588.105903055512;5062.164742817431;5194.71429071401;5384.7846086156505;5415.620906536544;5420.810271640474;13213.73572528544;13411.932940335237;13433.32833358338;20430.182792688276;22021;2146.12009076278;2235.3517479930965;2345.3667509772267;2361.409647588103;2391.712994440661;14842;14874.702505949928;14981.400743970227;15227.162506062163;15236.390544378211;1803.7925638551603;1858.7862395824518;1959.1379792891225;1959.5590992026823;1978.7130866024345;73941.26058739398;76316.23683763147;76967.61516192439;77355;77794;17212.39756608513;17215.22531486086;17290.394836180672;17305.826941730673;17363.82636173622;26684.733152668614;26983;27122.18633441;27229.319267018484;27365.726342736318;10352.948235258775;10378.169746420268;10379.948100259602;10414.583416663248;10444.373337599769;8922.821543569093;8939.106089391009;8950.86573701395;8963.820723585492;9005.14451127142;4369.344598310216;8620.396572240008;8634.829472088915;8647;8867.467951922905;1981.2075169932143;2046.1815273890265;2051.0770153431017;2060.7115003899467;2077.418322869599;476.91653960556766;490.399260905388;496.4662987288679;976.1588150627305;1056.3345092591771;11047.72380690489;11082.833757493645;11156.442177891235;11184.552617895193;11231.21381503287;481.86748644123145;491.9458859525449;493.2822742909059;493.5582653525075;493.56073094945526;6007.128966299862;6138.416850399205;6196.938030619726;6220.160278362363;6279.623222606567;623307;634557;636451;645029;658550;84456.57771711102;86514;86741.13258867331;86815;87916;510.4461659099844;517.8498235511735;517.9507946745053;518.132128684452;518.948105189478;10590.576376944837;10766;10794;10808.081313088476;10809.459527023775;33872.49191262084;34605.13487162841;34882.825585871906;35297;36419.63580364268;45028;45869.77065114653;47921.281180783015;47933.76033119812;48190.27714584354;9603.519824008912;9883.950580247052;9966.252531060345;9983.950080249553;10027.348222365523;11508.36703981289;11573.479193436147;11863.110266730202;14247;15001.699966000837;10579.206559507913;10669.146468282364;10704.839427408438;10809.56761729522;10888.45557722095;10616.363018218932;10749.623763168564;10990.945045275043;11217.046551043253;11302.886971130183;9930.602775889172;10193.082622564005;10955.014048735651;11312.83030754523;11347.37589432589;15828.762568561711;15856.207189640703;15987.520374388787;16106.516804495885;16131.709463243147;16473.505794826175;16508.66982660364;16569.088700121127;16571.66856662836;16678.416255431486 09:42:51 INFO - 2016-01-22 09:42:51,718 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1582.1772678207326;1592.5302035899408;1799.7120460726287;1870.8409785168262;1896.1372575478158;7851.725189618364;7919.168487308836;8078;8083.757487275384;8122.796930076751;8240.464369815958;8369.83260334793;8388.412811103226;8389.370797190204;8419.452735572198;2343.8828058597087;2369.9098414729247;2374.5963186258377;2375.726791418983;2379.95240095198;2396.5686176488225;2421.503591763693;2439.3413778279855;2453.129139155601;2467.235157101304;2339.3449834046496;2367.621180611103;2385;2393.8922748476275;2394.1979436888664;2322.5703244899746;2326.6161083421216;2349.6005679034606;2354.587947109266;2357.422431504284;2372.2764556810166;2381.4403615150427;2392.3899405651623;2401.807855371566;2405.2183040511904;8098.554579498125;8200.507969521788;8215.424920255584;8221;8251.381146414044;4849.612031037544;4885.022995400934;4889.608831293488;4915.139850526144;4938.135826230396;3038.8176709397285;3051.9847400763074;3065.1877252528097;3071.6314042314843;3162.6204855417495;982.3369225772575;984.8965858584817;1000.1049061090356;1007.1489591295343;1033.0702367868903;11038.448077596087;11173.553057877756;11193.048590869786;11206.719832004184;11220.270682405699;4095.1604920991126;4141.855035073818;4169.833206671699;4233.491980962304;4345.717528360647;9256.907430925605;9260.722178334661;9276.814463710823;9280.211182049601;9307.627694892128;4745.311929770164;4748.8337908173735;4767.594754445841;4773.522647735199;4778.1638213312535;3926.3521518949055;3981.8651684269844;4387.978060109743;4434.445694288214;4499.955000449953;3537.4163263061823;3542.2738338640515;3576.159602493412;3652.5069115669044;3680.1535646801385;1080.6163811846682;1084.3927400655657;1088.8040152772578;1091.067137597343;1094.6606551968914;1045.6601604478574;1066.269605320358;1090.0571006079683;1090.6564432203832;1100.471773548701;7300.6349682515665;7320.9633951830965;7350.338469537767;7350.889736653954;7357.301056399633;1295.514182181682;1313.40240190713;1317.0583033131356;1318.5121505043196;1319.346923272986;5636.689982051026;5713.857153571111;5716.371199168088;5721.485066344049;5725.370209276976;9565.04349565038;9603.9039609603;9754.0733630305;9838.75403114928;9950.1542368898;9608.711738647851;9738;9749.756256093513;9825.754356141153;9849.852252216222;7576.772696818994;7584.62076896153;7694.461387702919;7767.184445633127;7791.805204869924;7654.311111999947;7672.693092276247;7682;7696.15342312334;7709.2290770922455;8227.712030079158;8289.253967142746;8377.329813614775;8433.87349189775;8516.787080323042;8377.45546539473;8579.528125953133;8603.05366409707;8608.09614990442;8727.738167854974;6838.179418469816;7003.894941575983;7047.08387909589;7231.8553628928175;7338.889916651361;7605.6577454013595;7690.038745156856;7707.922920770945;7709;7778.6888524460655;6986.580805151707;7140.143182818095;7150.856982860209;7237.782866514013;7355.889661654973;7111.53775004623;7165.5700657958605;7209.170945341353;7216.314450127229;7253.637318133967;7039.507234493536;7233.457490688114;7233.493655444279;7240.348368646636;7258.673359698721;6421.068945003042;6440.388163124496;6442.935570644234;6451.2903580607035;6454.225492940689;6635.734570617121;6658.700358483783;6676.9666151668935;6700.061991321121;6723.294054124247 09:42:51 INFO - 2016-01-22 09:42:51,718 DEBUG : BROWSER_OUTPUT: |4;prototype.html;351.37455329513466;363.79082027834;379.8765401244596;381.7556763671251;382.1992924822499;6232.532560058003;6297.433231009209;6297.464715499183;6303.3381494943005;6341.302456729756;6204.472619827309;6298.834715577621;6333.271673757519;6350.872982540346;6359.71381287842;4900.681455705386;4916.410030796301;4925.138100832358;4928.827491037814;4949.8020079196785;4939.937913348629;4948.950510494903;4953.430355509108;4954.950450495485;4955.504449555052;4721.913959789234;4839.225723884179;4855.344528488644;4877.073356062355;4892.510748925115;4847.103285892122;4877.463479017305;4884.926726099111;4891.779869905863;4892.461829198821;4271.103068355649;4284.9143017139795;4285.314349704064;4292.656587472995;4299.828006879721;5962.672053037081;6053.303870054956;6054.364291749391;6054.909176362358;6061.51507879373;5678.886422271573;5679.886402271973;5685.602007859451;5691.630044047124;5701.486866182022;6678.565893216925;6698.296678848748;6703.262641109474;6719.899201511981;6723.7982860513775;4697.201475749097;4748.38271024768;4752.5247475252545;4753.619710423158;4758.953030333321;6853.383195512428;6924.896126558106;6973.163220413532;6992.1958974717545;6997.615131167784;4813.542713442217;4820.517948205152;4833.299171620095;4835.250536166829;4842.58837998767;4903.754812259373;4903.754812259373;4915.26271059344;4917.778699958439;4929.630277729185;5503.752331145108;5626.35296940857;5638.830835074954;5647.548196144298;5662.207290979266;6793.184817821893;6806.931930680729;6828.692708828015;6829.146356705412;6847.281035491302;1675.689997350494;1734.1502663694698;1735.106420193576;1735.7483164941013;1738.721804511272;1154.6016624264614;1166.4750862111914;1171.7363593191635;1182.5210789630214;1182.7338848759132;6373.235211774617;6417.069524918954;6462.159919210472;6491.253505846794;6493.545451818327;6872.41584465326;6922.826929326707;6963.09479767627;6963.1644202696;6968.233494315621;6387.616742995435;6408.102865598727;6429.517786166056;6461.57999730016;6491;3765.4163604641326;3781.4516895050065;3783.697304215656;3785.2240290740333;3785.299719551892;7168.713251469882;7201.243869393743;7205.963970180115;7212.7114915403845;7225.2774722528375;6938.583684978817;7077.115360579927;7095.148582170069;7105.857882842314;7131.358177763922;7092.148942126978;7093.964530177419;7107.466939979418;7109.466789990772;7206.495545311778;6927;6962.721491140298;6965.651717414008;6969.895451568332;6971.79084627462;6679.298673639198;6799.3200679931615;6833.521653484208;6844.794656160323;6853;7140.607266600179;7152.9284707152265;7156.069710937753;7182.17404998411;7186.425085993003;4778.593819525379;4833.613310935047;4841.903161936812;4848.587870031087;4852.975735121302;6820.181578210448;6902.275261097512;6934.826629334307;6954.478414119062;7036.964815175891;6874.209465911485;6881.174259088942;6909.7581584644295;6917.204521480095;6926.58440493572;6838;6873.5875847449315;6877.209120951155;6882.621455819978;6884.311568843075;6656.30108838565;6761.425278851353;6803.7618683345845;6806.7957961261245;6818.590884546943;6889.138857642794;6903.102596662402;6914.308569143247;6916.135483064617;6919.411849992605;6652.168478940132;6696.866062678817;6697.397234248941;6702.430293425114;6704.530682852349 09:42:51 INFO - 2016-01-22 09:42:51,718 DEBUG : BROWSER_OUTPUT: |5;yui.html;869.6738722978882;896.1173244354314;919;921.1157289002557;943.9805010588562;12293.69265768355;12634.431450584723;12660.24038557686;14364.640883977905;14394.352254148562;12837.679058023554;13059.281739504324;13070.15044022138;13089.149205301648;13116.73766524669;910.2717825739383;914.743871715919;915.7847905742145;920.3005715656083;935.9064093590621;926.6154545863459;931.1247427418239;932.035343419561;936.035883040466;936.9531523423835;948.8576713492962;956.3592393096642;958.018031517693;958.8465845464727;962.5524131278954;948.2603569216022;949.6723630347519;950.4534892436842;953.1707414549317;959.4770849886828;707.5400989356959;707.7310621963621;708.3872450330427;710.2577806192542;716.7419728897593;13152.21086734799;13198.802017969738;13307.401166947511;13339.733205335937;13428.395722192525;11883.465244064038;12161.391930403533;12224.755504889852;12286.877131228752;12885.67785805353;9205.606542298983;9340.34617576763;9379.015203403613;9386.671466498708;9454.90545094547;3572.1962558424407;3638.5269914911155;3662.3041622091982;3683.6684698377007;3740.1584643455276;48332;48467.51532484665;48515.51484485145;48532.514674853504;48548.27177592339;9396;9789.265805064648;9796.26528010402;9844.950775246078;9935.453550054817;16060.75908861368;16183.919080404523;16228.51314460568;16274.67450651004;16291;7047.048648432498;7336.119665640157;7695;7884.132745398002;7914.287714105643;4577.313402989512;4578.885527861764;4618.861434156981;4660.673752837337;4686.554777296152;3234.36929798687;3257.218267615755;3279.5736554247796;3280.245543524955;3283.622383425889;568.3009897825698;615.9045347971072;617.2099712368176;619.1146660275759;624.1418050181001;668.1147479589563;669.18723898485;681.2948598200838;690.6339639990813;709.8048036789821;8469.576521173916;9287.303452241109;9528.714138575853;9535.618575256913;9623;585.9472647461749;672.2403683837331;687.9552829066095;712.4478529139958;736.7347754808264;3828.578856325802;3840.9807950960067;3865.690744740414;3901.1027463682944;3978.224246271949;56418;57498.41257143438;57767;58202;58935.115973260436;52355;52884.94230115376;52950.73524632352;53910.191347129825;53911.73044134833;47812.28281575779;48056.5194348059;48141.75929120332;49271.75364123228;49277.75361123172;8981.371304008657;9020.86468702983;9065.728028159167;9145.3598248122;9310.0224476429;37309.6269037317;37526.43710344292;37678.62321376751;37869.62130378661;38161.23677526489;46944;47272.52727472681;47398.28902566395;47813.760931195124;48141;10976.670699879016;11372.772544549229;11607.535698572301;11646.777088405595;11754.177207595729;12107.697307567381;12236.327002014974;12240.265584064984;12399;12492.750144997231;11023.724406889893;11302.943485282522;11710.70723231926;11710.946014858704;11997.880021199677;11040.227184097035;11264.774704506028;11490;11612.709682258012;11962.34207118582;11285.492152852978;11810.173287869766;12245.510179592717;12324.50701971911;12790;9676.564554595201;10077.941816109496;10692.14462842955;10830.241883068109;11024.724381890517;9602.231821454126;9674.177694896012;9893.109620134222;9943.850842237227;9947.801043979225 09:42:51 INFO - 2016-01-22 09:42:51,718 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:42:51 INFO - 2016-01-22 09:42:51,718 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:42:51 INFO - 2016-01-22 09:42:51,719 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,306 09:42:51 INFO - 2016-01-22 09:42:51,719 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:42:51 INFO - 2016-01-22 09:42:51,719 DEBUG : BROWSER_OUTPUT: __startTimestamp1453484571709__endTimestamp 09:42:51 INFO - 2016-01-22 09:42:51,719 DEBUG : BROWSER_OUTPUT: 09:42:51 INFO - 2016-01-22 09:42:51,719 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:42:51 INFO - 2016-01-22 09:42:51,720 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:42:51 INFO - 2016-01-22 09:42:51,720 DEBUG : BROWSER_OUTPUT: 09:42:51 INFO - 2016-01-22 09:42:51,720 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5475.60 Median:5689.12 stddev:598.86 (10.5%) stddev-sans-first:575.23 09:42:51 INFO - 2016-01-22 09:42:51,720 DEBUG : BROWSER_OUTPUT: Values: 3273.2 3294.2 3319.4 3322.9 3325.3 5397.8 5420.4 5440.6 5441.0 5486.2 5452.1 5473.4 5474.0 5478.1 5483.3 4960.2 5007.6 5058.0 5080.9 5099.2 4839.1 5009.2 5021.4 5057.7 5166.6 4978.3 5062.7 5072.9 5081.1 5168.7 5029.3 5032.1 5046.5 5048.2 5071.2 4860.6 4914.2 4950.5 4961.6 4998.2 5298.8 5325.5 5337.5 5359.5 5372.3 5897.7 5924.5 5930.9 5936.0 5943.1 5677.9 5863.2 5874.3 5985.0 5985.6 5539.6 5550.4 5568.6 5573.9 5581.7 6023.8 6034.1 6042.7 6047.7 6051.6 5669.8 5755.8 5789.1 5790.0 5871.7 5876.7 5914.3 5923.1 5926.8 5959.0 5617.2 5905.4 5907.5 5910.6 5919.5 5747.5 5791.1 5828.9 5830.7 5849.2 4560.5 4566.9 4595.0 4595.1 4604.1 3970.9 4083.6 4111.5 4129.0 4140.6 5511.7 5569.2 5620.7 5639.1 5647.5 5866.8 5936.3 5941.6 5941.9 5949.7 5457.6 5565.4 5586.8 5606.0 5618.7 4964.3 5067.3 5079.1 5085.2 5096.6 6010.3 6037.1 6048.6 6050.8 6080.9 5734.3 5775.2 5841.4 5920.1 5946.1 6083.1 6107.6 6116.5 6122.3 6125.6 5780.4 5895.6 5902.3 5904.7 5910.3 5566.3 5695.6 5696.1 5712.7 5939.6 5689.1 5819.9 5824.5 5851.0 5857.7 5776.2 5795.9 5805.1 5838.7 5846.7 5494.5 5601.3 5624.4 5735.9 5749.4 5810.2 5838.5 5862.6 5875.3 5891.6 5706.9 5709.9 5713.1 5720.5 5755.5 09:42:51 INFO - 2016-01-22 09:42:51,720 DEBUG : BROWSER_OUTPUT: 09:42:51 INFO - 2016-01-22 09:42:51,720 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:53089.15 Median:41353.48 stddev:99513.19 (240.6%) stddev-sans-first:99714.27 09:42:51 INFO - 2016-01-22 09:42:51,721 DEBUG : BROWSER_OUTPUT: Values: 583.2 623.3 624.6 631.1 652.3 27524.7 41016.8 41589.8 41629.6 41634.4 45599.0 45615.3 46360.5 46398.5 46520.0 9095.2 9286.6 9294.5 9307.2 9313.2 8939.3 9066.3 9085.6 9117.9 9131.5 9069.0 9188.5 9195.6 9204.5 9212.4 8992.2 9134.7 9147.6 9179.5 9185.6 8998.0 9073.3 9104.5 9126.0 9159.3 42092.4 42225.2 42447.8 42515.4 42543.6 3490.5 3490.7 3509.4 3664.9 3744.3 31959.5 32411.8 32780.3 33034.3 33769.8 3585.6 3622.1 3652.9 3653.5 3670.0 282737.0 284502.0 284765.0 284915.0 285213.0 45165.3 45214.3 45221.0 45223.0 45235.1 42752.0 43024.4 43027.0 43144.4 43197.8 16508.3 16630.3 16681.6 16692.7 16739.2 13595.7 13710.2 13777.4 13859.3 14310.1 15442.0 15491.4 15499.3 15505.8 15628.0 6163.2 6226.3 6260.9 6309.2 6313.6 970.4 1048.6 1083.1 1116.7 1120.2 28406.7 28918.7 29054.0 29230.4 29404.0 1110.5 1118.1 1146.7 1197.1 1218.1 14978.3 15279.6 15322.3 15625.9 15752.8 321515.0 523115.0 524780.0 526742.0 552308.0 58875.1 59575.4 59728.7 59731.7 59980.0 1472.8 1479.3 1501.4 1501.9 1509.5 30474.7 31082.8 31310.8 31576.4 31812.0 53015.0 53388.7 53602.0 53727.5 53994.0 309131.0 310258.0 310899.0 311148.0 311895.0 44922.8 44972.8 45278.0 45468.5 45700.0 48457.0 48526.0 48903.8 48990.8 49676.3 38255.9 40822.6 41282.6 41424.4 41704.2 40636.8 41593.2 42171.0 44868.0 45776.3 38226.8 38419.4 38551.6 38659.4 38697.4 34412.7 34468.8 34571.1 38313.8 39892.0 27080.9 27162.0 27197.6 27279.8 27293.6 09:42:51 INFO - 2016-01-22 09:42:51,721 DEBUG : BROWSER_OUTPUT: 09:42:51 INFO - 2016-01-22 09:42:51,721 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32477.45 Median:30619.11 stddev:104622.80 (341.7%) stddev-sans-first:104888.54 09:42:51 INFO - 2016-01-22 09:42:51,721 DEBUG : BROWSER_OUTPUT: Values: 386.8 388.7 391.3 392.9 393.6 17169.9 17628.5 18939.9 19134.8 19150.8 12137.9 12185.5 12329.8 12339.6 12392.2 5079.6 5173.9 5174.9 5192.2 5196.1 5151.2 5260.4 5395.3 5397.6 5405.8 5331.4 5371.5 5384.8 5391.8 5549.9 5542.4 5564.7 5567.8 5573.8 5588.1 5062.2 5194.7 5384.8 5415.6 5420.8 13213.7 13411.9 13433.3 20430.2 22021.0 2146.1 2235.4 2345.4 2361.4 2391.7 14842.0 14874.7 14981.4 15227.2 15236.4 1803.8 1858.8 1959.1 1959.6 1978.7 73941.3 76316.2 76967.6 77355.0 77794.0 17212.4 17215.2 17290.4 17305.8 17363.8 26684.7 26983.0 27122.2 27229.3 27365.7 10352.9 10378.2 10379.9 10414.6 10444.4 8922.8 8939.1 8950.9 8963.8 9005.1 4369.3 8620.4 8634.8 8647.0 8867.5 1981.2 2046.2 2051.1 2060.7 2077.4 476.9 490.4 496.5 976.2 1056.3 11047.7 11082.8 11156.4 11184.6 11231.2 481.9 491.9 493.3 493.6 493.6 6007.1 6138.4 6196.9 6220.2 6279.6 623307.0 634557.0 636451.0 645029.0 658550.0 84456.6 86514.0 86741.1 86815.0 87916.0 510.4 517.8 518.0 518.1 518.9 10590.6 10766.0 10794.0 10808.1 10809.5 33872.5 34605.1 34882.8 35297.0 36419.6 45028.0 45869.8 47921.3 47933.8 48190.3 9603.5 9884.0 9966.3 9984.0 10027.3 11508.4 11573.5 11863.1 14247.0 15001.7 10579.2 10669.1 10704.8 10809.6 10888.5 10616.4 10749.6 10990.9 11217.0 11302.9 9930.6 10193.1 10955.0 11312.8 11347.4 15828.8 15856.2 15987.5 16106.5 16131.7 16473.5 16508.7 16569.1 16571.7 16678.4 09:42:51 INFO - 2016-01-22 09:42:51,721 DEBUG : BROWSER_OUTPUT: 09:42:51 INFO - 2016-01-22 09:42:51,721 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5618.33 Median:6447.11 stddev:2923.33 (45.3%) stddev-sans-first:2915.79 09:42:51 INFO - 2016-01-22 09:42:51,722 DEBUG : BROWSER_OUTPUT: Values: 1582.2 1592.5 1799.7 1870.8 1896.1 7851.7 7919.2 8078.0 8083.8 8122.8 8240.5 8369.8 8388.4 8389.4 8419.5 2343.9 2369.9 2374.6 2375.7 2380.0 2396.6 2421.5 2439.3 2453.1 2467.2 2339.3 2367.6 2385.0 2393.9 2394.2 2322.6 2326.6 2349.6 2354.6 2357.4 2372.3 2381.4 2392.4 2401.8 2405.2 8098.6 8200.5 8215.4 8221.0 8251.4 4849.6 4885.0 4889.6 4915.1 4938.1 3038.8 3052.0 3065.2 3071.6 3162.6 982.3 984.9 1000.1 1007.1 1033.1 11038.4 11173.6 11193.0 11206.7 11220.3 4095.2 4141.9 4169.8 4233.5 4345.7 9256.9 9260.7 9276.8 9280.2 9307.6 4745.3 4748.8 4767.6 4773.5 4778.2 3926.4 3981.9 4388.0 4434.4 4500.0 3537.4 3542.3 3576.2 3652.5 3680.2 1080.6 1084.4 1088.8 1091.1 1094.7 1045.7 1066.3 1090.1 1090.7 1100.5 7300.6 7321.0 7350.3 7350.9 7357.3 1295.5 1313.4 1317.1 1318.5 1319.3 5636.7 5713.9 5716.4 5721.5 5725.4 9565.0 9603.9 9754.1 9838.8 9950.2 9608.7 9738.0 9749.8 9825.8 9849.9 7576.8 7584.6 7694.5 7767.2 7791.8 7654.3 7672.7 7682.0 7696.2 7709.2 8227.7 8289.3 8377.3 8433.9 8516.8 8377.5 8579.5 8603.1 8608.1 8727.7 6838.2 7003.9 7047.1 7231.9 7338.9 7605.7 7690.0 7707.9 7709.0 7778.7 6986.6 7140.1 7150.9 7237.8 7355.9 7111.5 7165.6 7209.2 7216.3 7253.6 7039.5 7233.5 7233.5 7240.3 7258.7 6421.1 6440.4 6442.9 6451.3 6454.2 6635.7 6658.7 6677.0 6700.1 6723.3 09:42:51 INFO - 2016-01-22 09:42:51,723 DEBUG : BROWSER_OUTPUT: 09:42:51 INFO - 2016-01-22 09:42:51,723 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5663.09 Median:6380.43 stddev:1690.68 (26.5%) stddev-sans-first:1647.74 09:42:51 INFO - 2016-01-22 09:42:51,723 DEBUG : BROWSER_OUTPUT: Values: 351.4 363.8 379.9 381.8 382.2 6232.5 6297.4 6297.5 6303.3 6341.3 6204.5 6298.8 6333.3 6350.9 6359.7 4900.7 4916.4 4925.1 4928.8 4949.8 4939.9 4949.0 4953.4 4955.0 4955.5 4721.9 4839.2 4855.3 4877.1 4892.5 4847.1 4877.5 4884.9 4891.8 4892.5 4271.1 4284.9 4285.3 4292.7 4299.8 5962.7 6053.3 6054.4 6054.9 6061.5 5678.9 5679.9 5685.6 5691.6 5701.5 6678.6 6698.3 6703.3 6719.9 6723.8 4697.2 4748.4 4752.5 4753.6 4759.0 6853.4 6924.9 6973.2 6992.2 6997.6 4813.5 4820.5 4833.3 4835.3 4842.6 4903.8 4903.8 4915.3 4917.8 4929.6 5503.8 5626.4 5638.8 5647.5 5662.2 6793.2 6806.9 6828.7 6829.1 6847.3 1675.7 1734.2 1735.1 1735.7 1738.7 1154.6 1166.5 1171.7 1182.5 1182.7 6373.2 6417.1 6462.2 6491.3 6493.5 6872.4 6922.8 6963.1 6963.2 6968.2 6387.6 6408.1 6429.5 6461.6 6491.0 3765.4 3781.5 3783.7 3785.2 3785.3 7168.7 7201.2 7206.0 7212.7 7225.3 6938.6 7077.1 7095.1 7105.9 7131.4 7092.1 7094.0 7107.5 7109.5 7206.5 6927.0 6962.7 6965.7 6969.9 6971.8 6679.3 6799.3 6833.5 6844.8 6853.0 7140.6 7152.9 7156.1 7182.2 7186.4 4778.6 4833.6 4841.9 4848.6 4853.0 6820.2 6902.3 6934.8 6954.5 7037.0 6874.2 6881.2 6909.8 6917.2 6926.6 6838.0 6873.6 6877.2 6882.6 6884.3 6656.3 6761.4 6803.8 6806.8 6818.6 6889.1 6903.1 6914.3 6916.1 6919.4 6652.2 6696.9 6697.4 6702.4 6704.5 09:42:51 INFO - 2016-01-22 09:42:51,723 DEBUG : BROWSER_OUTPUT: 09:42:51 INFO - 2016-01-22 09:42:51,724 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14118.93 Median:48540.39 stddev:16451.76 (33.9%) stddev-sans-first:16467.83 09:42:51 INFO - 2016-01-22 09:42:51,724 DEBUG : BROWSER_OUTPUT: Values: 869.7 896.1 919.0 921.1 944.0 12293.7 12634.4 12660.2 14364.6 14394.4 12837.7 13059.3 13070.2 13089.1 13116.7 910.3 914.7 915.8 920.3 935.9 926.6 931.1 932.0 936.0 937.0 948.9 956.4 958.0 958.8 962.6 948.3 949.7 950.5 953.2 959.5 707.5 707.7 708.4 710.3 716.7 13152.2 13198.8 13307.4 13339.7 13428.4 11883.5 12161.4 12224.8 12286.9 12885.7 9205.6 9340.3 9379.0 9386.7 9454.9 3572.2 3638.5 3662.3 3683.7 3740.2 48332.0 48467.5 48515.5 48532.5 48548.3 9396.0 9789.3 9796.3 9845.0 9935.5 16060.8 16183.9 16228.5 16274.7 16291.0 7047.0 7336.1 7695.0 7884.1 7914.3 4577.3 4578.9 4618.9 4660.7 4686.6 3234.4 3257.2 3279.6 3280.2 3283.6 568.3 615.9 617.2 619.1 624.1 668.1 669.2 681.3 690.6 709.8 8469.6 9287.3 9528.7 9535.6 9623.0 585.9 672.2 688.0 712.4 736.7 3828.6 3841.0 3865.7 3901.1 3978.2 56418.0 57498.4 57767.0 58202.0 58935.1 52355.0 52884.9 52950.7 53910.2 53911.7 47812.3 48056.5 48141.8 49271.8 49277.8 8981.4 9020.9 9065.7 9145.4 9310.0 37309.6 37526.4 37678.6 37869.6 38161.2 46944.0 47272.5 47398.3 47813.8 48141.0 10976.7 11372.8 11607.5 11646.8 11754.2 12107.7 12236.3 12240.3 12399.0 12492.8 11023.7 11302.9 11710.7 11710.9 11997.9 11040.2 11264.8 11490.0 11612.7 11962.3 11285.5 11810.2 12245.5 12324.5 12790.0 9676.6 10077.9 10692.1 10830.2 11024.7 9602.2 9674.2 9893.1 9943.9 9947.8 09:42:51 INFO - 2016-01-22 09:42:51,724 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:42:51 INFO - 2016-01-22 09:42:51,724 DEBUG : BROWSER_OUTPUT: 09:42:52 INFO - 2016-01-22 09:42:52,337 INFO : Browser exited with error code: 0 09:42:52 INFO - 2016-01-22 09:42:52,358 INFO : Completed test dromaeo_css (00:18:28) 09:42:52 INFO - 2016-01-22 09:42:52,359 INFO : Starting test kraken 09:42:52 INFO - 2016-01-22 09:42:52,359 DEBUG : operating with platform_type : linux_ 09:42:52 INFO - 2016-01-22 09:42:52,359 INFO : Initialising browser for kraken test... 09:42:52 INFO - 2016-01-22 09:42:52,365 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVye_oi/profile http://localhost:40743/getInfo.html 09:42:56 INFO - 2016-01-22 09:42:56,405 DEBUG : BROWSER_OUTPUT: 09:42:56 INFO - 2016-01-22 09:42:56,405 DEBUG : BROWSER_OUTPUT: (process:24249): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:42:57 INFO - 2016-01-22 09:42:57,317 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:42:57 INFO - 2016-01-22 09:42:57,317 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:42:57 INFO - 2016-01-22 09:42:57,317 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:42:57 INFO - 2016-01-22 09:42:57,318 DEBUG : BROWSER_OUTPUT: __metrics 09:42:58 INFO - 2016-01-22 09:42:58,309 INFO : Browser initialized. 09:42:58 INFO - 2016-01-22 09:42:58,310 INFO : Running cycle 1/1 for kraken test... 09:42:58 INFO - 2016-01-22 09:42:58,310 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVye_oi/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:42:59 INFO - 2016-01-22 09:42:59,583 DEBUG : BROWSER_OUTPUT: 09:42:59 INFO - 2016-01-22 09:42:59,583 DEBUG : BROWSER_OUTPUT: (process:24363): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:43:10 INFO - 2016-01-22 09:43:10,082 DEBUG : BROWSER_OUTPUT: RSS: Main: 137113600 09:43:10 INFO - 2016-01-22 09:43:10,082 DEBUG : BROWSER_OUTPUT: 09:43:12 INFO - 2016-01-22 09:43:12,538 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40743/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40743/tests/kraken/driver.html?testName=audio-beat-detection) 09:43:13 INFO - 2016-01-22 09:43:13,132 DEBUG : BROWSER_OUTPUT: RSS: Main: 138326016 09:43:13 INFO - 2016-01-22 09:43:13,132 DEBUG : BROWSER_OUTPUT: 09:43:15 INFO - 2016-01-22 09:43:15,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40743/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40743/tests/kraken/driver.html?testName=audio-dft) 09:43:16 INFO - 2016-01-22 09:43:16,365 DEBUG : BROWSER_OUTPUT: RSS: Main: 138702848 09:43:16 INFO - 2016-01-22 09:43:16,365 DEBUG : BROWSER_OUTPUT: 09:43:19 INFO - 2016-01-22 09:43:19,184 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40743/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40743/tests/kraken/driver.html?testName=audio-fft) 09:43:19 INFO - 2016-01-22 09:43:19,768 DEBUG : BROWSER_OUTPUT: RSS: Main: 138678272 09:43:19 INFO - 2016-01-22 09:43:19,768 DEBUG : BROWSER_OUTPUT: 09:43:21 INFO - 2016-01-22 09:43:21,786 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40743/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40743/tests/kraken/driver.html?testName=audio-oscillator) 09:43:22 INFO - 2016-01-22 09:43:22,372 DEBUG : BROWSER_OUTPUT: RSS: Main: 138727424 09:43:22 INFO - 2016-01-22 09:43:22,372 DEBUG : BROWSER_OUTPUT: 09:43:24 INFO - 2016-01-22 09:43:24,566 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40743/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40743/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:43:25 INFO - 2016-01-22 09:43:25,153 DEBUG : BROWSER_OUTPUT: RSS: Main: 139792384 09:43:25 INFO - 2016-01-22 09:43:25,154 DEBUG : BROWSER_OUTPUT: 09:43:28 INFO - 2016-01-22 09:43:28,098 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40743/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40743/tests/kraken/driver.html?testName=imaging-darkroom) 09:43:28 INFO - 2016-01-22 09:43:28,685 DEBUG : BROWSER_OUTPUT: RSS: Main: 140296192 09:43:28 INFO - 2016-01-22 09:43:28,685 DEBUG : BROWSER_OUTPUT: 09:43:32 INFO - 2016-01-22 09:43:32,047 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40743/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40743/tests/kraken/driver.html?testName=imaging-desaturate) 09:43:32 INFO - 2016-01-22 09:43:32,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 140455936 09:43:32 INFO - 2016-01-22 09:43:32,629 DEBUG : BROWSER_OUTPUT: 09:43:35 INFO - 2016-01-22 09:43:35,419 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40743/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40743/tests/kraken/driver.html?testName=json-parse-financial) 09:43:36 INFO - 2016-01-22 09:43:36,005 DEBUG : BROWSER_OUTPUT: RSS: Main: 138878976 09:43:36 INFO - 2016-01-22 09:43:36,005 DEBUG : BROWSER_OUTPUT: 09:43:37 INFO - 2016-01-22 09:43:37,606 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40743/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40743/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:43:38 INFO - 2016-01-22 09:43:38,187 DEBUG : BROWSER_OUTPUT: RSS: Main: 139214848 09:43:38 INFO - 2016-01-22 09:43:38,187 DEBUG : BROWSER_OUTPUT: 09:43:39 INFO - 2016-01-22 09:43:39,942 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40743/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40743/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:43:40 INFO - 2016-01-22 09:43:40,548 DEBUG : BROWSER_OUTPUT: RSS: Main: 138788864 09:43:40 INFO - 2016-01-22 09:43:40,548 DEBUG : BROWSER_OUTPUT: 09:43:42 INFO - 2016-01-22 09:43:42,560 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40743/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40743/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:43:43 INFO - 2016-01-22 09:43:43,147 DEBUG : BROWSER_OUTPUT: RSS: Main: 139726848 09:43:43 INFO - 2016-01-22 09:43:43,147 DEBUG : BROWSER_OUTPUT: 09:43:45 INFO - 2016-01-22 09:43:45,547 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40743/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40743/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:43:46 INFO - 2016-01-22 09:43:46,141 DEBUG : BROWSER_OUTPUT: RSS: Main: 139284480 09:43:46 INFO - 2016-01-22 09:43:46,141 DEBUG : BROWSER_OUTPUT: 09:43:48 INFO - 2016-01-22 09:43:48,667 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40743/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40743/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:43:49 INFO - 2016-01-22 09:43:49,254 DEBUG : BROWSER_OUTPUT: RSS: Main: 139653120 09:43:49 INFO - 2016-01-22 09:43:49,255 DEBUG : BROWSER_OUTPUT: 09:43:50 INFO - 2016-01-22 09:43:50,888 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40743/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40743/tests/kraken/driver.html?testName=ai-astar) 09:43:51 INFO - 2016-01-22 09:43:51,140 DEBUG : BROWSER_OUTPUT: RSS: Main: 141189120 09:43:51 INFO - 2016-01-22 09:43:51,140 DEBUG : BROWSER_OUTPUT: 09:43:51 INFO - 2016-01-22 09:43:51,141 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:43:51 INFO - 2016-01-22 09:43:51,142 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:43:51 INFO - 2016-01-22 09:43:51,142 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:43:51 INFO - 2016-01-22 09:43:51,142 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:43:51 INFO - 2016-01-22 09:43:51,142 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;105;110;110;111;122;111;111;110;113 09:43:51 INFO - 2016-01-22 09:43:51,143 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;146;123;155;159;128;165;145;126;172;130 09:43:51 INFO - 2016-01-22 09:43:51,143 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;160;167;163;163;162;163;162;164;163 09:43:51 INFO - 2016-01-22 09:43:51,143 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;71;72;164;70;70;71;74;163;70 09:43:51 INFO - 2016-01-22 09:43:51,143 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;142;93;95;93;149;93;93;129 09:43:51 INFO - 2016-01-22 09:43:51,143 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;111;110;110;109;109;110;109 09:43:51 INFO - 2016-01-22 09:43:51,144 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;146;146;152;146;148;146;147;146 09:43:51 INFO - 2016-01-22 09:43:51,144 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;96;95;95;98;96;95;96 09:43:51 INFO - 2016-01-22 09:43:51,144 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;63;62;60;63;61;61;61;58;61 09:43:51 INFO - 2016-01-22 09:43:51,144 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;65;64;64;64;64;65;64;65;64 09:43:51 INFO - 2016-01-22 09:43:51,144 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;79;81;81;81;81;86;80;80;81;81 09:43:51 INFO - 2016-01-22 09:43:51,145 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;115;113;124;115;113;122;124;120;112;111 09:43:51 INFO - 2016-01-22 09:43:51,145 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;134;152;143;143;144;142;144;151;154;143 09:43:51 INFO - 2016-01-22 09:43:51,145 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;64;64;70;65;64;64;65;65;64 09:43:51 INFO - 2016-01-22 09:43:51,145 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:43:51 INFO - 2016-01-22 09:43:51,146 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:43:51 INFO - 2016-01-22 09:43:51,146 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,683 09:43:51 INFO - 2016-01-22 09:43:51,146 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:43:51 INFO - 2016-01-22 09:43:51,146 DEBUG : BROWSER_OUTPUT: __startTimestamp1453484631140__endTimestamp 09:43:51 INFO - 2016-01-22 09:43:51,146 DEBUG : BROWSER_OUTPUT: 09:43:51 INFO - 2016-01-22 09:43:51,150 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:43:51 INFO - 2016-01-22 09:43:51,150 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:43:51 INFO - 2016-01-22 09:43:51,150 DEBUG : BROWSER_OUTPUT: 09:43:51 INFO - 2016-01-22 09:43:51,151 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:4.27 (3.8%) stddev-sans-first:4.50 09:43:51 INFO - 2016-01-22 09:43:51,151 DEBUG : BROWSER_OUTPUT: Values: 110.0 105.0 110.0 110.0 111.0 122.0 111.0 111.0 110.0 113.0 09:43:51 INFO - 2016-01-22 09:43:51,151 DEBUG : BROWSER_OUTPUT: 09:43:51 INFO - 2016-01-22 09:43:51,151 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.90 Median:150.50 stddev:17.59 (11.7%) stddev-sans-first:18.65 09:43:51 INFO - 2016-01-22 09:43:51,152 DEBUG : BROWSER_OUTPUT: Values: 146.0 123.0 155.0 159.0 128.0 165.0 145.0 126.0 172.0 130.0 09:43:51 INFO - 2016-01-22 09:43:51,152 DEBUG : BROWSER_OUTPUT: 09:43:51 INFO - 2016-01-22 09:43:51,152 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:1.79 (1.1%) stddev-sans-first:1.87 09:43:51 INFO - 2016-01-22 09:43:51,153 DEBUG : BROWSER_OUTPUT: Values: 162.0 160.0 167.0 163.0 163.0 162.0 163.0 162.0 164.0 163.0 09:43:51 INFO - 2016-01-22 09:43:51,153 DEBUG : BROWSER_OUTPUT: 09:43:51 INFO - 2016-01-22 09:43:51,153 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.30 Median:71.00 stddev:38.66 (54.4%) stddev-sans-first:40.75 09:43:51 INFO - 2016-01-22 09:43:51,153 DEBUG : BROWSER_OUTPUT: Values: 78.0 71.0 72.0 164.0 70.0 70.0 71.0 74.0 163.0 70.0 09:43:51 INFO - 2016-01-22 09:43:51,153 DEBUG : BROWSER_OUTPUT: 09:43:51 INFO - 2016-01-22 09:43:51,153 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.20 Median:93.00 stddev:23.15 (24.9%) stddev-sans-first:23.89 09:43:51 INFO - 2016-01-22 09:43:51,153 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 142.0 93.0 95.0 93.0 149.0 93.0 93.0 129.0 09:43:51 INFO - 2016-01-22 09:43:51,154 DEBUG : BROWSER_OUTPUT: 09:43:51 INFO - 2016-01-22 09:43:51,154 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 09:43:51 INFO - 2016-01-22 09:43:51,154 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 111.0 110.0 110.0 109.0 109.0 110.0 109.0 09:43:51 INFO - 2016-01-22 09:43:51,154 DEBUG : BROWSER_OUTPUT: 09:43:51 INFO - 2016-01-22 09:43:51,154 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:1.87 (1.3%) stddev-sans-first:1.96 09:43:51 INFO - 2016-01-22 09:43:51,154 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 146.0 146.0 152.0 146.0 148.0 146.0 147.0 146.0 09:43:51 INFO - 2016-01-22 09:43:51,154 DEBUG : BROWSER_OUTPUT: 09:43:51 INFO - 2016-01-22 09:43:51,154 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.95 (1.0%) stddev-sans-first:0.97 09:43:51 INFO - 2016-01-22 09:43:51,155 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 96.0 95.0 95.0 98.0 96.0 95.0 96.0 09:43:51 INFO - 2016-01-22 09:43:51,155 DEBUG : BROWSER_OUTPUT: 09:43:51 INFO - 2016-01-22 09:43:51,155 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.00 Median:61.00 stddev:1.49 (2.4%) stddev-sans-first:1.54 09:43:51 INFO - 2016-01-22 09:43:51,155 DEBUG : BROWSER_OUTPUT: Values: 60.0 63.0 62.0 60.0 63.0 61.0 61.0 61.0 58.0 61.0 09:43:51 INFO - 2016-01-22 09:43:51,155 DEBUG : BROWSER_OUTPUT: 09:43:51 INFO - 2016-01-22 09:43:51,155 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 09:43:51 INFO - 2016-01-22 09:43:51,155 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 64.0 64.0 64.0 64.0 65.0 64.0 65.0 64.0 09:43:51 INFO - 2016-01-22 09:43:51,155 DEBUG : BROWSER_OUTPUT: 09:43:51 INFO - 2016-01-22 09:43:51,156 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:81.00 stddev:1.85 (2.3%) stddev-sans-first:1.80 09:43:51 INFO - 2016-01-22 09:43:51,156 DEBUG : BROWSER_OUTPUT: Values: 79.0 81.0 81.0 81.0 81.0 86.0 80.0 80.0 81.0 81.0 09:43:51 INFO - 2016-01-22 09:43:51,156 DEBUG : BROWSER_OUTPUT: 09:43:51 INFO - 2016-01-22 09:43:51,156 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:116.90 Median:117.50 stddev:5.09 (4.3%) stddev-sans-first:5.35 09:43:51 INFO - 2016-01-22 09:43:51,156 DEBUG : BROWSER_OUTPUT: Values: 115.0 113.0 124.0 115.0 113.0 122.0 124.0 120.0 112.0 111.0 09:43:51 INFO - 2016-01-22 09:43:51,156 DEBUG : BROWSER_OUTPUT: 09:43:51 INFO - 2016-01-22 09:43:51,156 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.00 Median:144.00 stddev:5.87 (4.1%) stddev-sans-first:4.68 09:43:51 INFO - 2016-01-22 09:43:51,157 DEBUG : BROWSER_OUTPUT: Values: 134.0 152.0 143.0 143.0 144.0 142.0 144.0 151.0 154.0 143.0 09:43:51 INFO - 2016-01-22 09:43:51,157 DEBUG : BROWSER_OUTPUT: 09:43:51 INFO - 2016-01-22 09:43:51,157 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.00 stddev:2.42 (3.7%) stddev-sans-first:1.94 09:43:51 INFO - 2016-01-22 09:43:51,157 DEBUG : BROWSER_OUTPUT: Values: 70.0 64.0 64.0 70.0 65.0 64.0 64.0 65.0 65.0 64.0 09:43:51 INFO - 2016-01-22 09:43:51,157 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:43:51 INFO - 2016-01-22 09:43:51,157 DEBUG : BROWSER_OUTPUT: 09:43:51 INFO - 2016-01-22 09:43:51,965 INFO : Browser exited with error code: 0 09:43:52 INFO - 2016-01-22 09:43:52,018 INFO : Completed test kraken (00:00:59) 09:43:52 INFO - 2016-01-22 09:43:52,018 INFO : Starting test v8_7 09:43:52 INFO - 2016-01-22 09:43:52,018 DEBUG : operating with platform_type : linux_ 09:43:52 INFO - 2016-01-22 09:43:52,019 INFO : Initialising browser for v8_7 test... 09:43:52 INFO - 2016-01-22 09:43:52,025 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeOJ2u0/profile http://localhost:40743/getInfo.html 09:43:55 INFO - 2016-01-22 09:43:55,988 DEBUG : BROWSER_OUTPUT: 09:43:55 INFO - 2016-01-22 09:43:55,988 DEBUG : BROWSER_OUTPUT: (process:24675): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:43:57 INFO - 2016-01-22 09:43:57,014 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:43:57 INFO - 2016-01-22 09:43:57,014 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:43:57 INFO - 2016-01-22 09:43:57,014 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:43:57 INFO - 2016-01-22 09:43:57,014 DEBUG : BROWSER_OUTPUT: __metrics 09:43:58 INFO - 2016-01-22 09:43:58,005 INFO : Browser initialized. 09:43:58 INFO - 2016-01-22 09:43:58,006 INFO : Running cycle 1/1 for v8_7 test... 09:43:58 INFO - 2016-01-22 09:43:58,006 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeOJ2u0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:43:59 INFO - 2016-01-22 09:43:59,238 DEBUG : BROWSER_OUTPUT: 09:43:59 INFO - 2016-01-22 09:43:59,238 DEBUG : BROWSER_OUTPUT: (process:24792): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:44:09 INFO - 2016-01-22 09:44:09,743 DEBUG : BROWSER_OUTPUT: RSS: Main: 136466432 09:44:09 INFO - 2016-01-22 09:44:09,743 DEBUG : BROWSER_OUTPUT: 09:44:31 INFO - 2016-01-22 09:44:31,138 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40743/tests/v8_7/run.html (next: http://localhost:40743/tests/v8_7/run.html) 09:44:31 INFO - 2016-01-22 09:44:31,396 DEBUG : BROWSER_OUTPUT: RSS: Main: 135294976 09:44:31 INFO - 2016-01-22 09:44:31,397 DEBUG : BROWSER_OUTPUT: 09:44:31 INFO - 2016-01-22 09:44:31,397 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:44:31 INFO - 2016-01-22 09:44:31,397 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:44:31 INFO - 2016-01-22 09:44:31,397 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:44:31 INFO - 2016-01-22 09:44:31,397 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:44:31 INFO - 2016-01-22 09:44:31,397 DEBUG : BROWSER_OUTPUT: |0;Richards;166.36167027116952 09:44:31 INFO - 2016-01-22 09:44:31,397 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;166.63889351774705 09:44:31 INFO - 2016-01-22 09:44:31,398 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.2516056967328 09:44:31 INFO - 2016-01-22 09:44:31,398 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5202.072538860104 09:44:31 INFO - 2016-01-22 09:44:31,398 DEBUG : BROWSER_OUTPUT: |4;RayTrace;907.4410163339383 09:44:31 INFO - 2016-01-22 09:44:31,398 DEBUG : BROWSER_OUTPUT: |5;Earley;547.945205479452 09:44:31 INFO - 2016-01-22 09:44:31,398 DEBUG : BROWSER_OUTPUT: |6;Boyer;10774.193548387097 09:44:31 INFO - 2016-01-22 09:44:31,398 DEBUG : BROWSER_OUTPUT: |7;RegExp;24238.095238095237 09:44:31 INFO - 2016-01-22 09:44:31,398 DEBUG : BROWSER_OUTPUT: |8;Splay;523.0125523012553 09:44:31 INFO - 2016-01-22 09:44:31,399 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 09:44:31 INFO - 2016-01-22 09:44:31,399 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:44:31 INFO - 2016-01-22 09:44:31,399 DEBUG : BROWSER_OUTPUT: __startTimestamp1453484671390__endTimestamp 09:44:31 INFO - 2016-01-22 09:44:31,399 DEBUG : BROWSER_OUTPUT: 09:44:31 INFO - 2016-01-22 09:44:31,399 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:44:31 INFO - 2016-01-22 09:44:31,399 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:44:31 INFO - 2016-01-22 09:44:31,399 DEBUG : BROWSER_OUTPUT: 09:44:31 INFO - 2016-01-22 09:44:31,400 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.36 Median:166.36 stddev:0.00 (0.0%) 09:44:31 INFO - 2016-01-22 09:44:31,400 DEBUG : BROWSER_OUTPUT: Values: 166.4 09:44:31 INFO - 2016-01-22 09:44:31,400 DEBUG : BROWSER_OUTPUT: 09:44:31 INFO - 2016-01-22 09:44:31,400 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:166.64 Median:166.64 stddev:0.00 (0.0%) 09:44:31 INFO - 2016-01-22 09:44:31,400 DEBUG : BROWSER_OUTPUT: Values: 166.6 09:44:31 INFO - 2016-01-22 09:44:31,400 DEBUG : BROWSER_OUTPUT: 09:44:31 INFO - 2016-01-22 09:44:31,400 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 09:44:31 INFO - 2016-01-22 09:44:31,401 DEBUG : BROWSER_OUTPUT: Values: 279.3 09:44:31 INFO - 2016-01-22 09:44:31,401 DEBUG : BROWSER_OUTPUT: 09:44:31 INFO - 2016-01-22 09:44:31,401 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 09:44:31 INFO - 2016-01-22 09:44:31,401 DEBUG : BROWSER_OUTPUT: Values: 5202.1 09:44:31 INFO - 2016-01-22 09:44:31,401 DEBUG : BROWSER_OUTPUT: 09:44:31 INFO - 2016-01-22 09:44:31,401 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:907.44 Median:907.44 stddev:0.00 (0.0%) 09:44:31 INFO - 2016-01-22 09:44:31,401 DEBUG : BROWSER_OUTPUT: Values: 907.4 09:44:31 INFO - 2016-01-22 09:44:31,402 DEBUG : BROWSER_OUTPUT: 09:44:31 INFO - 2016-01-22 09:44:31,402 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:547.95 Median:547.95 stddev:0.00 (0.0%) 09:44:31 INFO - 2016-01-22 09:44:31,402 DEBUG : BROWSER_OUTPUT: Values: 547.9 09:44:31 INFO - 2016-01-22 09:44:31,402 DEBUG : BROWSER_OUTPUT: 09:44:31 INFO - 2016-01-22 09:44:31,402 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10774.19 Median:10774.19 stddev:0.00 (0.0%) 09:44:31 INFO - 2016-01-22 09:44:31,402 DEBUG : BROWSER_OUTPUT: Values: 10774.2 09:44:31 INFO - 2016-01-22 09:44:31,403 DEBUG : BROWSER_OUTPUT: 09:44:31 INFO - 2016-01-22 09:44:31,403 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24238.10 Median:24238.10 stddev:0.00 (0.0%) 09:44:31 INFO - 2016-01-22 09:44:31,403 DEBUG : BROWSER_OUTPUT: Values: 24238.1 09:44:31 INFO - 2016-01-22 09:44:31,403 DEBUG : BROWSER_OUTPUT: 09:44:31 INFO - 2016-01-22 09:44:31,403 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:523.01 Median:523.01 stddev:0.00 (0.0%) 09:44:31 INFO - 2016-01-22 09:44:31,403 DEBUG : BROWSER_OUTPUT: Values: 523.0 09:44:31 INFO - 2016-01-22 09:44:31,403 DEBUG : BROWSER_OUTPUT: 09:44:31 INFO - 2016-01-22 09:44:31,404 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 09:44:31 INFO - 2016-01-22 09:44:31,404 DEBUG : BROWSER_OUTPUT: Values: 4840.6 09:44:31 INFO - 2016-01-22 09:44:31,404 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:44:31 INFO - 2016-01-22 09:44:31,404 DEBUG : BROWSER_OUTPUT: 09:44:32 INFO - 2016-01-22 09:44:32,281 INFO : Browser exited with error code: 0 09:44:32 INFO - 2016-01-22 09:44:32,293 INFO : Completed test v8_7 (00:00:40) 09:44:32 INFO - 2016-01-22 09:44:32,428 INFO : Completed test suite (00:20:08) 09:44:32 INFO - 2016-01-22 09:44:32,428 DEBUG : Working with test: dromaeo_css 09:44:32 INFO - 2016-01-22 09:44:32,428 DEBUG : Generating results file: dromaeo_css 09:44:32 INFO - 2016-01-22 09:44:32,430 DEBUG : Working with test: kraken 09:44:32 INFO - 2016-01-22 09:44:32,430 DEBUG : Generating results file: kraken 09:44:32 INFO - 2016-01-22 09:44:32,430 INFO : javascript benchmark 09:44:32 INFO - 2016-01-22 09:44:32,430 DEBUG : Working with test: v8_7 09:44:32 INFO - 2016-01-22 09:44:32,430 DEBUG : Generating results file: v8_7 09:44:32 INFO - 2016-01-22 09:44:32,431 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:44:32 INFO - 2016-01-22 09:44:32,485 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 09:44:32 INFO - 2016-01-22 09:44:32,485 DEBUG : process_Request line: dromaeo_css 7249.80 graph.html#tests=[[72,52,43]] 09:44:32 INFO - 2016-01-22 09:44:32,485 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:44:32 INFO - 2016-01-22 09:44:32,522 DEBUG : process_Request line: kraken 1503.00 graph.html#tests=[[232,52,43]] 09:44:32 INFO - 2016-01-22 09:44:32,522 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:44:32 INFO - 2016-01-22 09:44:32,555 DEBUG : process_Request line: v8_7 23293.23 graph.html#tests=[[230,52,43]] 09:44:32 INFO - 2016-01-22 09:44:32,556 INFO : javascript benchmark 09:44:32 INFO - 2016-01-22 09:44:32,560 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3273.214428537151, 3294.242324265417, 3319.3527262183875, 3322.8868329109746, 3325.268440942993, 5397.811076612319, 5420.403755586883, 5440.5919556033305, 5441.0, 5486.177073438987, 5452.073147564914, 5473.397926228112, 5473.972630136844, 5478.096114141162, 5483.259759932418, 4960.156773348531, 5007.599392048627, 5057.974710126444, 5080.872978175556, 5099.235114732783, 4839.128956787777, 5009.173486374744, 5021.422536408323, 5057.721825299607, 5166.5866730661455, 4978.303037574742, 5062.670926389791, 5072.949270507284, 5081.136206844827, 5168.664036837612, 5029.321041659402, 5032.119379108642, 5046.54581087702, 5048.1670524363435, 5071.239314102896, 4860.635452341053, 4914.16459201933, 4950.504949505057, 4961.627877909171, 4998.150314446553, 5298.788048478056, 5325.4940780625775, 5337.546308563777, 5359.464053594648, 5372.301600791911, 5897.705114744289, 5924.526037916957, 5930.911036334458, 5936.0, 5943.138244954501, 5677.943220567783, 5863.237779088734, 5874.295084589834, 5984.97007514964, 5985.6408615483215, 5539.584531160179, 5550.4449555044575, 5568.638038527523, 5573.9163912540935, 5581.748821303051, 6023.849403764941, 6034.125051867454, 6042.6978651067275, 6047.667378294148, 6051.606645568024, 5669.829905102853, 5755.827325180251, 5789.102689083199, 5789.971050144806, 5871.706414679249, 5876.706164691748, 5914.349421563625, 5923.08192230205, 5926.822195334147, 5959.0, 5617.241672374259, 5905.379935106752, 5907.527397808165, 5910.586258961917, 5919.526437885045, 5747.5114615257335, 5791.131330300489, 5828.94171058284, 5830.679312637761, 5849.151872978479, 4560.521145279764, 4566.862994110182, 4595.012072404449, 4595.149897268949, 4604.102200071021, 3970.940435893464, 4083.632473077437, 4111.48606424197, 4128.958710412858, 4140.585941405835, 5511.669299842022, 5569.192467092249, 5620.690862002547, 5639.069553523705, 5647.49172574462, 5866.765329386777, 5936.28764548257, 5941.584089113807, 5941.851453713605, 5949.702514874239, 5457.645253058538, 5565.387807341189, 5586.776528938797, 5605.971970140124, 5618.662880227118, 4964.280179373971, 5067.3412456381175, 5079.1365467870555, 5085.160948443539, 5096.643234973591, 6010.278766548042, 6037.0642550404755, 6048.637081775108, 6050.788222412194, 6080.878382432326, 5734.340550836707, 5775.249217601685, 5841.415858414124, 5920.052791553331, 5946.13781001761, 6083.117947897618, 6107.572469927062, 6116.480099191618, 6122.2959359674205, 6125.571210015256, 5780.421957804186, 5895.557833162616, 5902.2622172228475, 5904.675242861512, 5910.320313164041, 5566.332040155207, 5695.629784064023, 5696.088625819849, 5712.685802280915, 5939.628051451541, 5689.118186681071, 5819.883602328015, 5824.475797178275, 5850.970745146247, 5857.707114644336, 5776.162456443708, 5795.884082318415, 5805.129230615442, 5838.737256823369, 5846.707664616837, 5494.450554944474, 5601.327840659147, 5624.381318054929, 5735.8852822944145, 5749.396313387034, 5810.215620891295, 5838.503727183237, 5862.648241105377, 5875.3243377012195, 5891.558133140117, 5706.914396284142, 5709.885802284014, 5713.143028545752, 5720.513756330759, 5755.510781583613], "unit": "ms", "name": "dojo.html", "value": 5437.391389594973}, {"lowerIsBetter": false, "replicates": [583.2126629050782, 623.2987888625297, 624.581530374649, 631.1132858334042, 652.2759736692274, 27524.724752752467, 41016.794916025414, 41589.7920510397, 41629.58370416295, 41634.37548436776, 45599.0, 45615.31577026339, 46360.536394636045, 46398.536014639925, 46520.0, 9095.226905713022, 9286.58210380531, 9294.488803115826, 9307.162355388014, 9313.16181543661, 8939.284857211407, 9066.320025998044, 9085.636574537011, 9117.863232051524, 9131.543422828865, 9069.0, 9188.540572971358, 9195.632174713004, 9204.493752843591, 9212.447253164799, 8992.23565996891, 9134.721139040506, 9147.58835852385, 9179.49512776797, 9185.632574697003, 8997.955010224907, 9073.31950103745, 9104.453732776055, 9125.954370228174, 9159.313051521096, 42092.368614470804, 42225.1554968902, 42447.78776106131, 42515.36226956598, 42543.57456425458, 3490.511328413999, 3490.7207423406066, 3509.3858574749315, 3664.926701465956, 3744.2698673758628, 31959.520607190912, 32411.837940810146, 32780.344393112246, 33034.339313213604, 33769.83115084434, 3585.551806024247, 3622.094476380905, 3652.8904132876055, 3653.488511608377, 3670.0, 282737.0, 284502.0, 284765.0, 284915.0, 285213.0, 45165.322520162226, 45214.32178517325, 45221.0, 45223.0, 45235.095298094515, 42752.0, 43024.3546346805, 43027.0, 43144.35283470688, 43197.78401108037, 16508.25712842901, 16630.3347866084, 16681.582960425843, 16692.666146677, 16739.16304184786, 13595.728085438433, 13710.24593647359, 13777.448902044007, 13859.307034648227, 14310.141391516543, 15442.0, 15491.380344786083, 15499.302531386114, 15505.767413488808, 15628.0, 6163.19878415803, 6226.283977342573, 6260.874782504325, 6309.211348581427, 6313.589616674902, 970.4371464550544, 1048.5962904281753, 1083.0685610375072, 1116.6650004998469, 1120.176670147441, 28406.71593284082, 28918.710812892023, 29054.0, 29230.415391692473, 29404.0, 1110.4891749795186, 1118.1334465789078, 1146.696125526736, 1197.108154424959, 1218.06817784395, 14978.251087445584, 15279.61800954985, 15322.310496027705, 15625.921870390575, 15752.842471575137, 321515.0, 523115.0, 524780.0, 526742.0, 552308.0, 58875.11687324694, 59575.404245957856, 59728.70135649381, 59731.70134149301, 59980.0, 1472.8158980127484, 1479.2973337664523, 1501.4144483651385, 1501.909885406879, 1509.5018643847504, 30474.695253047186, 31082.844585776926, 31310.843445782626, 31576.368472629958, 31812.0, 53015.0, 53388.73305633447, 53602.0, 53727.46272537224, 53994.0, 309131.0, 310258.0, 310899.0, 311148.0, 311895.0, 44922.77538612286, 44972.77513612542, 45278.0, 45468.545314546434, 45700.0, 48457.0, 48526.0, 48903.75548122237, 48990.75504622454, 49676.25485617646, 38255.8523244292, 40822.59177408307, 41282.587174127875, 41424.37863431991, 41704.165916682105, 40636.75081538829, 41593.168136636494, 42171.0, 44868.0, 45776.31335529903, 38226.80886595549, 38419.42370864384, 38551.6144838548, 38659.42010869783, 38697.41953870638, 34412.65587344095, 34468.827655862566, 34571.13572160716, 38313.808430957666, 39892.0030342965, 27080.864595677685, 27162.0, 27197.592036119077, 27279.77241024119, 27293.590596140675], "unit": "ms", "name": "ext.html", "value": 19534.6052996132}, {"lowerIsBetter": false, "replicates": [386.79499865071506, 388.7181793199929, 391.3093390166357, 392.9017745563609, 393.55921368067766, 17169.914150429246, 17628.471145865613, 18939.905300473514, 19134.808651913478, 19150.808491915075, 12137.939310303458, 12185.512579496832, 12329.753404931897, 12339.62981110568, 12392.194507357015, 5079.644424890268, 5173.870653233662, 5174.948250517503, 5192.169252919533, 5196.0647083524955, 5151.227315902626, 5260.368755749316, 5395.325584301962, 5397.595180361469, 5405.783768649249, 5331.360236771573, 5371.4897084776885, 5384.811531596395, 5391.757370918299, 5549.94551035302, 5542.418046105161, 5564.693941833198, 5567.805126820583, 5573.777048918038, 5588.105903055512, 5062.164742817431, 5194.71429071401, 5384.7846086156505, 5415.620906536544, 5420.810271640474, 13213.73572528544, 13411.932940335237, 13433.32833358338, 20430.182792688276, 22021.0, 2146.12009076278, 2235.3517479930965, 2345.3667509772267, 2361.409647588103, 2391.712994440661, 14842.0, 14874.702505949928, 14981.400743970227, 15227.162506062163, 15236.390544378211, 1803.7925638551603, 1858.7862395824518, 1959.1379792891225, 1959.5590992026823, 1978.7130866024345, 73941.26058739398, 76316.23683763147, 76967.61516192439, 77355.0, 77794.0, 17212.39756608513, 17215.22531486086, 17290.394836180672, 17305.826941730673, 17363.82636173622, 26684.733152668614, 26983.0, 27122.18633441, 27229.319267018484, 27365.726342736318, 10352.948235258775, 10378.169746420268, 10379.948100259602, 10414.583416663248, 10444.373337599769, 8922.821543569093, 8939.106089391009, 8950.86573701395, 8963.820723585492, 9005.14451127142, 4369.344598310216, 8620.396572240008, 8634.829472088915, 8647.0, 8867.467951922905, 1981.2075169932143, 2046.1815273890265, 2051.0770153431017, 2060.7115003899467, 2077.418322869599, 476.91653960556766, 490.399260905388, 496.4662987288679, 976.1588150627305, 1056.3345092591771, 11047.72380690489, 11082.833757493645, 11156.442177891235, 11184.552617895193, 11231.21381503287, 481.86748644123145, 491.9458859525449, 493.2822742909059, 493.5582653525075, 493.56073094945526, 6007.128966299862, 6138.416850399205, 6196.938030619726, 6220.160278362363, 6279.623222606567, 623307.0, 634557.0, 636451.0, 645029.0, 658550.0, 84456.57771711102, 86514.0, 86741.13258867331, 86815.0, 87916.0, 510.4461659099844, 517.8498235511735, 517.9507946745053, 518.132128684452, 518.948105189478, 10590.576376944837, 10766.0, 10794.0, 10808.081313088476, 10809.459527023775, 33872.49191262084, 34605.13487162841, 34882.825585871906, 35297.0, 36419.63580364268, 45028.0, 45869.77065114653, 47921.281180783015, 47933.76033119812, 48190.27714584354, 9603.519824008912, 9883.950580247052, 9966.252531060345, 9983.950080249553, 10027.348222365523, 11508.36703981289, 11573.479193436147, 11863.110266730202, 14247.0, 15001.699966000837, 10579.206559507913, 10669.146468282364, 10704.839427408438, 10809.56761729522, 10888.45557722095, 10616.363018218932, 10749.623763168564, 10990.945045275043, 11217.046551043253, 11302.886971130183, 9930.602775889172, 10193.082622564005, 10955.014048735651, 11312.83030754523, 11347.37589432589, 15828.762568561711, 15856.207189640703, 15987.520374388787, 16106.516804495885, 16131.709463243147, 16473.505794826175, 16508.66982660364, 16569.088700121127, 16571.66856662836, 16678.416255431486], "unit": "ms", "name": "jquery.html", "value": 8832.865777666002}, {"lowerIsBetter": false, "replicates": [1582.1772678207326, 1592.5302035899408, 1799.7120460726287, 1870.8409785168262, 1896.1372575478158, 7851.725189618364, 7919.168487308836, 8078.0, 8083.757487275384, 8122.796930076751, 8240.464369815958, 8369.83260334793, 8388.412811103226, 8389.370797190204, 8419.452735572198, 2343.8828058597087, 2369.9098414729247, 2374.5963186258377, 2375.726791418983, 2379.95240095198, 2396.5686176488225, 2421.503591763693, 2439.3413778279855, 2453.129139155601, 2467.235157101304, 2339.3449834046496, 2367.621180611103, 2385.0, 2393.8922748476275, 2394.1979436888664, 2322.5703244899746, 2326.6161083421216, 2349.6005679034606, 2354.587947109266, 2357.422431504284, 2372.2764556810166, 2381.4403615150427, 2392.3899405651623, 2401.807855371566, 2405.2183040511904, 8098.554579498125, 8200.507969521788, 8215.424920255584, 8221.0, 8251.381146414044, 4849.612031037544, 4885.022995400934, 4889.608831293488, 4915.139850526144, 4938.135826230396, 3038.8176709397285, 3051.9847400763074, 3065.1877252528097, 3071.6314042314843, 3162.6204855417495, 982.3369225772575, 984.8965858584817, 1000.1049061090356, 1007.1489591295343, 1033.0702367868903, 11038.448077596087, 11173.553057877756, 11193.048590869786, 11206.719832004184, 11220.270682405699, 4095.1604920991126, 4141.855035073818, 4169.833206671699, 4233.491980962304, 4345.717528360647, 9256.907430925605, 9260.722178334661, 9276.814463710823, 9280.211182049601, 9307.627694892128, 4745.311929770164, 4748.8337908173735, 4767.594754445841, 4773.522647735199, 4778.1638213312535, 3926.3521518949055, 3981.8651684269844, 4387.978060109743, 4434.445694288214, 4499.955000449953, 3537.4163263061823, 3542.2738338640515, 3576.159602493412, 3652.5069115669044, 3680.1535646801385, 1080.6163811846682, 1084.3927400655657, 1088.8040152772578, 1091.067137597343, 1094.6606551968914, 1045.6601604478574, 1066.269605320358, 1090.0571006079683, 1090.6564432203832, 1100.471773548701, 7300.6349682515665, 7320.9633951830965, 7350.338469537767, 7350.889736653954, 7357.301056399633, 1295.514182181682, 1313.40240190713, 1317.0583033131356, 1318.5121505043196, 1319.346923272986, 5636.689982051026, 5713.857153571111, 5716.371199168088, 5721.485066344049, 5725.370209276976, 9565.04349565038, 9603.9039609603, 9754.0733630305, 9838.75403114928, 9950.1542368898, 9608.711738647851, 9738.0, 9749.756256093513, 9825.754356141153, 9849.852252216222, 7576.772696818994, 7584.62076896153, 7694.461387702919, 7767.184445633127, 7791.805204869924, 7654.311111999947, 7672.693092276247, 7682.0, 7696.15342312334, 7709.2290770922455, 8227.712030079158, 8289.253967142746, 8377.329813614775, 8433.87349189775, 8516.787080323042, 8377.45546539473, 8579.528125953133, 8603.05366409707, 8608.09614990442, 8727.738167854974, 6838.179418469816, 7003.894941575983, 7047.08387909589, 7231.8553628928175, 7338.889916651361, 7605.6577454013595, 7690.038745156856, 7707.922920770945, 7709.0, 7778.6888524460655, 6986.580805151707, 7140.143182818095, 7150.856982860209, 7237.782866514013, 7355.889661654973, 7111.53775004623, 7165.5700657958605, 7209.170945341353, 7216.314450127229, 7253.637318133967, 7039.507234493536, 7233.457490688114, 7233.493655444279, 7240.348368646636, 7258.673359698721, 6421.068945003042, 6440.388163124496, 6442.935570644234, 6451.2903580607035, 6454.225492940689, 6635.734570617121, 6658.700358483783, 6676.9666151668935, 6700.061991321121, 6723.294054124247], "unit": "ms", "name": "mootools.html", "value": 4612.7101818297715}, {"lowerIsBetter": false, "replicates": [351.37455329513466, 363.79082027834, 379.8765401244596, 381.7556763671251, 382.1992924822499, 6232.532560058003, 6297.433231009209, 6297.464715499183, 6303.3381494943005, 6341.302456729756, 6204.472619827309, 6298.834715577621, 6333.271673757519, 6350.872982540346, 6359.71381287842, 4900.681455705386, 4916.410030796301, 4925.138100832358, 4928.827491037814, 4949.8020079196785, 4939.937913348629, 4948.950510494903, 4953.430355509108, 4954.950450495485, 4955.504449555052, 4721.913959789234, 4839.225723884179, 4855.344528488644, 4877.073356062355, 4892.510748925115, 4847.103285892122, 4877.463479017305, 4884.926726099111, 4891.779869905863, 4892.461829198821, 4271.103068355649, 4284.9143017139795, 4285.314349704064, 4292.656587472995, 4299.828006879721, 5962.672053037081, 6053.303870054956, 6054.364291749391, 6054.909176362358, 6061.51507879373, 5678.886422271573, 5679.886402271973, 5685.602007859451, 5691.630044047124, 5701.486866182022, 6678.565893216925, 6698.296678848748, 6703.262641109474, 6719.899201511981, 6723.7982860513775, 4697.201475749097, 4748.38271024768, 4752.5247475252545, 4753.619710423158, 4758.953030333321, 6853.383195512428, 6924.896126558106, 6973.163220413532, 6992.1958974717545, 6997.615131167784, 4813.542713442217, 4820.517948205152, 4833.299171620095, 4835.250536166829, 4842.58837998767, 4903.754812259373, 4903.754812259373, 4915.26271059344, 4917.778699958439, 4929.630277729185, 5503.752331145108, 5626.35296940857, 5638.830835074954, 5647.548196144298, 5662.207290979266, 6793.184817821893, 6806.931930680729, 6828.692708828015, 6829.146356705412, 6847.281035491302, 1675.689997350494, 1734.1502663694698, 1735.106420193576, 1735.7483164941013, 1738.721804511272, 1154.6016624264614, 1166.4750862111914, 1171.7363593191635, 1182.5210789630214, 1182.7338848759132, 6373.235211774617, 6417.069524918954, 6462.159919210472, 6491.253505846794, 6493.545451818327, 6872.41584465326, 6922.826929326707, 6963.09479767627, 6963.1644202696, 6968.233494315621, 6387.616742995435, 6408.102865598727, 6429.517786166056, 6461.57999730016, 6491.0, 3765.4163604641326, 3781.4516895050065, 3783.697304215656, 3785.2240290740333, 3785.299719551892, 7168.713251469882, 7201.243869393743, 7205.963970180115, 7212.7114915403845, 7225.2774722528375, 6938.583684978817, 7077.115360579927, 7095.148582170069, 7105.857882842314, 7131.358177763922, 7092.148942126978, 7093.964530177419, 7107.466939979418, 7109.466789990772, 7206.495545311778, 6927.0, 6962.721491140298, 6965.651717414008, 6969.895451568332, 6971.79084627462, 6679.298673639198, 6799.3200679931615, 6833.521653484208, 6844.794656160323, 6853.0, 7140.607266600179, 7152.9284707152265, 7156.069710937753, 7182.17404998411, 7186.425085993003, 4778.593819525379, 4833.613310935047, 4841.903161936812, 4848.587870031087, 4852.975735121302, 6820.181578210448, 6902.275261097512, 6934.826629334307, 6954.478414119062, 7036.964815175891, 6874.209465911485, 6881.174259088942, 6909.7581584644295, 6917.204521480095, 6926.58440493572, 6838.0, 6873.5875847449315, 6877.209120951155, 6882.621455819978, 6884.311568843075, 6656.30108838565, 6761.425278851353, 6803.7618683345845, 6806.7957961261245, 6818.590884546943, 6889.138857642794, 6903.102596662402, 6914.308569143247, 6916.135483064617, 6919.411849992605, 6652.168478940132, 6696.866062678817, 6697.397234248941, 6702.430293425114, 6704.530682852349], "unit": "ms", "name": "prototype.html", "value": 5118.456148949264}, {"lowerIsBetter": false, "replicates": [869.6738722978882, 896.1173244354314, 919.0, 921.1157289002557, 943.9805010588562, 12293.69265768355, 12634.431450584723, 12660.24038557686, 14364.640883977905, 14394.352254148562, 12837.679058023554, 13059.281739504324, 13070.15044022138, 13089.149205301648, 13116.73766524669, 910.2717825739383, 914.743871715919, 915.7847905742145, 920.3005715656083, 935.9064093590621, 926.6154545863459, 931.1247427418239, 932.035343419561, 936.035883040466, 936.9531523423835, 948.8576713492962, 956.3592393096642, 958.018031517693, 958.8465845464727, 962.5524131278954, 948.2603569216022, 949.6723630347519, 950.4534892436842, 953.1707414549317, 959.4770849886828, 707.5400989356959, 707.7310621963621, 708.3872450330427, 710.2577806192542, 716.7419728897593, 13152.21086734799, 13198.802017969738, 13307.401166947511, 13339.733205335937, 13428.395722192525, 11883.465244064038, 12161.391930403533, 12224.755504889852, 12286.877131228752, 12885.67785805353, 9205.606542298983, 9340.34617576763, 9379.015203403613, 9386.671466498708, 9454.90545094547, 3572.1962558424407, 3638.5269914911155, 3662.3041622091982, 3683.6684698377007, 3740.1584643455276, 48332.0, 48467.51532484665, 48515.51484485145, 48532.514674853504, 48548.27177592339, 9396.0, 9789.265805064648, 9796.26528010402, 9844.950775246078, 9935.453550054817, 16060.75908861368, 16183.919080404523, 16228.51314460568, 16274.67450651004, 16291.0, 7047.048648432498, 7336.119665640157, 7695.0, 7884.132745398002, 7914.287714105643, 4577.313402989512, 4578.885527861764, 4618.861434156981, 4660.673752837337, 4686.554777296152, 3234.36929798687, 3257.218267615755, 3279.5736554247796, 3280.245543524955, 3283.622383425889, 568.3009897825698, 615.9045347971072, 617.2099712368176, 619.1146660275759, 624.1418050181001, 668.1147479589563, 669.18723898485, 681.2948598200838, 690.6339639990813, 709.8048036789821, 8469.576521173916, 9287.303452241109, 9528.714138575853, 9535.618575256913, 9623.0, 585.9472647461749, 672.2403683837331, 687.9552829066095, 712.4478529139958, 736.7347754808264, 3828.578856325802, 3840.9807950960067, 3865.690744740414, 3901.1027463682944, 3978.224246271949, 56418.0, 57498.41257143438, 57767.0, 58202.0, 58935.115973260436, 52355.0, 52884.94230115376, 52950.73524632352, 53910.191347129825, 53911.73044134833, 47812.28281575779, 48056.5194348059, 48141.75929120332, 49271.75364123228, 49277.75361123172, 8981.371304008657, 9020.86468702983, 9065.728028159167, 9145.3598248122, 9310.0224476429, 37309.6269037317, 37526.43710344292, 37678.62321376751, 37869.62130378661, 38161.23677526489, 46944.0, 47272.52727472681, 47398.28902566395, 47813.760931195124, 48141.0, 10976.670699879016, 11372.772544549229, 11607.535698572301, 11646.777088405595, 11754.177207595729, 12107.697307567381, 12236.327002014974, 12240.265584064984, 12399.0, 12492.750144997231, 11023.724406889893, 11302.943485282522, 11710.70723231926, 11710.946014858704, 11997.880021199677, 11040.227184097035, 11264.774704506028, 11490.0, 11612.709682258012, 11962.34207118582, 11285.492152852978, 11810.173287869766, 12245.510179592717, 12324.50701971911, 12790.0, 9676.564554595201, 10077.941816109496, 10692.14462842955, 10830.241883068109, 11024.724381890517, 9602.231821454126, 9674.177694896012, 9893.109620134222, 9943.850842237227, 9947.801043979225], "unit": "ms", "name": "yui.html", "value": 6554.316292204694}], "name": "dromaeo_css", "value": 7249.801002186099}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 105.0, 110.0, 110.0, 111.0, 122.0, 111.0, 111.0, 110.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [146.0, 123.0, 155.0, 159.0, 128.0, 165.0, 145.0, 126.0, 172.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.9}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 167.0, 163.0, 163.0, 162.0, 163.0, 162.0, 164.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 162.9}, {"lowerIsBetter": true, "replicates": [78.0, 71.0, 72.0, 164.0, 70.0, 70.0, 71.0, 74.0, 163.0, 70.0], "unit": "ms", "name": "audio-fft", "value": 90.3}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 142.0, 93.0, 95.0, 93.0, 149.0, 93.0, 93.0, 129.0], "unit": "ms", "name": "audio-oscillator", "value": 107.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 111.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 146.0, 146.0, 152.0, 146.0, 148.0, 146.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 98.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [60.0, 63.0, 62.0, 60.0, 63.0, 61.0, 61.0, 61.0, 58.0, 61.0], "unit": "ms", "name": "json-parse-financial", "value": 61.0}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.3}, {"lowerIsBetter": true, "replicates": [79.0, 81.0, 81.0, 81.0, 81.0, 86.0, 80.0, 80.0, 81.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 81.1}, {"lowerIsBetter": true, "replicates": [115.0, 113.0, 124.0, 115.0, 113.0, 122.0, 124.0, 120.0, 112.0, 111.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 116.9}, {"lowerIsBetter": true, "replicates": [134.0, 152.0, 143.0, 143.0, 144.0, 142.0, 144.0, 151.0, 154.0, 143.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.0}, {"lowerIsBetter": true, "replicates": [70.0, 64.0, 64.0, 70.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.5}], "name": "kraken", "value": 1503.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.36167027116952], "unit": "score", "name": "Richards", "value": 212.20032200000009}, {"lowerIsBetter": false, "replicates": [166.63889351774705], "unit": "score", "name": "DeltaBlue", "value": 396.77411799999993}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [907.4410163339383], "unit": "score", "name": "RayTrace", "value": 815.4678780000004}, {"lowerIsBetter": false, "replicates": [547.945205479452], "unit": "score", "name": "Earley", "value": 1216.2949749999998}, {"lowerIsBetter": false, "replicates": [10774.193548387097], "unit": "score", "name": "Boyer", "value": 61.857344311377226}, {"lowerIsBetter": false, "replicates": [24238.095238095237], "unit": "score", "name": "RegExp", "value": 37.5848428290766}, {"lowerIsBetter": false, "replicates": [523.0125523012553], "unit": "score", "name": "Splay", "value": 155.810792}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 23293.230224840103}]} 09:44:32 INFO - RETURN: dromaeo_css: 7249.80 09:44:32 INFO - RETURN: kraken: 1503.00 09:44:32 INFO - RETURN: v8_7: 23293.23 09:44:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23293.23"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1503.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7249.80"}}} 09:44:32 INFO - Return code: 0 09:44:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:44:32 INFO - # TBPL SUCCESS # 09:44:32 INFO - Running post-action listener: _resource_record_post_action 09:44:32 INFO - Running post-run listener: _resource_record_post_run 09:44:33 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 0; Write bytes: 512626688; Read time: 0; Write time: 525208 09:44:33 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 237535232; Read time: 0; Write time: 314556 09:44:33 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 0; Write bytes: 275091456; Read time: 0; Write time: 210652 09:44:33 INFO - Running post-run listener: _upload_blobber_files 09:44:33 INFO - Blob upload gear active. 09:44:33 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:44:33 INFO - Copying logs to upload dir... 09:44:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.542144 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-01-22 09:44:33.311784) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-22 09:44:33.315133) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1453483374.787094-52715717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/ZDxVibeIQAelFrXkPXgRVQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009882 build_url: 'https://queue.taskcluster.net/v1/task/ZDxVibeIQAelFrXkPXgRVQ/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:44:33.367144) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:44:33.367459) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1453483374.787094-52715717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004550 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:44:33.420395) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 09:44:33.421131) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 09:44:33.421772) ========= ========= Total master_lag: 0.31 =========