builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1456236016.89 results: success (0) buildid: 20160223030304 builduid: d32a9238d9644683b7ce63ab094970b9 revision: 789a12291942763bc1e3a89f97e0b82dc1c9d00b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 06:00:16.893487) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 06:00:16.893869) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 06:00:16.894431) ========= 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=8887e36bb8e381bfd44124ac000001a8-1456234233.685923-1855228529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006737 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 06:00:16.928526) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 06:00:16.928803) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 06:00:16.987125) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 06:00:16.987393) ========= 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=8887e36bb8e381bfd44124ac000001a8-1456234233.685923-1855228529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004748 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 06:00:17.051526) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 06:00:17.051787) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 06:00:17.052132) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 06:00:17.052417) ========= 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=8887e36bb8e381bfd44124ac000001a8-1456234233.685923-1855228529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-23 06:00:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.2M=0s 2016-02-23 06:00:17 (36.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174364 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 06:00:17.240161) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 06:00:17.240475) ========= 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=8887e36bb8e381bfd44124ac000001a8-1456234233.685923-1855228529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017841 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 06:00:17.295917) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-23 06:00:17.296391) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 789a12291942763bc1e3a89f97e0b82dc1c9d00b --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 789a12291942763bc1e3a89f97e0b82dc1c9d00b --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=8887e36bb8e381bfd44124ac000001a8-1456234233.685923-1855228529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-23 06:00:17,776 truncating revision to first 12 chars 2016-02-23 06:00:17,776 Setting DEBUG logging. 2016-02-23 06:00:17,776 attempt 1/10 2016-02-23 06:00:17,776 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/789a12291942?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-23 06:00:19,065 unpacking tar archive at: mozilla-central-789a12291942/testing/mozharness/ program finished with exit code 0 elapsedTime=1.637570 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-23 06:00:18.948621) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 06:00:18.948986) ========= echo 789a12291942763bc1e3a89f97e0b82dc1c9d00b in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'789a12291942763bc1e3a89f97e0b82dc1c9d00b'] 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=8887e36bb8e381bfd44124ac000001a8-1456234233.685923-1855228529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 789a12291942763bc1e3a89f97e0b82dc1c9d00b program finished with exit code 0 elapsedTime=0.004415 script_repo_revision: '789a12291942763bc1e3a89f97e0b82dc1c9d00b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 06:00:18.999158) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 06:00:18.999474) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 06:00:19.009323) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-02-23 06:00:19.009609) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=8887e36bb8e381bfd44124ac000001a8-1456234233.685923-1855228529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:00:19 INFO - MultiFileLogger online at 20160223 06:00:19 in /builds/slave/test-pgo 06:00:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:00:19 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:00:19 INFO - {'append_to_log': False, 06:00:19 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:00:19 INFO - 'blob_upload_branch': 'Firefox', 06:00:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:00:19 INFO - 'branch': 'Firefox', 06:00:19 INFO - 'buildbot_json_path': 'buildprops.json', 06:00:19 INFO - 'config_files': ('talos/linux_config.py',), 06:00:19 INFO - 'default_actions': ('clobber', 06:00:19 INFO - 'read-buildbot-config', 06:00:19 INFO - 'download-and-extract', 06:00:19 INFO - 'populate-webroot', 06:00:19 INFO - 'create-virtualenv', 06:00:19 INFO - 'install', 06:00:19 INFO - 'run-tests'), 06:00:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:00:19 INFO - 'download_minidump_stackwalk': True, 06:00:19 INFO - 'download_symbols': 'ondemand', 06:00:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:00:19 INFO - 'tooltool.py': '/tools/tooltool.py', 06:00:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:00:19 INFO - '/tools/misc-python/virtualenv.py')}, 06:00:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:00:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:00:19 INFO - 'installer_path': 'installer.exe', 06:00:19 INFO - 'log_level': 'info', 06:00:19 INFO - 'log_name': 'talos', 06:00:19 INFO - 'log_to_console': True, 06:00:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:00:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:00:19 INFO - 'opt_config_files': (), 06:00:19 INFO - 'pip_index': False, 06:00:19 INFO - 'sps_profile': False, 06:00:19 INFO - 'sps_profile_interval': 0, 06:00:19 INFO - 'suite': 'dromaeojs', 06:00:19 INFO - 'system_bits': '32', 06:00:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:00:19 INFO - 'title': 'talos-linux64-ix-001', 06:00:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:00:19 INFO - 'use_talos_json': True, 06:00:19 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:00:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:00:19 INFO - 'work_dir': 'build'} 06:00:19 INFO - ##### 06:00:19 INFO - ##### Running clobber step. 06:00:19 INFO - ##### 06:00:19 INFO - Running pre-action listener: _resource_record_pre_action 06:00:19 INFO - Running main action method: clobber 06:00:19 INFO - rmtree: /builds/slave/test-pgo/build 06:00:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:00:20 INFO - Running post-action listener: _resource_record_post_action 06:00:20 INFO - ##### 06:00:20 INFO - ##### Running read-buildbot-config step. 06:00:20 INFO - ##### 06:00:20 INFO - Running pre-action listener: _resource_record_pre_action 06:00:20 INFO - Running main action method: read_buildbot_config 06:00:20 INFO - Using buildbot properties: 06:00:20 INFO - { 06:00:20 INFO - "project": "", 06:00:20 INFO - "product": "firefox", 06:00:20 INFO - "script_repo_revision": "production", 06:00:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:00:20 INFO - "repository": "", 06:00:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:00:20 INFO - "buildid": "20160223030304", 06:00:20 INFO - "stage_platform": "linux64-pgo", 06:00:20 INFO - "basedir": "/builds/slave/test-pgo", 06:00:20 INFO - "nightly_build": "True", 06:00:20 INFO - "buildnumber": 203, 06:00:20 INFO - "slavename": "talos-linux64-ix-001", 06:00:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:00:20 INFO - "platform": "ubuntu64_hw", 06:00:20 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:00:20 INFO - "branch": "mozilla-central", 06:00:20 INFO - "repo_path": "mozilla-central", 06:00:20 INFO - "revision": "789a12291942763bc1e3a89f97e0b82dc1c9d00b", 06:00:20 INFO - "pgo_build": "True", 06:00:20 INFO - "builduid": "d32a9238d9644683b7ce63ab094970b9", 06:00:20 INFO - "slavebuilddir": "test" 06:00:20 INFO - } 06:00:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 06:00:20 INFO - Running post-action listener: _resource_record_post_action 06:00:20 INFO - ##### 06:00:20 INFO - ##### Running download-and-extract step. 06:00:20 INFO - ##### 06:00:20 INFO - Running pre-action listener: _resource_record_pre_action 06:00:20 INFO - Running main action method: download_and_extract 06:00:20 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:20 INFO - https://queue.taskcluster.net/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:00:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/test_packages.json 06:00:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/test_packages.json 06:00:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:00:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:00:21 INFO - Downloaded 1448 bytes. 06:00:21 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:00:21 INFO - Using the following test package requirements: 06:00:21 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 06:00:21 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:00:21 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:00:21 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:21 INFO - u'jsshell-linux-x86_64.zip'], 06:00:21 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:00:21 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 06:00:21 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:00:21 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:00:21 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:00:21 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 06:00:21 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:00:21 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:00:21 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')]} 06:00:21 INFO - https://queue.taskcluster.net/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:00:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:00:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:00:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:00:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:00:22 INFO - Downloaded 23365443 bytes. 06:00:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:00:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 06:00:24 INFO - Return code: 0 06:00:24 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:24 INFO - https://queue.taskcluster.net/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:00:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:00:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:00:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:00:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:00:35 INFO - Downloaded 23365443 bytes. 06:00:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:00:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 06:00:36 INFO - Return code: 0 06:00: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')]} 06:00:36 INFO - https://queue.taskcluster.net/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:00:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 06:00:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 06:00:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 06:00:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:00:38 INFO - Downloaded 10707015 bytes. 06:00:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:00:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 06:00:38 INFO - Return code: 0 06:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:38 INFO - https://queue.taskcluster.net/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:00:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:00:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:00:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:00:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:00:39 INFO - Downloaded 56560470 bytes. 06:00:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:00:39 INFO - mkdir: /builds/slave/test-pgo/properties 06:00:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:00:39 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:00:39 INFO - Contents: 06:00:39 INFO - build_url:https://queue.taskcluster.net/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:00:40 INFO - Running post-action listener: _resource_record_post_action 06:00:40 INFO - Running post-action listener: set_extra_try_arguments 06:00:40 INFO - ##### 06:00:40 INFO - ##### Running populate-webroot step. 06:00:40 INFO - ##### 06:00:40 INFO - Running pre-action listener: _resource_record_pre_action 06:00:40 INFO - Running main action method: populate_webroot 06:00:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:00:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:00:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:00:40 INFO - '--tppagecycles', 06:00:40 INFO - '7'], 06:00:40 INFO - 'tests': ['tsvgm']}}, 06:00:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:00:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:00:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:00:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:00:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:00:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:00:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:00:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:40 INFO - 'talos_options': ['--e10s'], 06:00:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:00:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:40 INFO - 'tests': ['damp', 'tps']}, 06:00:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:40 INFO - 'talos_options': ['--e10s'], 06:00:40 INFO - 'tests': ['damp', 'tps']}, 06:00:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:00:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:00:40 INFO - 'other': {'tests': ['a11yr', 06:00:40 INFO - 'ts_paint', 06:00:40 INFO - 'tpaint', 06:00:40 INFO - 'sessionrestore', 06:00:40 INFO - 'sessionrestore_no_auto_restore']}, 06:00:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:00:40 INFO - 'tests': ['a11yr', 06:00:40 INFO - 'ts_paint', 06:00:40 INFO - 'tpaint', 06:00:40 INFO - 'sessionrestore', 06:00:40 INFO - 'sessionrestore_no_auto_restore']}, 06:00:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:00:40 INFO - 'tests': ['a11yr', 06:00:40 INFO - 'ts_paint', 06:00:40 INFO - 'tpaint', 06:00:40 INFO - 'sessionrestore', 06:00:40 INFO - 'sessionrestore_no_auto_restore']}, 06:00:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:00:40 INFO - 'tests': ['a11yr', 06:00:40 INFO - 'ts_paint', 06:00:40 INFO - 'tpaint', 06:00:40 INFO - 'sessionrestore', 06:00:40 INFO - 'sessionrestore_no_auto_restore']}, 06:00:40 INFO - 'other_l64': {'tests': ['a11yr', 06:00:40 INFO - 'ts_paint', 06:00:40 INFO - 'tpaint', 06:00:40 INFO - 'sessionrestore', 06:00:40 INFO - 'sessionrestore_no_auto_restore']}, 06:00:40 INFO - 'other_nol64': {'tests': ['a11yr', 06:00:40 INFO - 'ts_paint', 06:00:40 INFO - 'tpaint', 06:00:40 INFO - 'sessionrestore', 06:00:40 INFO - 'sessionrestore_no_auto_restore']}, 06:00:40 INFO - 'svgr': {'tests': ['tsvgx', 06:00:40 INFO - 'tsvgr_opacity', 06:00:40 INFO - 'tart', 06:00:40 INFO - 'tscrollx', 06:00:40 INFO - 'cart']}, 06:00:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:00:40 INFO - 'tests': ['tsvgx', 06:00:40 INFO - 'tsvgr_opacity', 06:00:40 INFO - 'tart', 06:00:40 INFO - 'tscrollx', 06:00:40 INFO - 'cart']}, 06:00:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:40 INFO - 'tests': ['tp5o']}, 06:00:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:40 INFO - 'talos_options': ['--e10s'], 06:00:40 INFO - 'tests': ['tp5o']}, 06:00:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:40 INFO - 'talos_options': ['--xperf_path', 06:00:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:00:40 INFO - 'tests': ['tp5n']}, 06:00:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:40 INFO - 'talos_options': ['--e10s', 06:00:40 INFO - '--xperf_path', 06:00:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:00:40 INFO - 'tests': ['tp5n']}}, 06:00:40 INFO - 'talos.zip': {'path': '', 06:00:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:00:40 INFO - Running post-action listener: _resource_record_post_action 06:00:40 INFO - ##### 06:00:40 INFO - ##### Running create-virtualenv step. 06:00:40 INFO - ##### 06:00:40 INFO - Running pre-action listener: _resource_record_pre_action 06:00:40 INFO - Running main action method: create_virtualenv 06:00:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:00:40 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 06:00:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:00:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:00:40 INFO - Using real prefix '/usr' 06:00:40 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:00:40 INFO - Installing distribute.............................................................................................................................................................................................done. 06:00:42 INFO - Installing pip.................done. 06:00:42 INFO - Return code: 0 06:00:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:42 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 0x7f70a4748f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afd670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8c8c0>, '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 0x2b8d7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8dc50>, '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': '8887e36bb8e381bfd44124ac000001a8-1456234233.685923-1855228529', '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 06:00:42 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 06:00:42 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 06:00:42 INFO - Using env: {'DISPLAY': ':0', 06:00:42 INFO - 'HOME': '/home/cltbld', 06:00:42 INFO - 'LANG': 'en_US.UTF-8', 06:00:42 INFO - 'LANGUAGE': 'en_US:en', 06:00:42 INFO - 'LOGNAME': 'cltbld', 06:00:42 INFO - 'MAIL': '/var/mail/cltbld', 06:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:42 INFO - 'MOZ_NO_REMOTE': '1', 06:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:42 INFO - 'NO_EM_RESTART': '1', 06:00:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:00:42 INFO - 'PWD': '/builds/slave/test-pgo', 06:00:42 INFO - 'SHELL': '/bin/bash', 06:00:42 INFO - 'SHLVL': '1', 06:00:42 INFO - 'TERM': 'linux', 06:00:42 INFO - 'TMOUT': '86400', 06:00:42 INFO - 'USER': 'cltbld', 06:00:42 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1456234233.685923-1855228529', 06:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:42 INFO - '_': '/tools/buildbot/bin/python'} 06:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:43 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 06:00:43 INFO - Cleaning up... 06:00:43 INFO - Return code: 0 06:00:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:43 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 0x7f70a4748f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afd670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8c8c0>, '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 0x2b8d7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8dc50>, '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': '8887e36bb8e381bfd44124ac000001a8-1456234233.685923-1855228529', '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 06:00:43 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 06:00:43 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 06:00:43 INFO - Using env: {'DISPLAY': ':0', 06:00:43 INFO - 'HOME': '/home/cltbld', 06:00:43 INFO - 'LANG': 'en_US.UTF-8', 06:00:43 INFO - 'LANGUAGE': 'en_US:en', 06:00:43 INFO - 'LOGNAME': 'cltbld', 06:00:43 INFO - 'MAIL': '/var/mail/cltbld', 06:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:43 INFO - 'MOZ_NO_REMOTE': '1', 06:00:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:43 INFO - 'NO_EM_RESTART': '1', 06:00:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:00:43 INFO - 'PWD': '/builds/slave/test-pgo', 06:00:43 INFO - 'SHELL': '/bin/bash', 06:00:43 INFO - 'SHLVL': '1', 06:00:43 INFO - 'TERM': 'linux', 06:00:43 INFO - 'TMOUT': '86400', 06:00:43 INFO - 'USER': 'cltbld', 06:00:43 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1456234233.685923-1855228529', 06:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:43 INFO - '_': '/tools/buildbot/bin/python'} 06:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:43 INFO - Downloading/unpacking psutil>=0.7.1 06:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:00:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:00:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:00:45 INFO - Installing collected packages: psutil 06:00:45 INFO - Running setup.py install for psutil 06:00:45 INFO - building 'psutil._psutil_linux' extension 06:00:45 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 06:00:45 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 06:00:45 INFO - building 'psutil._psutil_posix' extension 06:00:45 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 06:00:45 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 06:00:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:00:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:00:45 INFO - Successfully installed psutil 06:00:45 INFO - Cleaning up... 06:00:45 INFO - Return code: 0 06:00:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:45 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 0x7f70a4748f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afd670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8c8c0>, '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 0x2b8d7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8dc50>, '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': '8887e36bb8e381bfd44124ac000001a8-1456234233.685923-1855228529', '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 06:00:45 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 06:00:45 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 06:00:45 INFO - Using env: {'DISPLAY': ':0', 06:00:45 INFO - 'HOME': '/home/cltbld', 06:00:45 INFO - 'LANG': 'en_US.UTF-8', 06:00:45 INFO - 'LANGUAGE': 'en_US:en', 06:00:45 INFO - 'LOGNAME': 'cltbld', 06:00:45 INFO - 'MAIL': '/var/mail/cltbld', 06:00:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:45 INFO - 'MOZ_NO_REMOTE': '1', 06:00:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:45 INFO - 'NO_EM_RESTART': '1', 06:00:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:00:45 INFO - 'PWD': '/builds/slave/test-pgo', 06:00:45 INFO - 'SHELL': '/bin/bash', 06:00:45 INFO - 'SHLVL': '1', 06:00:45 INFO - 'TERM': 'linux', 06:00:45 INFO - 'TMOUT': '86400', 06:00:45 INFO - 'USER': 'cltbld', 06:00:45 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1456234233.685923-1855228529', 06:00:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:45 INFO - '_': '/tools/buildbot/bin/python'} 06:00:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:00:45 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 06:00:45 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 06:00:45 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 06:00:45 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 06:00:45 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 06:00:45 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 06:00:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:00:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:00:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:00:47 INFO - Installing collected packages: mozsystemmonitor 06:00:47 INFO - Running setup.py install for mozsystemmonitor 06:00:47 INFO - Successfully installed mozsystemmonitor 06:00:47 INFO - Cleaning up... 06:00:47 INFO - Return code: 0 06:00:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:00:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:47 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 0x7f70a4748f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afd670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8c8c0>, '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 0x2b8d7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8dc50>, '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': '8887e36bb8e381bfd44124ac000001a8-1456234233.685923-1855228529', '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 06:00:47 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 06:00:47 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 06:00:47 INFO - Using env: {'DISPLAY': ':0', 06:00:47 INFO - 'HOME': '/home/cltbld', 06:00:47 INFO - 'LANG': 'en_US.UTF-8', 06:00:47 INFO - 'LANGUAGE': 'en_US:en', 06:00:47 INFO - 'LOGNAME': 'cltbld', 06:00:47 INFO - 'MAIL': '/var/mail/cltbld', 06:00:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:47 INFO - 'MOZ_NO_REMOTE': '1', 06:00:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:47 INFO - 'NO_EM_RESTART': '1', 06:00:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:00:47 INFO - 'PWD': '/builds/slave/test-pgo', 06:00:47 INFO - 'SHELL': '/bin/bash', 06:00:47 INFO - 'SHLVL': '1', 06:00:47 INFO - 'TERM': 'linux', 06:00:47 INFO - 'TMOUT': '86400', 06:00:47 INFO - 'USER': 'cltbld', 06:00:47 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1456234233.685923-1855228529', 06:00:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:47 INFO - '_': '/tools/buildbot/bin/python'} 06:00:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:48 INFO - Downloading/unpacking blobuploader==1.2.4 06:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:49 INFO - Downloading blobuploader-1.2.4.tar.gz 06:00:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:00:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:00:50 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 06:00:50 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 06:00:50 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 06:00:50 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 06:00:50 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 06:00:50 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 06:00:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:00:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:00:50 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 06:00:50 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 06:00:50 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 06:00:50 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 06:00:50 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 06:00:50 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 06:00:50 INFO - Downloading docopt-0.6.1.tar.gz 06:00:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:00:50 INFO - Installing collected packages: blobuploader, requests, docopt 06:00:50 INFO - Running setup.py install for blobuploader 06:00:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:00:50 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:00:50 INFO - Running setup.py install for requests 06:00:51 INFO - Running setup.py install for docopt 06:00:51 INFO - Successfully installed blobuploader requests docopt 06:00:51 INFO - Cleaning up... 06:00:51 INFO - Return code: 0 06:00:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:00: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')]} 06:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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')]} 06:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:51 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 0x7f70a4748f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afd670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8c8c0>, '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 0x2b8d7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8dc50>, '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': '8887e36bb8e381bfd44124ac000001a8-1456234233.685923-1855228529', '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 06:00:51 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 06:00:51 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 06:00:51 INFO - Using env: {'DISPLAY': ':0', 06:00:51 INFO - 'HOME': '/home/cltbld', 06:00:51 INFO - 'LANG': 'en_US.UTF-8', 06:00:51 INFO - 'LANGUAGE': 'en_US:en', 06:00:51 INFO - 'LOGNAME': 'cltbld', 06:00:51 INFO - 'MAIL': '/var/mail/cltbld', 06:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:51 INFO - 'MOZ_NO_REMOTE': '1', 06:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:51 INFO - 'NO_EM_RESTART': '1', 06:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:00:51 INFO - 'PWD': '/builds/slave/test-pgo', 06:00:51 INFO - 'SHELL': '/bin/bash', 06:00:51 INFO - 'SHLVL': '1', 06:00:51 INFO - 'TERM': 'linux', 06:00:51 INFO - 'TMOUT': '86400', 06:00:51 INFO - 'USER': 'cltbld', 06:00:51 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1456234233.685923-1855228529', 06:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:51 INFO - '_': '/tools/buildbot/bin/python'} 06:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:00:51 INFO - Running setup.py (path:/tmp/pip-RPCW9D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:00:51 INFO - Running setup.py (path:/tmp/pip-Uu6guC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:00:51 INFO - Running setup.py (path:/tmp/pip-zW2Pk_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:00:51 INFO - Running setup.py (path:/tmp/pip-s5IYy0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:00:51 INFO - Running setup.py (path:/tmp/pip-t1FMUB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:00:51 INFO - Running setup.py (path:/tmp/pip-F5_zR1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:00:51 INFO - Running setup.py (path:/tmp/pip-jR1rYb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:00:52 INFO - Running setup.py (path:/tmp/pip-IFLzmA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:00:52 INFO - Running setup.py (path:/tmp/pip-Giafv1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:00:52 INFO - Running setup.py (path:/tmp/pip-6nYD4w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:00:52 INFO - Running setup.py (path:/tmp/pip-G0lMWw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:00:52 INFO - Running setup.py (path:/tmp/pip-cj5oxm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:00:52 INFO - Running setup.py (path:/tmp/pip-PIyj3v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:00:52 INFO - Running setup.py (path:/tmp/pip-DSq6Qs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:00:52 INFO - Running setup.py (path:/tmp/pip-mhUeI6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:00:52 INFO - Running setup.py (path:/tmp/pip-8oza_a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:00:52 INFO - Running setup.py (path:/tmp/pip-Vmh0a2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:00:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:00:52 INFO - Running setup.py install for manifestparser 06:00:52 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:00:52 INFO - Running setup.py install for mozcrash 06:00:52 INFO - Running setup.py install for mozdebug 06:00:53 INFO - Running setup.py install for mozdevice 06:00:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:00:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:00:53 INFO - Running setup.py install for mozfile 06:00:53 INFO - Running setup.py install for mozhttpd 06:00:53 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:00:53 INFO - Running setup.py install for mozinfo 06:00:53 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:00:53 INFO - Running setup.py install for mozInstall 06:00:53 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:00:53 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:00:53 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:00:53 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:00:53 INFO - Running setup.py install for mozleak 06:00:53 INFO - Running setup.py install for mozlog 06:00:53 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:00:53 INFO - Running setup.py install for moznetwork 06:00:53 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:00:53 INFO - Running setup.py install for mozprocess 06:00:54 INFO - Running setup.py install for mozprofile 06:00:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:00:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:00:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:00:54 INFO - Running setup.py install for mozrunner 06:00:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:00:54 INFO - Running setup.py install for mozscreenshot 06:00:54 INFO - Running setup.py install for moztest 06:00:54 INFO - Running setup.py install for mozversion 06:00:54 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:00:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:00:54 INFO - Cleaning up... 06:00:54 INFO - Return code: 0 06:00:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:00:54 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')]} 06:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:54 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')]} 06:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:54 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 0x7f70a4748f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afd670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8c8c0>, '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 0x2b8d7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8dc50>, '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': '8887e36bb8e381bfd44124ac000001a8-1456234233.685923-1855228529', '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 06:00:54 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 06:00:54 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 06:00:54 INFO - Using env: {'DISPLAY': ':0', 06:00:54 INFO - 'HOME': '/home/cltbld', 06:00:54 INFO - 'LANG': 'en_US.UTF-8', 06:00:54 INFO - 'LANGUAGE': 'en_US:en', 06:00:54 INFO - 'LOGNAME': 'cltbld', 06:00:54 INFO - 'MAIL': '/var/mail/cltbld', 06:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:54 INFO - 'MOZ_NO_REMOTE': '1', 06:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:54 INFO - 'NO_EM_RESTART': '1', 06:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:00:54 INFO - 'PWD': '/builds/slave/test-pgo', 06:00:54 INFO - 'SHELL': '/bin/bash', 06:00:54 INFO - 'SHLVL': '1', 06:00:54 INFO - 'TERM': 'linux', 06:00:54 INFO - 'TMOUT': '86400', 06:00:54 INFO - 'USER': 'cltbld', 06:00:54 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1456234233.685923-1855228529', 06:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:54 INFO - '_': '/tools/buildbot/bin/python'} 06:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:00:54 INFO - Running setup.py (path:/tmp/pip-lzNuZy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:00:54 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)) 06:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:00:54 INFO - Running setup.py (path:/tmp/pip-25gJi3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:00:54 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)) 06:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:00:54 INFO - Running setup.py (path:/tmp/pip-ZWwC_4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:00:54 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)) 06:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:00:54 INFO - Running setup.py (path:/tmp/pip-Yy5eqi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:00:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 06:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:00:55 INFO - Running setup.py (path:/tmp/pip-v_j5jM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:00:55 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)) 06:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:00:55 INFO - Running setup.py (path:/tmp/pip-s1NTg3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:00:55 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)) 06:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:00:55 INFO - Running setup.py (path:/tmp/pip-XvLnsm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:00:55 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)) 06:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:00:55 INFO - Running setup.py (path:/tmp/pip-OuioBB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:00:55 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)) 06:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:00:55 INFO - Running setup.py (path:/tmp/pip-VB_FXu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:00:55 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)) 06:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:00:55 INFO - Running setup.py (path:/tmp/pip-9s61nn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:00:55 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)) 06:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:00:55 INFO - Running setup.py (path:/tmp/pip-Z4HIEL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:00:55 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)) 06:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:00:55 INFO - Running setup.py (path:/tmp/pip-DkMYOT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:00:55 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)) 06:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:00:55 INFO - Running setup.py (path:/tmp/pip-3pM69n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:00:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 06:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:00:55 INFO - Running setup.py (path:/tmp/pip-378PMJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:00:55 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)) 06:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:00:55 INFO - Running setup.py (path:/tmp/pip-CFv4w6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:00:55 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)) 06:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:00:55 INFO - Running setup.py (path:/tmp/pip-ESi3eF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:00:55 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)) 06:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:00:55 INFO - Running setup.py (path:/tmp/pip-n_CVB3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:00:55 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)) 06:00:55 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)) 06:00:55 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)) 06:00:55 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)) 06:00:55 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:00:55 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:00:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:57 INFO - Downloading blessings-1.6.tar.gz 06:00:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:00:57 INFO - Installing collected packages: blessings 06:00:57 INFO - Running setup.py install for blessings 06:00:57 INFO - Successfully installed blessings 06:00:57 INFO - Cleaning up... 06:00:58 INFO - Return code: 0 06:00:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:00:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:00:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:00:58 INFO - Reading from file tmpfile_stdout 06:00:58 INFO - Current package versions: 06:00:58 INFO - argparse == 1.2.1 06:00:58 INFO - blessings == 1.6 06:00:58 INFO - blobuploader == 1.2.4 06:00:58 INFO - docopt == 0.6.1 06:00:58 INFO - manifestparser == 1.1 06:00:58 INFO - mozInstall == 1.12 06:00:58 INFO - mozcrash == 0.16 06:00:58 INFO - mozdebug == 0.1 06:00:58 INFO - mozdevice == 0.48 06:00:58 INFO - mozfile == 1.2 06:00:58 INFO - mozhttpd == 0.7 06:00:58 INFO - mozinfo == 0.9 06:00:58 INFO - mozleak == 0.1 06:00:58 INFO - mozlog == 3.1 06:00:58 INFO - moznetwork == 0.27 06:00:58 INFO - mozprocess == 0.22 06:00:58 INFO - mozprofile == 0.28 06:00:58 INFO - mozrunner == 6.11 06:00:58 INFO - mozscreenshot == 0.1 06:00:58 INFO - mozsystemmonitor == 0.0 06:00:58 INFO - moztest == 0.7 06:00:58 INFO - mozversion == 1.4 06:00:58 INFO - psutil == 3.1.1 06:00:58 INFO - requests == 1.2.3 06:00:58 INFO - wsgiref == 0.1.2 06:00:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:00: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')]} 06:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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')]} 06:00:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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/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 0x7f70a4748f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afd670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8c8c0>, '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 0x2b8d7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8dc50>, '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': '8887e36bb8e381bfd44124ac000001a8-1456234233.685923-1855228529', '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 06:00:58 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 06:00:58 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 06:00:58 INFO - Using env: {'DISPLAY': ':0', 06:00:58 INFO - 'HOME': '/home/cltbld', 06:00:58 INFO - 'LANG': 'en_US.UTF-8', 06:00:58 INFO - 'LANGUAGE': 'en_US:en', 06:00:58 INFO - 'LOGNAME': 'cltbld', 06:00:58 INFO - 'MAIL': '/var/mail/cltbld', 06:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:58 INFO - 'MOZ_NO_REMOTE': '1', 06:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:58 INFO - 'NO_EM_RESTART': '1', 06:00:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:00:58 INFO - 'PWD': '/builds/slave/test-pgo', 06:00:58 INFO - 'SHELL': '/bin/bash', 06:00:58 INFO - 'SHLVL': '1', 06:00:58 INFO - 'TERM': 'linux', 06:00:58 INFO - 'TMOUT': '86400', 06:00:58 INFO - 'USER': 'cltbld', 06:00:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1456234233.685923-1855228529', 06:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:58 INFO - '_': '/tools/buildbot/bin/python'} 06:00:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.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 1)) 06:00:58 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 2)) 06:00:58 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 3)) 06:00:58 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 4)) 06:00:58 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 5)) 06:00:58 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 6)) 06:00:58 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 7)) 06:00:58 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 8)) 06:00:58 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 9)) 06:00:58 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.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:00:58 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 4)) 06:00:58 INFO - Cleaning up... 06:00:58 INFO - Return code: 0 06:00:58 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06:00: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')]} 06:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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')]} 06:00:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f70a4748f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afd670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8c8c0>, '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 0x2b8d7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8dc50>, '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': '8887e36bb8e381bfd44124ac000001a8-1456234233.685923-1855228529', '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 06:00:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 06:00:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:00:58 INFO - Using env: {'DISPLAY': ':0', 06:00:58 INFO - 'HOME': '/home/cltbld', 06:00:58 INFO - 'LANG': 'en_US.UTF-8', 06:00:58 INFO - 'LANGUAGE': 'en_US:en', 06:00:58 INFO - 'LOGNAME': 'cltbld', 06:00:58 INFO - 'MAIL': '/var/mail/cltbld', 06:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:58 INFO - 'MOZ_NO_REMOTE': '1', 06:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:58 INFO - 'NO_EM_RESTART': '1', 06:00:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:00:58 INFO - 'PWD': '/builds/slave/test-pgo', 06:00:58 INFO - 'SHELL': '/bin/bash', 06:00:58 INFO - 'SHLVL': '1', 06:00:58 INFO - 'TERM': 'linux', 06:00:58 INFO - 'TMOUT': '86400', 06:00:58 INFO - 'USER': 'cltbld', 06:00:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1456234233.685923-1855228529', 06:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:58 INFO - '_': '/tools/buildbot/bin/python'} 06:00:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:58 INFO - Downloading/unpacking jsonschema 06:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:01:00 INFO - Downloading/unpacking functools32 (from jsonschema) 06:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:00 INFO - Downloading functools32-3.2.3-2.tar.gz 06:01:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:01:00 INFO - warning: no files found matching '*.txt' 06:01:00 INFO - no previously-included directories found matching 'build' 06:01:00 INFO - no previously-included directories found matching 'dist' 06:01:00 INFO - no previously-included directories found matching '.git*' 06:01:00 INFO - Installing collected packages: jsonschema, functools32 06:01:00 INFO - Running setup.py install for functools32 06:01:00 INFO - warning: no files found matching '*.txt' 06:01:00 INFO - no previously-included directories found matching 'build' 06:01:00 INFO - no previously-included directories found matching 'dist' 06:01:00 INFO - no previously-included directories found matching '.git*' 06:01:00 INFO - Successfully installed jsonschema functools32 06:01:00 INFO - Cleaning up... 06:01:00 INFO - Return code: 0 06:01:00 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 06:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f70a4748f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afd670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8c8c0>, '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 0x2b8d7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8dc50>, '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': '8887e36bb8e381bfd44124ac000001a8-1456234233.685923-1855228529', '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 06:01:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 06:01:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:01:00 INFO - Using env: {'DISPLAY': ':0', 06:01:00 INFO - 'HOME': '/home/cltbld', 06:01:00 INFO - 'LANG': 'en_US.UTF-8', 06:01:00 INFO - 'LANGUAGE': 'en_US:en', 06:01:00 INFO - 'LOGNAME': 'cltbld', 06:01:00 INFO - 'MAIL': '/var/mail/cltbld', 06:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:00 INFO - 'MOZ_NO_REMOTE': '1', 06:01:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:00 INFO - 'NO_EM_RESTART': '1', 06:01:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:01:00 INFO - 'PWD': '/builds/slave/test-pgo', 06:01:00 INFO - 'SHELL': '/bin/bash', 06:01:00 INFO - 'SHLVL': '1', 06:01:00 INFO - 'TERM': 'linux', 06:01:00 INFO - 'TMOUT': '86400', 06:01:00 INFO - 'USER': 'cltbld', 06:01:00 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1456234233.685923-1855228529', 06:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:00 INFO - '_': '/tools/buildbot/bin/python'} 06:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:01 INFO - Downloading/unpacking flake8 06:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:01:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:01: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 06:01: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 06:01: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 06:01: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 06:01: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 06:01: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 06:01:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:01:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:01:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:01:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:01:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:01:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:01:03 INFO - no previously-included directories found matching 'docs/_build' 06:01:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:01:03 INFO - Running setup.py install for pep8 06:01:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:01:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:01:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:01:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:01:03 INFO - no previously-included directories found matching 'docs/_build' 06:01:03 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:01:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:01:03 INFO - Cleaning up... 06:01:03 INFO - Return code: 0 06:01:03 INFO - Running post-action listener: _resource_record_post_action 06:01:03 INFO - Running post-action listener: _start_resource_monitoring 06:01:03 INFO - Starting resource monitoring. 06:01:03 INFO - ##### 06:01:03 INFO - ##### Running install step. 06:01:03 INFO - ##### 06:01:03 INFO - Running pre-action listener: _resource_record_pre_action 06:01:03 INFO - Running main action method: install 06:01:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:01:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:01:04 INFO - Reading from file tmpfile_stdout 06:01:04 INFO - Detecting whether we're running mozinstall >=1.0... 06:01:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:01:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:01:04 INFO - Reading from file tmpfile_stdout 06:01:04 INFO - Output received: 06:01:04 INFO - Usage: mozinstall [options] installer 06:01:04 INFO - Options: 06:01:04 INFO - -h, --help show this help message and exit 06:01:04 INFO - -d DEST, --destination=DEST 06:01:04 INFO - Directory to install application into. [default: 06:01:04 INFO - "/builds/slave/test-pgo"] 06:01:04 INFO - --app=APP Application being installed. [default: firefox] 06:01:04 INFO - mkdir: /builds/slave/test-pgo/build/application 06:01:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 06:01:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 06:01:20 INFO - Reading from file tmpfile_stdout 06:01:20 INFO - Output received: 06:01:20 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:01:20 INFO - Running post-action listener: _resource_record_post_action 06:01:20 INFO - ##### 06:01:20 INFO - ##### Running run-tests step. 06:01:20 INFO - ##### 06:01:20 INFO - Running pre-action listener: _resource_record_pre_action 06:01:20 INFO - Running main action method: run_tests 06:01:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:01:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:01:20 INFO - Python 2.7.3 06:01:20 INFO - Return code: 0 06:01:20 INFO - grabbing minidump binary from tooltool 06:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:20 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 0x2b8c8c0>, '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 0x2b8d7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8dc50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:01:20 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 06:01:20 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 06:01:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:01:20 INFO - Return code: 0 06:01:20 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:01:20 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:01:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:01:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:01:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:01:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:01:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:01:21 INFO - Return code: 0 06:01:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 06:01:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 06:01:21 INFO - Using env: {'DISPLAY': ':0', 06:01:21 INFO - 'HOME': '/home/cltbld', 06:01:21 INFO - 'LANG': 'en_US.UTF-8', 06:01:21 INFO - 'LANGUAGE': 'en_US:en', 06:01:21 INFO - 'LOGNAME': 'cltbld', 06:01:21 INFO - 'MAIL': '/var/mail/cltbld', 06:01:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:01:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:21 INFO - 'MOZ_NO_REMOTE': '1', 06:01:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:01:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:21 INFO - 'NO_EM_RESTART': '1', 06:01:21 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:01:21 INFO - 'PWD': '/builds/slave/test-pgo', 06:01:21 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:01:21 INFO - 'SHELL': '/bin/bash', 06:01:21 INFO - 'SHLVL': '1', 06:01:21 INFO - 'TERM': 'linux', 06:01:21 INFO - 'TMOUT': '86400', 06:01:21 INFO - 'USER': 'cltbld', 06:01:21 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1456234233.685923-1855228529', 06:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:21 INFO - '_': '/tools/buildbot/bin/python'} 06:01:21 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:01:21 INFO - mozversion application_buildid: 20160223030304 06:01:21 INFO - mozversion application_changeset: 789a12291942763bc1e3a89f97e0b82dc1c9d00b 06:01:21 INFO - mozversion application_display_name: Nightly 06:01:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:01:21 INFO - mozversion application_name: Firefox 06:01:21 INFO - mozversion application_remotingname: firefox 06:01:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:01:21 INFO - mozversion application_vendor: Mozilla 06:01:21 INFO - mozversion application_version: 47.0a1 06:01:21 INFO - mozversion platform_buildid: 20160223030304 06:01:21 INFO - mozversion platform_changeset: 789a12291942763bc1e3a89f97e0b82dc1c9d00b 06:01:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:01:21 INFO - mozversion platform_version: 47.0a1 06:01:21 INFO - using testdate: 1456236081 06:01:21 INFO - actual date: 1456236081 06:01:21 INFO - starting webserver on 'localhost:47199' 06:01:21 INFO - SUITE-START | Running 2 tests 06:01:21 INFO - TEST-START | dromaeo_css 06:01:21 INFO - operating with platform_type : linux_ 06:01:21 INFO - Initialising browser for dromaeo_css test... 06:01:21 INFO - TEST-INFO | started process 24684 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFWDrYO/profile http://localhost:47199/getInfo.html) 06:01:25 INFO - PROCESS | 24684 | __metrics Screen width/height:1600/1200 06:01:25 INFO - PROCESS | 24684 | colorDepth:24 06:01:25 INFO - PROCESS | 24684 | Browser inner width/height: 1024/697 06:01:25 INFO - PROCESS | 24684 | __metrics 06:01:27 INFO - PROCESS | 24684 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:01:27 INFO - TEST-INFO | 24684: exit 0 06:01:27 INFO - Browser initialized. 06:01:27 INFO - Running cycle 1/1 for dromaeo_css test... 06:01:27 INFO - TEST-INFO | started process 24778 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFWDrYO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:01:39 INFO - PROCESS | 24778 | RSS: Main: 148119552 06:01:39 INFO - PROCESS | 24778 | 06:02:31 INFO - PROCESS | 24778 | 1456236151152 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] 06:04:38 INFO - PROCESS | 24778 | Cycle 1(1): loaded http://localhost:47199/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47199/tests/dromaeo/cssquery-ext.html) 06:04:39 INFO - PROCESS | 24778 | RSS: Main: 243388416 06:04:39 INFO - PROCESS | 24778 | 06:07:42 INFO - PROCESS | 24778 | Cycle 1(1): loaded http://localhost:47199/tests/dromaeo/cssquery-ext.html (next: http://localhost:47199/tests/dromaeo/cssquery-jquery.html) 06:07:42 INFO - PROCESS | 24778 | RSS: Main: 235028480 06:07:42 INFO - PROCESS | 24778 | 06:10:44 INFO - PROCESS | 24778 | Cycle 1(1): loaded http://localhost:47199/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47199/tests/dromaeo/cssquery-mootools.html) 06:10:45 INFO - PROCESS | 24778 | RSS: Main: 223494144 06:10:45 INFO - PROCESS | 24778 | 06:13:47 INFO - PROCESS | 24778 | Cycle 1(1): loaded http://localhost:47199/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47199/tests/dromaeo/cssquery-prototype.html) 06:13:47 INFO - PROCESS | 24778 | RSS: Main: 204824576 06:13:47 INFO - PROCESS | 24778 | 06:16:50 INFO - PROCESS | 24778 | Cycle 1(1): loaded http://localhost:47199/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47199/tests/dromaeo/cssquery-yui.html) 06:16:51 INFO - PROCESS | 24778 | RSS: Main: 209289216 06:16:51 INFO - PROCESS | 24778 | 06:19:53 INFO - PROCESS | 24778 | Cycle 1(1): loaded http://localhost:47199/tests/dromaeo/cssquery-yui.html (next: http://localhost:47199/tests/dromaeo/cssquery-dojo.html) 06:19:53 INFO - PROCESS | 24778 | RSS: Main: 244568064 06:19:53 INFO - PROCESS | 24778 | 06:19:53 INFO - PROCESS | 24778 | __start_tp_report 06:19:53 INFO - PROCESS | 24778 | _x_x_mozilla_page_load 06:19:53 INFO - PROCESS | 24778 | _x_x_mozilla_page_load_details 06:19:53 INFO - PROCESS | 24778 | |i|pagename|runs| 06:19:53 INFO - PROCESS | 24778 | |0;dojo.html;3065;3126.9530957035636;3128.092853072609;3155.8422078896056;3163.066895265896;4940.876478088041;5011.974940125294;5025.271335656327;5058.6964782113055;5059.924101138486;5008.649394542384;5049.116404629184;5095.872603184922;5106.234064890268;5138.588912886969;4520.073384956077;4605.447346318447;4614.653900957442;4662.184117779392;4721.268203428474;4651.139539185245;4656.627469802408;4693.577578017977;4711.222648263032;4750.691205071659;4560.901985086847;4611.5619016193405;4667.253239481666;4668.393108895856;4700.576948074656;4661.207594708908;4670.369500117508;4676.50896655853;4677.6257899367965;4714.9391386938005;4534.863954081383;4580.564846339593;4650.813967441299;4664.65015123867;4692.2257827458425;4853.077915196137;4913.115639184945;4927.605791536705;4935.136351138536;4941.629377796679;5458.972705136489;5463.153211252262;5471.644343117685;5476.808311709071;5499.092649712793;5503.422140675211;5516.14499752539;5522.337319521643;5522.6134170608075;5526;4989.875253118665;5081.949180508184;5112.284280200774;5149.330587023663;5163.664361816507;5583.469570390806;5600.607957443021;5605.915911261334;5610.607257491936;5674.205611214434;5242.1088414969545;5373.892522149535;5378.784848606012;5379.112446446293;5390.784368625211;5431.103867861838;5447.237386765856;5478.233047373371;5482.972585137129;5527.55779537636;5372.57019438444;5399.541039011649;5399.676019438846;5409.621326507186;5445.918311225335;5250.343707036621;5389.326334208224;5401.378841433286;5411.053065713484;5464.508194262536;4226.091390351089;4229.619334259932;4233.470816147981;4235.851745188966;4262.296721041055;3834.9616503835164;3836.76979381238;3837.654611085016;3848.4034974578985;3868.303705333011;4919.680220785637;5087.923681144785;5154.690718556899;5163.638545301793;5180.197069454241;5298.072837253465;5299.5760339172775;5317.654352467077;5324.387695415076;5338.172583249602;4979.502049794992;4979.800807967713;4983.302337672729;4996.657587276861;5022.522860328263;4571.588557029817;4694.6009589185305;4733.692309999839;4737.194676904865;4779;5654.095344744821;5664.716764161775;5672.262605861211;5672.971635141798;5731.856703582361;5291;5387.191921211849;5445.700486473282;5449.2371068049715;5449.536789372948;5561.332640083216;5601.551875849841;5609.775608975595;5644.520215781705;5646.407127251744;5377.516023557742;5394.649347792381;5403.108487099585;5410.242566040679;5414.7021913795115;5364.088105022233;5465.098258787415;5489.58828087887;5500.532454741392;5550.250716153268;5281.577473802164;5313.442088580643;5314.681119132864;5321.414644389037;5357.946420535744;5258.132408152612;5267.499587539178;5279.920801188062;5280.234366016829;5329.9467005331;5080.390353157644;5134.255532947776;5205.531502164823;5217.686938783685;5218.530332269962;5302.575793936398;5313.946860531345;5328.387235467816;5350.250964864844;5372.247885295984;5181.53366197044;5184.870378240575;5185.818496352609;5190.039842629126;5193.688378697139 06:19:53 INFO - PROCESS | 24778 | |1;ext.html;526.202802753828;528.5216878724756;558.511302610216;577.8959787238297;601.8796240751849;27788.583171252423;35593;36181.45727814085;36201.45697814535;36208;39251.803740981326;39572.802135989354;39636.80181599088;39644.60355396445;39650;7453.888191677129;7603.429742769286;8395.370347223952;8612.698555550556;9855.063768941975;9977.50112494376;10112.241581881388;10123.595056197742;10132.341397809156;10141.391516509033;10036.44799536029;10061.49692515375;10117.140043096346;10120.645777397793;10131;9964.651237206699;10050.296479246455;10051.899481005206;10056.044675755791;10063.899361006406;9972.900270997343;10106.64626738068;10107.848382274271;10109.545070471846;10429.687109386654;39490.210195795924;39901.40147897784;39912.40131398002;39948;39974.400383993976;3025.4251692178414;3080.9832755190732;3178.618565772122;3309.6855798699085;3730.794806285653;26262.474750504884;26787.46425071488;26852.73147268522;26904.192874213804;27249.727502724916;3746.6253374662588;3811.428285757131;3834.0989867381145;3937.4093885917055;3959.3862951242604;211855.99999999846;212404;214264;214700.99999999843;215462;40958.38562421566;41583;41606.375904361455;41639.375409368884;41751.37372939409;38674.806625967256;38695;38840.22319553593;38857;38916.80541597274;14614.488492902698;14734;14752.63118422048;14758.188299643623;14759.188244646433;11125.221234513507;11200.495977681025;11330.433478326051;11486.483108260149;11589.884101159048;13810.171389716648;13848.723025539633;13895.374708138159;13940.790888136686;14112.788308175386;5555.583331250092;5721.799737009184;5734.426557344315;5734.799282025109;5795.362510123883;866.1079088538816;880.4145243413059;891.8171774786153;941.3598752847992;988.2637435110888;28082.578761318597;28405.431891362055;28483.430331393258;28529.85735071353;28716.42567148687;898.4654130792168;1000.2248257600418;1029.9485025748684;1036.7926414717087;1039.210200247817;13500.93249533746;13889;13917.02580819333;13987.37056832445;14147.50483733085;306148;307378;311345;312037;312166.4391678027;50113;50487.747561262695;50565.24152137721;50602.746986264836;50662;1312.7177656803833;1313.4614807928704;1337.9397927093305;1343.1605246720603;1356.4574170331946;25147.74852251454;26429.60355594629;26665.20004399871;26722.19833405001;26892.193234203005;47234;48077.75961120172;48182.5181748178;48801.75599121982;48811.511884882115;289068;294190;294191;294326;294427;35883;41043.79478102591;41651.583484164774;42070.78964605158;42269.154616906875;38061.66876002208;38167.80916095402;38336.61663383442;38692;38947.80526097352;33033.66966330306;33118;33147.50278745773;34897.47653785246;36683.44974825326;28960.234110872632;34723.13192170216;35230.47154292637;36368.63631363758;36643.63356366402;32025.83987080143;32342;32501;32558.511622326158;37105.628943711294;28712.569311459927;32425.837870810494;34581;34740.47889281612;35084;23645.172418965252;23655.40861478408;24744.25767226986;25212.62181067249;25226.243212703648 06:19:53 INFO - PROCESS | 24778 | |2;jquery.html;362.1543695471075;364.6135096797395;365.63984475291835;366.58392724257976;371.0279068839641;13336.799948000764;16486.67026659466;16504.42234521792;16768.32926682933;18047.548811279725;15661;15958.28187731552;16183.271752771125;16184.676306473893;16185.514434566981;5374.946250537503;5494.038543254935;5521.751521181556;5522.3649280332875;5543.417941116185;4012.1574469361467;5234.319538459995;5818.621789583684;6098.3596722343955;6099.390060993887;6030.125631783389;6036.15493830864;6044.274687037561;6067.150598916155;6070.72681729321;5927.525797936176;5950.077737950624;6080.2703675559;6080.817575472743;6084.361142080106;5319.601029922733;5337.599680024014;5338.172583249602;5339.893202135974;5341.332333458317;19301.51746206342;20128.597428051504;20141.49646258855;20268.594628107356;20309.390718278326;2242.5232620693805;2324.755900630443;2577.536043512167;2809.7190280971945;2966.9406611867857;12494.375281235993;12580.81128783069;12745.362731863463;12778.552750653775;13260.204387736767;1813.610073834132;1849.713294439364;1864.0307040339083;1879.5583037986062;1894.8957807320592;62086;63396.366036339045;64101.67949160271;64186;64586.3541364585;9537.952310238543;9738.610455581698;10015.349002314826;10022.448765317831;10093.899061009295;12988.740225195443;12999.285039322738;13069.869301307055;13073.738525229443;13110.213387196607;7779.649915753805;7787.844243115106;7815.882761758578;7851.214878512217;7861.606919653995;7799;7828.334591559667;7894.565798881116;7899.802504937423;7900.525968441912;5898.793542226002;5990.790322338785;5992;6003.519718422515;6047.455728984412;1669.7161482547997;1677.7818883545306;1714.7942246930447;1720.5096547483906;1799.5411170151528;866.5580553917547;957.7844984878486;983.8229118758692;1086.2939089591828;1110.4392281897751;14172.85827141736;15482.922585387001;15501.457448989457;16879.493615191564;16912.830871691127;895.4671970177734;901.5492253873064;934.8317302885409;942.3686130292721;1011.2870426349406;8704.390692651581;9138;9174.587143578421;9218.262538996863;9271.35100542969;228003;265397;360092;419130;465692;70821.64589177021;72923.2707672927;76231.23768762352;80006;80185.59907200426;438.2680922858833;451.52589780730756;452.298936648194;452.31925951442867;453.0146930426244;9556.665516706882;9851.45816980073;10027.348222365523;10045.999261617035;10281.53733082028;33509;33517.32965340728;33687.4946875802;34534;34582.654173457944;45226.77386613046;47972.520274798204;49163.262551061045;49487;49757.75121124371;7645.159032506531;7665.501742386727;7733;8024.598770061591;8061.798455038671;10157.695269141937;12045.518179273082;12408.441620126936;12502.374881255719;12775;10094.8485772712;10478.842817357898;10511.369317840954;10530.57877684884;10702.090322322378;10500.527476263434;10612;10671.306365086244;10752.0323170915;11299.09607231436;10774.084202842847;11129.443527823738;11184.720381990515;11276.154288428565;11287.661370158909;7850.4112191587;7901.881471777813;7912.881306780518;8003.998500562289;8185;8008.719694810654;8306.916930830614;10897.509612067635;11017.724556886142;11107.833382499108 06:19:53 INFO - PROCESS | 24778 | |3;mootools.html;1315.7565850317699;1430.2562667412944;1433.4552869909433;1595.266177558323;1794.0581194872698;7287.198408175096;7416.406687465003;7426.071741032371;7445.8883116753295;7453.5155214911065;7413.518121322124;7561.130469995952;7584.279493448127;7586.203448637896;7589.354904833096;1951.5706544560173;2158.643823769084;2201.2515744646817;2277.3168049585142;2297.1844995026777;2215.8559693619945;2216.091402524965;2228.3092241405216;2229.665550167472;2229.6655501674795;2293.289080385078;2297.8161747060194;2300.0454811253394;2301.7122859642545;2302.1482051640915;2230.1971290335546;2250.437390652337;2258.5934531784274;2277.9772202278095;2279.2022792022826;2187.57342318248;2191.2002119226368;2198.703175071361;2251.898664560099;2273.283915566591;6355.586886852339;6516.218053833523;7654.502457340255;7722.1119571249465;7729.188435214278;4030.0932290234464;4448.4439445069365;4513.097380523908;4514.255147900625;4522.796474158671;3124.7812653114293;3159.668234835332;3216.5979252593424;3221.4201443740117;3259.103746469716;1032.3805716569998;1047.245982892324;1059.3961441978076;1088.2491081154058;1112.1436493899732;10285.742856428575;10337.483125843753;10351.482425878676;10358.119559837423;10659.680209593647;4080.5511393746665;4163.646090082377;4169.332906734908;4182.811773470201;4241.851535196253;9131.497767622712;9140.223081038186;9162.267018638493;9162.358634895627;9167.083291670913;4077.245709543744;4519.932201016987;4619.3071039343695;4657.3246879202325;4672.789724462407;4134;4193.5387107418155;4202.033532287591;4206.453161089039;4215.388768628532;3547.396942519778;3566.375884220251;3586.444101164324;3594.6225646307284;3615.620359862229;1096.5010920031525;1108.9611863584735;1116.4473585575192;1121.3216004317433;1127.1321082766224;1319.4656164253493;1337.9732405352033;1352.9391177396844;1359.4766015084265;1372.9519466818613;7176.282371762782;7246.094238220223;7293.8905916411295;7322.304381083789;7334.48658593904;1089.4117176724637;1099.4942326529726;1108.6009036746764;1122.960696375623;1127.875933647298;5670.716464176775;5684.232628595169;5744.195812586241;5744.827655170351;5748.827535173951;8726.520041397656;8777.912220877837;8936.910630893737;9104.226140777975;9104.226140778108;9058.365914386062;9084.40951338174;9129.863052054225;9149.862752058725;9216.815663686823;7008.614526201108;7120.394766444807;7200.747973820996;7253.746118885813;7330.230325815819;6988.8951665724035;7006.509544331848;7009.824754381181;7026.156861176692;7068.3285087916565;7662.310392064741;7818.218178182136;7825.569593672402;7896.249856263646;7923.564203968837;7776.805579860323;8196.303314218358;8204.302634276153;8206.917930820615;8254.917450825415;5678.858028549154;5801.448862358069;6374.107624932421;6549.345065493412;6660.234073081464;7117.786466406016;7146;7156;7196.6041867695685;7218.061651985208;6422.2614399344675;6646;6656.7670131545165;6701.832454188684;6796.796096117125;6283.3088360281245;6515;6527.05357723137;6541.116949211986;6586.571872828251;6872.484563657646;6902.723891044503;6910.101686780687;6912.516123871281;6924.723011079501;6322;6387.105805187371;6387.361263873761;6402.711877965409;6415.358464153547;6497.610143391412;6509.641969691523;6538.738450462119;6540.247871494839;6562.048502967138 06:19:53 INFO - PROCESS | 24778 | |4;prototype.html;313.64244760972497;315.2654315445013;317.8871500617281;322.4566605270119;326.82024886312524;5831;6084.482818960388;6115.969420152893;6119.143319935212;6121.204243448346;5868.9413105868925;5962.403759624046;5977.282726072877;5978.581499295051;5983.790567330145;4258.403823464718;4406.427164468614;4491.101779644068;4501.414816073906;4539.296409056585;4503.189425903336;4505.414296141514;4523.389342438762;4524.208263553882;4532.546745325474;4470.374147619336;4470.75410852403;4471.5081341052455;4475.932861007072;4494.460664720238;4265.552117027714;4386.34204869269;4473.642108631302;4479.753613551254;4485.327200919855;3861.343571592836;3866.4586957825927;3868.709846761504;3869.2068126034096;3873.9418908716393;5623.0721930881355;5627.887442251173;5630.5495560355075;5630.718464076821;5631.352394474647;5207.869803254911;5210.817621383233;5214.348206474191;5216.3218781558535;5229.921551176735;6284.308726040132;6301.6534090625;6307.653079080649;6310.368963103699;6313.968430157865;4138.627523522868;4266.658667306608;4273.423087883127;4304.74171549708;4314.180305741899;6518.706658200345;6596.472282217411;6620.735170593171;6629.569078009914;6644.335566443366;4328.718633288826;4334.829596009123;4339.1104823511105;4339.696221264481;4348.412964249849;4375.234333991539;4379.299312110047;4389.429374181336;4391.077873646506;4393.384926110347;5147.378575748628;5161.096808058574;5168.302279192336;5173.4826517347965;5176.767045482887;6150.446459818549;6365.0452432134625;6378.585391949508;6385.904211436832;6386.648734319564;1536.7464368379315;1546.4278217059534;1554.114154931678;1554.572492564531;1556.657535342223;941.9858702119474;999.205631522941;1030.062642994871;1047.5966752800075;1075.3977772447454;5892.5285977122585;5954.196183515257;5959.195508606283;5972.297895099876;5975.282966044103;6420.422162005349;6426.8714625707225;6436.131122298523;6436.809190299716;6443.613383197023;5948.494377977834;5965.045592705146;5965.284165900033;5966.433188847052;5967.343592204854;3439;3474.8436320365645;3477.982610086984;3480.3387356402204;3481.3907566175817;6630.900536491957;6794.830129246809;6807.0810440589885;6826;6836.4530837532875;6625.271220165778;6646.734130634721;6649.867002659919;6651.268360480343;6651.467882569383;6789.0834737310815;6795.048693182958;6795.966020169966;6804.387605115563;6805.897911531331;6407.615543067431;6418.19772528434;6425.678716064272;6431.710573024318;6435.710393032231;6229.660622966055;6328.525360598066;6376.649284289409;6391.616503009835;6412.551121421456;6724.731010759515;6776.186857577122;6776.898346524905;6786.660666966533;6799.864002720017;4536.65975051879;4538.364628952016;4541.43232095988;4541.568550987651;4542.454905411372;6418.261899881573;6425.293217745951;6428.517861160338;6439.35986245637;6439.871202576016;6244.781432649836;6251.530645394952;6258.561900666909;6259.499240060875;6262.279837818709;6149.84625384369;6405.679716014088;6420.422162005442;6446.774362897464;6449.12936753551;6242.906356404566;6251.593646412968;6253.09330147117;6254.937450625435;6282.246130464374;6379.52153588492;6394.392532709385;6400.935990640221;6405.647689377129;6421.229452465734;5967.224260846062;6044.90932636002;6241;6249.687515624291;6276.403741644536 06:19:53 INFO - PROCESS | 24778 | |5;yui.html;729.4273994913993;749.9400047996161;799.3645052183514;825.0441457973695;838.748375487354;12969.481220751182;12973.15674481158;13002.284874331908;13067.411966461508;13074.15018023829;12168.634940951764;12250.326232057234;12261.509539618404;12535.49858005681;12695.047871409659;686.2931180883697;820.1921107708931;826.4793180296405;834.4951304460775;840.1052878684212;835.031363618203;839.102160688064;839.4501601451059;839.5046922315832;840.3487297344545;874.615169325498;875.6541166239332;877.0089798527687;877.1316396767219;877.7937184761576;709.684190535212;713.6396119959439;851.2041241439274;873.7990262239689;875.711015364928;635.3360738028725;636.2651137935645;639.3702203329716;639.7185238495048;640.1358166475268;12962.675933101653;13014.828665420064;13021;13023.41394637234;13031.934840325737;12722.427490762939;13170.27563484008;13171.143875648053;13314.400851961685;13343.199408035549;10611.257211995164;10639.734006649896;10799.298045627087;10984.340939543654;11067.391293478855;3610.4042832932537;3650.7809531428197;3686.7234957378037;3721.0697325668584;3724.962750372516;47887;48192.27711584329;48196.99999999965;48208;48268;9507.66723164686;9618.51907404627;9737.56180971858;9832.410055396698;10248.948755256177;17640.94154350743;17731;17747.73378399325;17767.822321776875;17773;7335.229800870832;7466.365358944442;7594.088709354803;7754.108277548042;7807.219278072147;4363.47638283408;4439.755813430293;4517.186906356887;4544.772761361919;4615;3011.141824579984;3035.8178509289514;3037.1951432870305;3038.3011907261453;3047.9542806857917;508.8626070960894;595.6217801695955;615.984600384994;623.7660877171061;641.8844607970517;593.1695626123376;636.6848410037061;661.6559389117632;665.5308007854451;672.515788632184;7477.7008919643695;7495.929924790955;7629.2370762923265;7958.2041795821115;7991.72028978983;505.1336957118559;579.9739011744482;632.8607706304606;645.3320812958565;673.0241150332038;3797.3924172132324;3813.809309534512;3828.272628200633;3850.441685955521;3853.306404847154;53282.46717532853;54433;54644.72677636586;54674.453255466935;55246.723766381714;47447.288290675664;47665.5233447668;48376.27435588469;50131.74934125379;51030.74484627553;44016.33975490306;44106.11787764291;44221.115577688906;44325.77837110794;44747.55252447434;7585;7797.805054873446;7820.257075577811;7973.44185906981;8124.537583235075;33867.66132338645;33943.3211335767;34207;34820.82589587036;34923.825380872935;38818.2236355277;39010.80494597509;41335.37996930109;42031.3695294577;42550;9824.901750982399;9857.260705446977;9948.651797187353;10026.799464010825;10075.798484030425;11785.941070294593;11827.994620457013;11929.582464613697;11969.16215864881;12848.293343866177;10397.428141452292;10519.579216831547;11410.714732131431;11495.48270327854;11681.06551475897;10856.782864342827;11115.610953616908;11191.776164476827;11467.139964502529;11775.646730598095;10368.481575921023;10435.426051567236;11035.779284414428;11108.444577770917;11457.770844583229;8254.339652827879;8276.462029968034;8354.832903342021;8575;8852.867206992029;8441.409101362846;8456.492610443393;8596.269317108116;8604.354673399645;9098.454092754457 06:19:53 INFO - PROCESS | 24778 | __end_tp_report 06:19:53 INFO - PROCESS | 24778 | __start_cc_report 06:19:53 INFO - PROCESS | 24778 | _x_x_mozilla_cycle_collect,749 06:19:53 INFO - PROCESS | 24778 | __end_cc_report 06:19:53 INFO - PROCESS | 24778 | __startTimestamp1456237193943__endTimestamp 06:19:53 INFO - PROCESS | 24778 | 06:19:53 INFO - PROCESS | 24778 | ------- Summary: start ------- 06:19:53 INFO - PROCESS | 24778 | Number of tests: 6 06:19:53 INFO - PROCESS | 24778 | 06:19:53 INFO - PROCESS | 24778 | [#0] dojo.html Cycles:165 Average:5054.08 Median:5205.53 stddev:537.83 (10.3%) stddev-sans-first:516.35 06:19:53 INFO - PROCESS | 24778 | Values: 3065.0 3127.0 3128.1 3155.8 3163.1 4940.9 5012.0 5025.3 5058.7 5059.9 5008.6 5049.1 5095.9 5106.2 5138.6 4520.1 4605.4 4614.7 4662.2 4721.3 4651.1 4656.6 4693.6 4711.2 4750.7 4560.9 4611.6 4667.3 4668.4 4700.6 4661.2 4670.4 4676.5 4677.6 4714.9 4534.9 4580.6 4650.8 4664.7 4692.2 4853.1 4913.1 4927.6 4935.1 4941.6 5459.0 5463.2 5471.6 5476.8 5499.1 5503.4 5516.1 5522.3 5522.6 5526.0 4989.9 5081.9 5112.3 5149.3 5163.7 5583.5 5600.6 5605.9 5610.6 5674.2 5242.1 5373.9 5378.8 5379.1 5390.8 5431.1 5447.2 5478.2 5483.0 5527.6 5372.6 5399.5 5399.7 5409.6 5445.9 5250.3 5389.3 5401.4 5411.1 5464.5 4226.1 4229.6 4233.5 4235.9 4262.3 3835.0 3836.8 3837.7 3848.4 3868.3 4919.7 5087.9 5154.7 5163.6 5180.2 5298.1 5299.6 5317.7 5324.4 5338.2 4979.5 4979.8 4983.3 4996.7 5022.5 4571.6 4694.6 4733.7 4737.2 4779.0 5654.1 5664.7 5672.3 5673.0 5731.9 5291.0 5387.2 5445.7 5449.2 5449.5 5561.3 5601.6 5609.8 5644.5 5646.4 5377.5 5394.6 5403.1 5410.2 5414.7 5364.1 5465.1 5489.6 5500.5 5550.3 5281.6 5313.4 5314.7 5321.4 5357.9 5258.1 5267.5 5279.9 5280.2 5329.9 5080.4 5134.3 5205.5 5217.7 5218.5 5302.6 5313.9 5328.4 5350.3 5372.2 5181.5 5184.9 5185.8 5190.0 5193.7 06:19:53 INFO - PROCESS | 24778 | 06:19:53 INFO - PROCESS | 24778 | [#1] ext.html Cycles:180 Average:43027.64 Median:32529.76 stddev:71939.18 (221.1%) stddev-sans-first:72070.21 06:19:53 INFO - PROCESS | 24778 | Values: 526.2 528.5 558.5 577.9 601.9 27788.6 35593.0 36181.5 36201.5 36208.0 39251.8 39572.8 39636.8 39644.6 39650.0 7453.9 7603.4 8395.4 8612.7 9855.1 9977.5 10112.2 10123.6 10132.3 10141.4 10036.4 10061.5 10117.1 10120.6 10131.0 9964.7 10050.3 10051.9 10056.0 10063.9 9972.9 10106.6 10107.8 10109.5 10429.7 39490.2 39901.4 39912.4 39948.0 39974.4 3025.4 3081.0 3178.6 3309.7 3730.8 26262.5 26787.5 26852.7 26904.2 27249.7 3746.6 3811.4 3834.1 3937.4 3959.4 211856.0 212404.0 214264.0 214701.0 215462.0 40958.4 41583.0 41606.4 41639.4 41751.4 38674.8 38695.0 38840.2 38857.0 38916.8 14614.5 14734.0 14752.6 14758.2 14759.2 11125.2 11200.5 11330.4 11486.5 11589.9 13810.2 13848.7 13895.4 13940.8 14112.8 5555.6 5721.8 5734.4 5734.8 5795.4 866.1 880.4 891.8 941.4 988.3 28082.6 28405.4 28483.4 28529.9 28716.4 898.5 1000.2 1029.9 1036.8 1039.2 13500.9 13889.0 13917.0 13987.4 14147.5 306148.0 307378.0 311345.0 312037.0 312166.4 50113.0 50487.7 50565.2 50602.7 50662.0 1312.7 1313.5 1337.9 1343.2 1356.5 25147.7 26429.6 26665.2 26722.2 26892.2 47234.0 48077.8 48182.5 48801.8 48811.5 289068.0 294190.0 294191.0 294326.0 294427.0 35883.0 41043.8 41651.6 42070.8 42269.2 38061.7 38167.8 38336.6 38692.0 38947.8 33033.7 33118.0 33147.5 34897.5 36683.4 28960.2 34723.1 35230.5 36368.6 36643.6 32025.8 32342.0 32501.0 32558.5 37105.6 28712.6 32425.8 34581.0 34740.5 35084.0 23645.2 23655.4 24744.3 25212.6 25226.2 06:19:53 INFO - PROCESS | 24778 | 06:19:53 INFO - PROCESS | 24778 | [#2] jquery.html Cycles:180 Average:22817.66 Median:211571.08 stddev:59411.78 (28.1%) stddev-sans-first:59554.52 06:19:53 INFO - PROCESS | 24778 | Values: 362.2 364.6 365.6 366.6 371.0 13336.8 16486.7 16504.4 16768.3 18047.5 15661.0 15958.3 16183.3 16184.7 16185.5 5374.9 5494.0 5521.8 5522.4 5543.4 4012.2 5234.3 5818.6 6098.4 6099.4 6030.1 6036.2 6044.3 6067.2 6070.7 5927.5 5950.1 6080.3 6080.8 6084.4 5319.6 5337.6 5338.2 5339.9 5341.3 19301.5 20128.6 20141.5 20268.6 20309.4 2242.5 2324.8 2577.5 2809.7 2966.9 12494.4 12580.8 12745.4 12778.6 13260.2 1813.6 1849.7 1864.0 1879.6 1894.9 62086.0 63396.4 64101.7 64186.0 64586.4 9538.0 9738.6 10015.3 10022.4 10093.9 12988.7 12999.3 13069.9 13073.7 13110.2 7779.6 7787.8 7815.9 7851.2 7861.6 7799.0 7828.3 7894.6 7899.8 7900.5 5898.8 5990.8 5992.0 6003.5 6047.5 1669.7 1677.8 1714.8 1720.5 1799.5 866.6 957.8 983.8 1086.3 1110.4 14172.9 15482.9 15501.5 16879.5 16912.8 895.5 901.5 934.8 942.4 1011.3 8704.4 9138.0 9174.6 9218.3 9271.4 228003.0 265397.0 360092.0 419130.0 465692.0 70821.6 72923.3 76231.2 80006.0 80185.6 438.3 451.5 452.3 452.3 453.0 9556.7 9851.5 10027.3 10046.0 10281.5 33509.0 33517.3 33687.5 34534.0 34582.7 45226.8 47972.5 49163.3 49487.0 49757.8 7645.2 7665.5 7733.0 8024.6 8061.8 10157.7 12045.5 12408.4 12502.4 12775.0 10094.8 10478.8 10511.4 10530.6 10702.1 10500.5 10612.0 10671.3 10752.0 11299.1 10774.1 11129.4 11184.7 11276.2 11287.7 7850.4 7901.9 7912.9 8004.0 8185.0 8008.7 8306.9 10897.5 11017.7 11107.8 06:19:53 INFO - PROCESS | 24778 | 06:19:53 INFO - PROCESS | 24778 | [#3] mootools.html Cycles:180 Average:5295.10 Median:5775.14 stddev:2702.82 (46.8%) stddev-sans-first:2693.85 06:19:53 INFO - PROCESS | 24778 | Values: 1315.8 1430.3 1433.5 1595.3 1794.1 7287.2 7416.4 7426.1 7445.9 7453.5 7413.5 7561.1 7584.3 7586.2 7589.4 1951.6 2158.6 2201.3 2277.3 2297.2 2215.9 2216.1 2228.3 2229.7 2229.7 2293.3 2297.8 2300.0 2301.7 2302.1 2230.2 2250.4 2258.6 2278.0 2279.2 2187.6 2191.2 2198.7 2251.9 2273.3 6355.6 6516.2 7654.5 7722.1 7729.2 4030.1 4448.4 4513.1 4514.3 4522.8 3124.8 3159.7 3216.6 3221.4 3259.1 1032.4 1047.2 1059.4 1088.2 1112.1 10285.7 10337.5 10351.5 10358.1 10659.7 4080.6 4163.6 4169.3 4182.8 4241.9 9131.5 9140.2 9162.3 9162.4 9167.1 4077.2 4519.9 4619.3 4657.3 4672.8 4134.0 4193.5 4202.0 4206.5 4215.4 3547.4 3566.4 3586.4 3594.6 3615.6 1096.5 1109.0 1116.4 1121.3 1127.1 1319.5 1338.0 1352.9 1359.5 1373.0 7176.3 7246.1 7293.9 7322.3 7334.5 1089.4 1099.5 1108.6 1123.0 1127.9 5670.7 5684.2 5744.2 5744.8 5748.8 8726.5 8777.9 8936.9 9104.2 9104.2 9058.4 9084.4 9129.9 9149.9 9216.8 7008.6 7120.4 7200.7 7253.7 7330.2 6988.9 7006.5 7009.8 7026.2 7068.3 7662.3 7818.2 7825.6 7896.2 7923.6 7776.8 8196.3 8204.3 8206.9 8254.9 5678.9 5801.4 6374.1 6549.3 6660.2 7117.8 7146.0 7156.0 7196.6 7218.1 6422.3 6646.0 6656.8 6701.8 6796.8 6283.3 6515.0 6527.1 6541.1 6586.6 6872.5 6902.7 6910.1 6912.5 6924.7 6322.0 6387.1 6387.4 6402.7 6415.4 6497.6 6509.6 6538.7 6540.2 6562.0 06:19:53 INFO - PROCESS | 24778 | 06:19:53 INFO - PROCESS | 24778 | [#4] prototype.html Cycles:180 Average:5245.69 Median:5973.79 stddev:1610.30 (27.0%) stddev-sans-first:1571.69 06:19:53 INFO - PROCESS | 24778 | Values: 313.6 315.3 317.9 322.5 326.8 5831.0 6084.5 6116.0 6119.1 6121.2 5868.9 5962.4 5977.3 5978.6 5983.8 4258.4 4406.4 4491.1 4501.4 4539.3 4503.2 4505.4 4523.4 4524.2 4532.5 4470.4 4470.8 4471.5 4475.9 4494.5 4265.6 4386.3 4473.6 4479.8 4485.3 3861.3 3866.5 3868.7 3869.2 3873.9 5623.1 5627.9 5630.5 5630.7 5631.4 5207.9 5210.8 5214.3 5216.3 5229.9 6284.3 6301.7 6307.7 6310.4 6314.0 4138.6 4266.7 4273.4 4304.7 4314.2 6518.7 6596.5 6620.7 6629.6 6644.3 4328.7 4334.8 4339.1 4339.7 4348.4 4375.2 4379.3 4389.4 4391.1 4393.4 5147.4 5161.1 5168.3 5173.5 5176.8 6150.4 6365.0 6378.6 6385.9 6386.6 1536.7 1546.4 1554.1 1554.6 1556.7 942.0 999.2 1030.1 1047.6 1075.4 5892.5 5954.2 5959.2 5972.3 5975.3 6420.4 6426.9 6436.1 6436.8 6443.6 5948.5 5965.0 5965.3 5966.4 5967.3 3439.0 3474.8 3478.0 3480.3 3481.4 6630.9 6794.8 6807.1 6826.0 6836.5 6625.3 6646.7 6649.9 6651.3 6651.5 6789.1 6795.0 6796.0 6804.4 6805.9 6407.6 6418.2 6425.7 6431.7 6435.7 6229.7 6328.5 6376.6 6391.6 6412.6 6724.7 6776.2 6776.9 6786.7 6799.9 4536.7 4538.4 4541.4 4541.6 4542.5 6418.3 6425.3 6428.5 6439.4 6439.9 6244.8 6251.5 6258.6 6259.5 6262.3 6149.8 6405.7 6420.4 6446.8 6449.1 6242.9 6251.6 6253.1 6254.9 6282.2 6379.5 6394.4 6400.9 6405.6 6421.2 5967.2 6044.9 6241.0 6249.7 6276.4 06:19:53 INFO - PROCESS | 24778 | 06:19:53 INFO - PROCESS | 24778 | [#5] yui.html Cycles:180 Average:13277.80 Median:48039.64 stddev:15256.26 (31.8%) stddev-sans-first:15269.96 06:19:53 INFO - PROCESS | 24778 | Values: 729.4 749.9 799.4 825.0 838.7 12969.5 12973.2 13002.3 13067.4 13074.2 12168.6 12250.3 12261.5 12535.5 12695.0 686.3 820.2 826.5 834.5 840.1 835.0 839.1 839.5 839.5 840.3 874.6 875.7 877.0 877.1 877.8 709.7 713.6 851.2 873.8 875.7 635.3 636.3 639.4 639.7 640.1 12962.7 13014.8 13021.0 13023.4 13031.9 12722.4 13170.3 13171.1 13314.4 13343.2 10611.3 10639.7 10799.3 10984.3 11067.4 3610.4 3650.8 3686.7 3721.1 3725.0 47887.0 48192.3 48197.0 48208.0 48268.0 9507.7 9618.5 9737.6 9832.4 10248.9 17640.9 17731.0 17747.7 17767.8 17773.0 7335.2 7466.4 7594.1 7754.1 7807.2 4363.5 4439.8 4517.2 4544.8 4615.0 3011.1 3035.8 3037.2 3038.3 3048.0 508.9 595.6 616.0 623.8 641.9 593.2 636.7 661.7 665.5 672.5 7477.7 7495.9 7629.2 7958.2 7991.7 505.1 580.0 632.9 645.3 673.0 3797.4 3813.8 3828.3 3850.4 3853.3 53282.5 54433.0 54644.7 54674.5 55246.7 47447.3 47665.5 48376.3 50131.7 51030.7 44016.3 44106.1 44221.1 44325.8 44747.6 7585.0 7797.8 7820.3 7973.4 8124.5 33867.7 33943.3 34207.0 34820.8 34923.8 38818.2 39010.8 41335.4 42031.4 42550.0 9824.9 9857.3 9948.7 10026.8 10075.8 11785.9 11828.0 11929.6 11969.2 12848.3 10397.4 10519.6 11410.7 11495.5 11681.1 10856.8 11115.6 11191.8 11467.1 11775.6 10368.5 10435.4 11035.8 11108.4 11457.8 8254.3 8276.5 8354.8 8575.0 8852.9 8441.4 8456.5 8596.3 8604.4 9098.5 06:19:53 INFO - PROCESS | 24778 | -------- Summary: end -------- 06:19:53 INFO - PROCESS | 24778 | 06:19:54 INFO - TEST-INFO | 24778: exit 0 06:19:54 INFO - TEST-OK | dromaeo_css | took 1112699ms 06:19:54 INFO - TEST-START | kraken 06:19:54 INFO - operating with platform_type : linux_ 06:19:54 INFO - Initialising browser for kraken test... 06:19:54 INFO - TEST-INFO | started process 24970 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBBRZvp/profile http://localhost:47199/getInfo.html) 06:19:58 INFO - PROCESS | 24970 | __metrics Screen width/height:1600/1200 06:19:58 INFO - PROCESS | 24970 | colorDepth:24 06:19:58 INFO - PROCESS | 24970 | Browser inner width/height: 1024/697 06:19:58 INFO - PROCESS | 24970 | __metrics 06:19:59 INFO - PROCESS | 24970 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:20:00 INFO - TEST-INFO | 24970: exit 0 06:20:00 INFO - Browser initialized. 06:20:00 INFO - Running cycle 1/1 for kraken test... 06:20:00 INFO - TEST-INFO | started process 25052 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBBRZvp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:20:12 INFO - PROCESS | 25052 | RSS: Main: 147775488 06:20:12 INFO - PROCESS | 25052 | 06:20:14 INFO - PROCESS | 25052 | Cycle 1(1): loaded http://localhost:47199/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47199/tests/kraken/driver.html?testName=audio-beat-detection) 06:20:15 INFO - PROCESS | 25052 | RSS: Main: 192389120 06:20:15 INFO - PROCESS | 25052 | 06:20:18 INFO - PROCESS | 25052 | Cycle 1(1): loaded http://localhost:47199/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47199/tests/kraken/driver.html?testName=audio-dft) 06:20:18 INFO - PROCESS | 25052 | RSS: Main: 181088256 06:20:18 INFO - PROCESS | 25052 | 06:20:21 INFO - PROCESS | 25052 | Cycle 1(1): loaded http://localhost:47199/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47199/tests/kraken/driver.html?testName=audio-fft) 06:20:22 INFO - PROCESS | 25052 | RSS: Main: 166412288 06:20:22 INFO - PROCESS | 25052 | 06:20:24 INFO - PROCESS | 25052 | Cycle 1(1): loaded http://localhost:47199/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47199/tests/kraken/driver.html?testName=audio-oscillator) 06:20:24 INFO - PROCESS | 25052 | RSS: Main: 166473728 06:20:24 INFO - PROCESS | 25052 | 06:20:26 INFO - PROCESS | 25052 | Cycle 1(1): loaded http://localhost:47199/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47199/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:20:27 INFO - PROCESS | 25052 | RSS: Main: 171466752 06:20:27 INFO - PROCESS | 25052 | 06:20:30 INFO - PROCESS | 25052 | Cycle 1(1): loaded http://localhost:47199/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47199/tests/kraken/driver.html?testName=imaging-darkroom) 06:20:31 INFO - PROCESS | 25052 | RSS: Main: 169717760 06:20:31 INFO - PROCESS | 25052 | 06:20:34 INFO - PROCESS | 25052 | Cycle 1(1): loaded http://localhost:47199/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47199/tests/kraken/driver.html?testName=imaging-desaturate) 06:20:34 INFO - PROCESS | 25052 | RSS: Main: 172548096 06:20:34 INFO - PROCESS | 25052 | 06:20:37 INFO - PROCESS | 25052 | Cycle 1(1): loaded http://localhost:47199/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47199/tests/kraken/driver.html?testName=json-parse-financial) 06:20:38 INFO - PROCESS | 25052 | RSS: Main: 169197568 06:20:38 INFO - PROCESS | 25052 | 06:20:39 INFO - PROCESS | 25052 | Cycle 1(1): loaded http://localhost:47199/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47199/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:20:40 INFO - PROCESS | 25052 | RSS: Main: 179998720 06:20:40 INFO - PROCESS | 25052 | 06:20:42 INFO - PROCESS | 25052 | Cycle 1(1): loaded http://localhost:47199/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47199/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:20:42 INFO - PROCESS | 25052 | RSS: Main: 177762304 06:20:42 INFO - PROCESS | 25052 | 06:20:44 INFO - PROCESS | 25052 | Cycle 1(1): loaded http://localhost:47199/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47199/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:20:45 INFO - PROCESS | 25052 | RSS: Main: 192626688 06:20:45 INFO - PROCESS | 25052 | 06:20:47 INFO - PROCESS | 25052 | Cycle 1(1): loaded http://localhost:47199/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47199/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:20:48 INFO - PROCESS | 25052 | RSS: Main: 196542464 06:20:48 INFO - PROCESS | 25052 | 06:20:51 INFO - PROCESS | 25052 | Cycle 1(1): loaded http://localhost:47199/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47199/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:20:51 INFO - PROCESS | 25052 | RSS: Main: 197091328 06:20:51 INFO - PROCESS | 25052 | 06:20:53 INFO - PROCESS | 25052 | Cycle 1(1): loaded http://localhost:47199/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47199/tests/kraken/driver.html?testName=ai-astar) 06:20:53 INFO - PROCESS | 25052 | RSS: Main: 258342912 06:20:53 INFO - PROCESS | 25052 | 06:20:53 INFO - PROCESS | 25052 | __start_tp_report 06:20:53 INFO - PROCESS | 25052 | _x_x_mozilla_page_load 06:20:53 INFO - PROCESS | 25052 | _x_x_mozilla_page_load_details 06:20:53 INFO - PROCESS | 25052 | |i|pagename|runs| 06:20:53 INFO - PROCESS | 25052 | |0;ai-astar;111;113;107;114;113;111;103;113;111;110 06:20:53 INFO - PROCESS | 25052 | |1;audio-beat-detection;152;124;152;185;125;156;153;126;165;126 06:20:53 INFO - PROCESS | 25052 | |2;audio-dft;163;162;162;160;161;161;160;163;161;161 06:20:53 INFO - PROCESS | 25052 | |3;audio-fft;74;75;102;96;73;73;73;105;91;72 06:20:53 INFO - PROCESS | 25052 | |4;audio-oscillator;96;96;140;96;96;96;140;96;96;140 06:20:53 INFO - PROCESS | 25052 | |5;imaging-gaussian-blur;119;115;115;115;115;115;115;115;114;115 06:20:53 INFO - PROCESS | 25052 | |6;imaging-darkroom;145;145;145;147;146;145;144;145;146;145 06:20:53 INFO - PROCESS | 25052 | |7;imaging-desaturate;96;96;96;95;96;97;96;96;96;95 06:20:53 INFO - PROCESS | 25052 | |8;json-parse-financial;57;58;58;56;56;57;57;66;54;58 06:20:53 INFO - PROCESS | 25052 | |9;json-stringify-tinderbox;67;68;68;68;67;67;70;67;68;67 06:20:53 INFO - PROCESS | 25052 | |10;stanford-crypto-aes;84;85;85;84;84;83;83;82;82;83 06:20:53 INFO - PROCESS | 25052 | |11;stanford-crypto-ccm;125;114;116;115;113;114;125;115;118;119 06:20:53 INFO - PROCESS | 25052 | |12;stanford-crypto-pbkdf2;154;140;142;149;152;138;151;143;155;150 06:20:53 INFO - PROCESS | 25052 | |13;stanford-crypto-sha256-iterative;71;71;68;68;70;70;68;68;68;68 06:20:53 INFO - PROCESS | 25052 | __end_tp_report 06:20:53 INFO - PROCESS | 25052 | __start_cc_report 06:20:53 INFO - PROCESS | 25052 | _x_x_mozilla_cycle_collect,961 06:20:53 INFO - PROCESS | 25052 | __end_cc_report 06:20:53 INFO - PROCESS | 25052 | __startTimestamp1456237253572__endTimestamp 06:20:53 INFO - PROCESS | 25052 | 06:20:53 INFO - PROCESS | 25052 | ------- Summary: start ------- 06:20:53 INFO - PROCESS | 25052 | Number of tests: 14 06:20:53 INFO - PROCESS | 25052 | 06:20:53 INFO - PROCESS | 25052 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:3.34 (3.0%) stddev-sans-first:3.54 06:20:53 INFO - PROCESS | 25052 | Values: 111.0 113.0 107.0 114.0 113.0 111.0 103.0 113.0 111.0 110.0 06:20:53 INFO - PROCESS | 25052 | 06:20:53 INFO - PROCESS | 25052 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:152.50 stddev:20.62 (13.5%) stddev-sans-first:21.77 06:20:53 INFO - PROCESS | 25052 | Values: 152.0 124.0 152.0 185.0 125.0 156.0 153.0 126.0 165.0 126.0 06:20:53 INFO - PROCESS | 25052 | 06:20:53 INFO - PROCESS | 25052 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:0.97 06:20:53 INFO - PROCESS | 25052 | Values: 163.0 162.0 162.0 160.0 161.0 161.0 160.0 163.0 161.0 161.0 06:20:53 INFO - PROCESS | 25052 | 06:20:53 INFO - PROCESS | 25052 | [#3] audio-fft Cycles:10 Average:83.40 Median:73.50 stddev:13.51 (18.4%) stddev-sans-first:13.89 06:20:53 INFO - PROCESS | 25052 | Values: 74.0 75.0 102.0 96.0 73.0 73.0 73.0 105.0 91.0 72.0 06:20:53 INFO - PROCESS | 25052 | 06:20:53 INFO - PROCESS | 25052 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:96.00 stddev:21.25 (22.1%) stddev-sans-first:22.00 06:20:53 INFO - PROCESS | 25052 | Values: 96.0 96.0 140.0 96.0 96.0 96.0 140.0 96.0 96.0 140.0 06:20:53 INFO - PROCESS | 25052 | 06:20:53 INFO - PROCESS | 25052 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.00 stddev:1.34 (1.2%) stddev-sans-first:0.33 06:20:53 INFO - PROCESS | 25052 | Values: 119.0 115.0 115.0 115.0 115.0 115.0 115.0 115.0 114.0 115.0 06:20:53 INFO - PROCESS | 25052 | 06:20:53 INFO - PROCESS | 25052 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 06:20:53 INFO - PROCESS | 25052 | Values: 145.0 145.0 145.0 147.0 146.0 145.0 144.0 145.0 146.0 145.0 06:20:53 INFO - PROCESS | 25052 | 06:20:53 INFO - PROCESS | 25052 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 06:20:53 INFO - PROCESS | 25052 | Values: 96.0 96.0 96.0 95.0 96.0 97.0 96.0 96.0 96.0 95.0 06:20:53 INFO - PROCESS | 25052 | 06:20:53 INFO - PROCESS | 25052 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.50 stddev:3.16 (5.5%) stddev-sans-first:3.35 06:20:53 INFO - PROCESS | 25052 | Values: 57.0 58.0 58.0 56.0 56.0 57.0 57.0 66.0 54.0 58.0 06:20:53 INFO - PROCESS | 25052 | 06:20:53 INFO - PROCESS | 25052 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.95 (1.4%) stddev-sans-first:0.97 06:20:53 INFO - PROCESS | 25052 | Values: 67.0 68.0 68.0 68.0 67.0 67.0 70.0 67.0 68.0 67.0 06:20:53 INFO - PROCESS | 25052 | 06:20:53 INFO - PROCESS | 25052 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:84.00 stddev:1.08 (1.3%) stddev-sans-first:1.13 06:20:53 INFO - PROCESS | 25052 | Values: 84.0 85.0 85.0 84.0 84.0 83.0 83.0 82.0 82.0 83.0 06:20:53 INFO - PROCESS | 25052 | 06:20:53 INFO - PROCESS | 25052 | [#11] stanford-crypto-ccm Cycles:10 Average:117.40 Median:117.00 stddev:4.40 (3.8%) stddev-sans-first:3.71 06:20:53 INFO - PROCESS | 25052 | Values: 125.0 114.0 116.0 115.0 113.0 114.0 125.0 115.0 118.0 119.0 06:20:53 INFO - PROCESS | 25052 | 06:20:53 INFO - PROCESS | 25052 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.40 Median:150.50 stddev:6.11 (4.1%) stddev-sans-first:6.00 06:20:53 INFO - PROCESS | 25052 | Values: 154.0 140.0 142.0 149.0 152.0 138.0 151.0 143.0 155.0 150.0 06:20:53 INFO - PROCESS | 25052 | 06:20:53 INFO - PROCESS | 25052 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.33 (1.9%) stddev-sans-first:1.20 06:20:53 INFO - PROCESS | 25052 | Values: 71.0 71.0 68.0 68.0 70.0 70.0 68.0 68.0 68.0 68.0 06:20:53 INFO - PROCESS | 25052 | -------- Summary: end -------- 06:20:53 INFO - PROCESS | 25052 | 06:20:54 INFO - TEST-INFO | 25052: exit 0 06:20:54 INFO - TEST-OK | kraken | took 59998ms 06:20:54 INFO - SUITE-END | took 1172s 06:20:54 INFO - Completed test suite (00:19:32) 06:20:54 INFO - Working with test: dromaeo_css 06:20:54 INFO - Generating results file: dromaeo_css 06:20:54 INFO - Working with test: kraken 06:20:54 INFO - Generating results file: kraken 06:20:54 INFO - javascript benchmark 06:20:54 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:20:54 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 06:20:54 INFO - process_Request line: dromaeo_css 6718.49 graph.html#tests=[[72,1,35]] 06:20:54 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:20:54 INFO - process_Request line: kraken 1510.20 graph.html#tests=[[232,1,35]] 06:20:54 INFO - RETURN: dromaeo_css: 6718.49 06:20:54 INFO - RETURN: kraken: 1510.20 06:20:54 INFO - javascript benchmark 06:20:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3065.0, 3126.9530957035636, 3128.092853072609, 3155.8422078896056, 3163.066895265896, 4940.876478088041, 5011.974940125294, 5025.271335656327, 5058.6964782113055, 5059.924101138486, 5008.649394542384, 5049.116404629184, 5095.872603184922, 5106.234064890268, 5138.588912886969, 4520.073384956077, 4605.447346318447, 4614.653900957442, 4662.184117779392, 4721.268203428474, 4651.139539185245, 4656.627469802408, 4693.577578017977, 4711.222648263032, 4750.691205071659, 4560.901985086847, 4611.5619016193405, 4667.253239481666, 4668.393108895856, 4700.576948074656, 4661.207594708908, 4670.369500117508, 4676.50896655853, 4677.6257899367965, 4714.9391386938005, 4534.863954081383, 4580.564846339593, 4650.813967441299, 4664.65015123867, 4692.2257827458425, 4853.077915196137, 4913.115639184945, 4927.605791536705, 4935.136351138536, 4941.629377796679, 5458.972705136489, 5463.153211252262, 5471.644343117685, 5476.808311709071, 5499.092649712793, 5503.422140675211, 5516.14499752539, 5522.337319521643, 5522.6134170608075, 5526.0, 4989.875253118665, 5081.949180508184, 5112.284280200774, 5149.330587023663, 5163.664361816507, 5583.469570390806, 5600.607957443021, 5605.915911261334, 5610.607257491936, 5674.205611214434, 5242.1088414969545, 5373.892522149535, 5378.784848606012, 5379.112446446293, 5390.784368625211, 5431.103867861838, 5447.237386765856, 5478.233047373371, 5482.972585137129, 5527.55779537636, 5372.57019438444, 5399.541039011649, 5399.676019438846, 5409.621326507186, 5445.918311225335, 5250.343707036621, 5389.326334208224, 5401.378841433286, 5411.053065713484, 5464.508194262536, 4226.091390351089, 4229.619334259932, 4233.470816147981, 4235.851745188966, 4262.296721041055, 3834.9616503835164, 3836.76979381238, 3837.654611085016, 3848.4034974578985, 3868.303705333011, 4919.680220785637, 5087.923681144785, 5154.690718556899, 5163.638545301793, 5180.197069454241, 5298.072837253465, 5299.5760339172775, 5317.654352467077, 5324.387695415076, 5338.172583249602, 4979.502049794992, 4979.800807967713, 4983.302337672729, 4996.657587276861, 5022.522860328263, 4571.588557029817, 4694.6009589185305, 4733.692309999839, 4737.194676904865, 4779.0, 5654.095344744821, 5664.716764161775, 5672.262605861211, 5672.971635141798, 5731.856703582361, 5291.0, 5387.191921211849, 5445.700486473282, 5449.2371068049715, 5449.536789372948, 5561.332640083216, 5601.551875849841, 5609.775608975595, 5644.520215781705, 5646.407127251744, 5377.516023557742, 5394.649347792381, 5403.108487099585, 5410.242566040679, 5414.7021913795115, 5364.088105022233, 5465.098258787415, 5489.58828087887, 5500.532454741392, 5550.250716153268, 5281.577473802164, 5313.442088580643, 5314.681119132864, 5321.414644389037, 5357.946420535744, 5258.132408152612, 5267.499587539178, 5279.920801188062, 5280.234366016829, 5329.9467005331, 5080.390353157644, 5134.255532947776, 5205.531502164823, 5217.686938783685, 5218.530332269962, 5302.575793936398, 5313.946860531345, 5328.387235467816, 5350.250964864844, 5372.247885295984, 5181.53366197044, 5184.870378240575, 5185.818496352609, 5190.039842629126, 5193.688378697139], "unit": "score", "name": "dojo.html", "value": 5021.124158746116}, {"lowerIsBetter": false, "replicates": [526.202802753828, 528.5216878724756, 558.511302610216, 577.8959787238297, 601.8796240751849, 27788.583171252423, 35593.0, 36181.45727814085, 36201.45697814535, 36208.0, 39251.803740981326, 39572.802135989354, 39636.80181599088, 39644.60355396445, 39650.0, 7453.888191677129, 7603.429742769286, 8395.370347223952, 8612.698555550556, 9855.063768941975, 9977.50112494376, 10112.241581881388, 10123.595056197742, 10132.341397809156, 10141.391516509033, 10036.44799536029, 10061.49692515375, 10117.140043096346, 10120.645777397793, 10131.0, 9964.651237206699, 10050.296479246455, 10051.899481005206, 10056.044675755791, 10063.899361006406, 9972.900270997343, 10106.64626738068, 10107.848382274271, 10109.545070471846, 10429.687109386654, 39490.210195795924, 39901.40147897784, 39912.40131398002, 39948.0, 39974.400383993976, 3025.4251692178414, 3080.9832755190732, 3178.618565772122, 3309.6855798699085, 3730.794806285653, 26262.474750504884, 26787.46425071488, 26852.73147268522, 26904.192874213804, 27249.727502724916, 3746.6253374662588, 3811.428285757131, 3834.0989867381145, 3937.4093885917055, 3959.3862951242604, 211855.99999999846, 212404.0, 214264.0, 214700.99999999843, 215462.0, 40958.38562421566, 41583.0, 41606.375904361455, 41639.375409368884, 41751.37372939409, 38674.806625967256, 38695.0, 38840.22319553593, 38857.0, 38916.80541597274, 14614.488492902698, 14734.0, 14752.63118422048, 14758.188299643623, 14759.188244646433, 11125.221234513507, 11200.495977681025, 11330.433478326051, 11486.483108260149, 11589.884101159048, 13810.171389716648, 13848.723025539633, 13895.374708138159, 13940.790888136686, 14112.788308175386, 5555.583331250092, 5721.799737009184, 5734.426557344315, 5734.799282025109, 5795.362510123883, 866.1079088538816, 880.4145243413059, 891.8171774786153, 941.3598752847992, 988.2637435110888, 28082.578761318597, 28405.431891362055, 28483.430331393258, 28529.85735071353, 28716.42567148687, 898.4654130792168, 1000.2248257600418, 1029.9485025748684, 1036.7926414717087, 1039.210200247817, 13500.93249533746, 13889.0, 13917.02580819333, 13987.37056832445, 14147.50483733085, 306148.0, 307378.0, 311345.0, 312037.0, 312166.4391678027, 50113.0, 50487.747561262695, 50565.24152137721, 50602.746986264836, 50662.0, 1312.7177656803833, 1313.4614807928704, 1337.9397927093305, 1343.1605246720603, 1356.4574170331946, 25147.74852251454, 26429.60355594629, 26665.20004399871, 26722.19833405001, 26892.193234203005, 47234.0, 48077.75961120172, 48182.5181748178, 48801.75599121982, 48811.511884882115, 289068.0, 294190.0, 294191.0, 294326.0, 294427.0, 35883.0, 41043.79478102591, 41651.583484164774, 42070.78964605158, 42269.154616906875, 38061.66876002208, 38167.80916095402, 38336.61663383442, 38692.0, 38947.80526097352, 33033.66966330306, 33118.0, 33147.50278745773, 34897.47653785246, 36683.44974825326, 28960.234110872632, 34723.13192170216, 35230.47154292637, 36368.63631363758, 36643.63356366402, 32025.83987080143, 32342.0, 32501.0, 32558.511622326158, 37105.628943711294, 28712.569311459927, 32425.837870810494, 34581.0, 34740.47889281612, 35084.0, 23645.172418965252, 23655.40861478408, 24744.25767226986, 25212.62181067249, 25226.243212703648], "unit": "score", "name": "ext.html", "value": 17505.630752977126}, {"lowerIsBetter": false, "replicates": [362.1543695471075, 364.6135096797395, 365.63984475291835, 366.58392724257976, 371.0279068839641, 13336.799948000764, 16486.67026659466, 16504.42234521792, 16768.32926682933, 18047.548811279725, 15661.0, 15958.28187731552, 16183.271752771125, 16184.676306473893, 16185.514434566981, 5374.946250537503, 5494.038543254935, 5521.751521181556, 5522.3649280332875, 5543.417941116185, 4012.1574469361467, 5234.319538459995, 5818.621789583684, 6098.3596722343955, 6099.390060993887, 6030.125631783389, 6036.15493830864, 6044.274687037561, 6067.150598916155, 6070.72681729321, 5927.525797936176, 5950.077737950624, 6080.2703675559, 6080.817575472743, 6084.361142080106, 5319.601029922733, 5337.599680024014, 5338.172583249602, 5339.893202135974, 5341.332333458317, 19301.51746206342, 20128.597428051504, 20141.49646258855, 20268.594628107356, 20309.390718278326, 2242.5232620693805, 2324.755900630443, 2577.536043512167, 2809.7190280971945, 2966.9406611867857, 12494.375281235993, 12580.81128783069, 12745.362731863463, 12778.552750653775, 13260.204387736767, 1813.610073834132, 1849.713294439364, 1864.0307040339083, 1879.5583037986062, 1894.8957807320592, 62086.0, 63396.366036339045, 64101.67949160271, 64186.0, 64586.3541364585, 9537.952310238543, 9738.610455581698, 10015.349002314826, 10022.448765317831, 10093.899061009295, 12988.740225195443, 12999.285039322738, 13069.869301307055, 13073.738525229443, 13110.213387196607, 7779.649915753805, 7787.844243115106, 7815.882761758578, 7851.214878512217, 7861.606919653995, 7799.0, 7828.334591559667, 7894.565798881116, 7899.802504937423, 7900.525968441912, 5898.793542226002, 5990.790322338785, 5992.0, 6003.519718422515, 6047.455728984412, 1669.7161482547997, 1677.7818883545306, 1714.7942246930447, 1720.5096547483906, 1799.5411170151528, 866.5580553917547, 957.7844984878486, 983.8229118758692, 1086.2939089591828, 1110.4392281897751, 14172.85827141736, 15482.922585387001, 15501.457448989457, 16879.493615191564, 16912.830871691127, 895.4671970177734, 901.5492253873064, 934.8317302885409, 942.3686130292721, 1011.2870426349406, 8704.390692651581, 9138.0, 9174.587143578421, 9218.262538996863, 9271.35100542969, 228003.0, 265397.0, 360092.0, 419130.0, 465692.0, 70821.64589177021, 72923.2707672927, 76231.23768762352, 80006.0, 80185.59907200426, 438.2680922858833, 451.52589780730756, 452.298936648194, 452.31925951442867, 453.0146930426244, 9556.665516706882, 9851.45816980073, 10027.348222365523, 10045.999261617035, 10281.53733082028, 33509.0, 33517.32965340728, 33687.4946875802, 34534.0, 34582.654173457944, 45226.77386613046, 47972.520274798204, 49163.262551061045, 49487.0, 49757.75121124371, 7645.159032506531, 7665.501742386727, 7733.0, 8024.598770061591, 8061.798455038671, 10157.695269141937, 12045.518179273082, 12408.441620126936, 12502.374881255719, 12775.0, 10094.8485772712, 10478.842817357898, 10511.369317840954, 10530.57877684884, 10702.090322322378, 10500.527476263434, 10612.0, 10671.306365086244, 10752.0323170915, 11299.09607231436, 10774.084202842847, 11129.443527823738, 11184.720381990515, 11276.154288428565, 11287.661370158909, 7850.4112191587, 7901.881471777813, 7912.881306780518, 8003.998500562289, 8185.0, 8008.719694810654, 8306.916930830614, 10897.509612067635, 11017.724556886142, 11107.833382499108], "unit": "score", "name": "jquery.html", "value": 8220.013439069548}, {"lowerIsBetter": false, "replicates": [1315.7565850317699, 1430.2562667412944, 1433.4552869909433, 1595.266177558323, 1794.0581194872698, 7287.198408175096, 7416.406687465003, 7426.071741032371, 7445.8883116753295, 7453.5155214911065, 7413.518121322124, 7561.130469995952, 7584.279493448127, 7586.203448637896, 7589.354904833096, 1951.5706544560173, 2158.643823769084, 2201.2515744646817, 2277.3168049585142, 2297.1844995026777, 2215.8559693619945, 2216.091402524965, 2228.3092241405216, 2229.665550167472, 2229.6655501674795, 2293.289080385078, 2297.8161747060194, 2300.0454811253394, 2301.7122859642545, 2302.1482051640915, 2230.1971290335546, 2250.437390652337, 2258.5934531784274, 2277.9772202278095, 2279.2022792022826, 2187.57342318248, 2191.2002119226368, 2198.703175071361, 2251.898664560099, 2273.283915566591, 6355.586886852339, 6516.218053833523, 7654.502457340255, 7722.1119571249465, 7729.188435214278, 4030.0932290234464, 4448.4439445069365, 4513.097380523908, 4514.255147900625, 4522.796474158671, 3124.7812653114293, 3159.668234835332, 3216.5979252593424, 3221.4201443740117, 3259.103746469716, 1032.3805716569998, 1047.245982892324, 1059.3961441978076, 1088.2491081154058, 1112.1436493899732, 10285.742856428575, 10337.483125843753, 10351.482425878676, 10358.119559837423, 10659.680209593647, 4080.5511393746665, 4163.646090082377, 4169.332906734908, 4182.811773470201, 4241.851535196253, 9131.497767622712, 9140.223081038186, 9162.267018638493, 9162.358634895627, 9167.083291670913, 4077.245709543744, 4519.932201016987, 4619.3071039343695, 4657.3246879202325, 4672.789724462407, 4134.0, 4193.5387107418155, 4202.033532287591, 4206.453161089039, 4215.388768628532, 3547.396942519778, 3566.375884220251, 3586.444101164324, 3594.6225646307284, 3615.620359862229, 1096.5010920031525, 1108.9611863584735, 1116.4473585575192, 1121.3216004317433, 1127.1321082766224, 1319.4656164253493, 1337.9732405352033, 1352.9391177396844, 1359.4766015084265, 1372.9519466818613, 7176.282371762782, 7246.094238220223, 7293.8905916411295, 7322.304381083789, 7334.48658593904, 1089.4117176724637, 1099.4942326529726, 1108.6009036746764, 1122.960696375623, 1127.875933647298, 5670.716464176775, 5684.232628595169, 5744.195812586241, 5744.827655170351, 5748.827535173951, 8726.520041397656, 8777.912220877837, 8936.910630893737, 9104.226140777975, 9104.226140778108, 9058.365914386062, 9084.40951338174, 9129.863052054225, 9149.862752058725, 9216.815663686823, 7008.614526201108, 7120.394766444807, 7200.747973820996, 7253.746118885813, 7330.230325815819, 6988.8951665724035, 7006.509544331848, 7009.824754381181, 7026.156861176692, 7068.3285087916565, 7662.310392064741, 7818.218178182136, 7825.569593672402, 7896.249856263646, 7923.564203968837, 7776.805579860323, 8196.303314218358, 8204.302634276153, 8206.917930820615, 8254.917450825415, 5678.858028549154, 5801.448862358069, 6374.107624932421, 6549.345065493412, 6660.234073081464, 7117.786466406016, 7146.0, 7156.0, 7196.6041867695685, 7218.061651985208, 6422.2614399344675, 6646.0, 6656.7670131545165, 6701.832454188684, 6796.796096117125, 6283.3088360281245, 6515.0, 6527.05357723137, 6541.116949211986, 6586.571872828251, 6872.484563657646, 6902.723891044503, 6910.101686780687, 6912.516123871281, 6924.723011079501, 6322.0, 6387.105805187371, 6387.361263873761, 6402.711877965409, 6415.358464153547, 6497.610143391412, 6509.641969691523, 6538.738450462119, 6540.247871494839, 6562.048502967138], "unit": "score", "name": "mootools.html", "value": 4392.999688636886}, {"lowerIsBetter": false, "replicates": [313.64244760972497, 315.2654315445013, 317.8871500617281, 322.4566605270119, 326.82024886312524, 5831.0, 6084.482818960388, 6115.969420152893, 6119.143319935212, 6121.204243448346, 5868.9413105868925, 5962.403759624046, 5977.282726072877, 5978.581499295051, 5983.790567330145, 4258.403823464718, 4406.427164468614, 4491.101779644068, 4501.414816073906, 4539.296409056585, 4503.189425903336, 4505.414296141514, 4523.389342438762, 4524.208263553882, 4532.546745325474, 4470.374147619336, 4470.75410852403, 4471.5081341052455, 4475.932861007072, 4494.460664720238, 4265.552117027714, 4386.34204869269, 4473.642108631302, 4479.753613551254, 4485.327200919855, 3861.343571592836, 3866.4586957825927, 3868.709846761504, 3869.2068126034096, 3873.9418908716393, 5623.0721930881355, 5627.887442251173, 5630.5495560355075, 5630.718464076821, 5631.352394474647, 5207.869803254911, 5210.817621383233, 5214.348206474191, 5216.3218781558535, 5229.921551176735, 6284.308726040132, 6301.6534090625, 6307.653079080649, 6310.368963103699, 6313.968430157865, 4138.627523522868, 4266.658667306608, 4273.423087883127, 4304.74171549708, 4314.180305741899, 6518.706658200345, 6596.472282217411, 6620.735170593171, 6629.569078009914, 6644.335566443366, 4328.718633288826, 4334.829596009123, 4339.1104823511105, 4339.696221264481, 4348.412964249849, 4375.234333991539, 4379.299312110047, 4389.429374181336, 4391.077873646506, 4393.384926110347, 5147.378575748628, 5161.096808058574, 5168.302279192336, 5173.4826517347965, 5176.767045482887, 6150.446459818549, 6365.0452432134625, 6378.585391949508, 6385.904211436832, 6386.648734319564, 1536.7464368379315, 1546.4278217059534, 1554.114154931678, 1554.572492564531, 1556.657535342223, 941.9858702119474, 999.205631522941, 1030.062642994871, 1047.5966752800075, 1075.3977772447454, 5892.5285977122585, 5954.196183515257, 5959.195508606283, 5972.297895099876, 5975.282966044103, 6420.422162005349, 6426.8714625707225, 6436.131122298523, 6436.809190299716, 6443.613383197023, 5948.494377977834, 5965.045592705146, 5965.284165900033, 5966.433188847052, 5967.343592204854, 3439.0, 3474.8436320365645, 3477.982610086984, 3480.3387356402204, 3481.3907566175817, 6630.900536491957, 6794.830129246809, 6807.0810440589885, 6826.0, 6836.4530837532875, 6625.271220165778, 6646.734130634721, 6649.867002659919, 6651.268360480343, 6651.467882569383, 6789.0834737310815, 6795.048693182958, 6795.966020169966, 6804.387605115563, 6805.897911531331, 6407.615543067431, 6418.19772528434, 6425.678716064272, 6431.710573024318, 6435.710393032231, 6229.660622966055, 6328.525360598066, 6376.649284289409, 6391.616503009835, 6412.551121421456, 6724.731010759515, 6776.186857577122, 6776.898346524905, 6786.660666966533, 6799.864002720017, 4536.65975051879, 4538.364628952016, 4541.43232095988, 4541.568550987651, 4542.454905411372, 6418.261899881573, 6425.293217745951, 6428.517861160338, 6439.35986245637, 6439.871202576016, 6244.781432649836, 6251.530645394952, 6258.561900666909, 6259.499240060875, 6262.279837818709, 6149.84625384369, 6405.679716014088, 6420.422162005442, 6446.774362897464, 6449.12936753551, 6242.906356404566, 6251.593646412968, 6253.09330147117, 6254.937450625435, 6282.246130464374, 6379.52153588492, 6394.392532709385, 6400.935990640221, 6405.647689377129, 6421.229452465734, 5967.224260846062, 6044.90932636002, 6241.0, 6249.687515624291, 6276.403741644536], "unit": "score", "name": "prototype.html", "value": 4713.672543094763}, {"lowerIsBetter": false, "replicates": [729.4273994913993, 749.9400047996161, 799.3645052183514, 825.0441457973695, 838.748375487354, 12969.481220751182, 12973.15674481158, 13002.284874331908, 13067.411966461508, 13074.15018023829, 12168.634940951764, 12250.326232057234, 12261.509539618404, 12535.49858005681, 12695.047871409659, 686.2931180883697, 820.1921107708931, 826.4793180296405, 834.4951304460775, 840.1052878684212, 835.031363618203, 839.102160688064, 839.4501601451059, 839.5046922315832, 840.3487297344545, 874.615169325498, 875.6541166239332, 877.0089798527687, 877.1316396767219, 877.7937184761576, 709.684190535212, 713.6396119959439, 851.2041241439274, 873.7990262239689, 875.711015364928, 635.3360738028725, 636.2651137935645, 639.3702203329716, 639.7185238495048, 640.1358166475268, 12962.675933101653, 13014.828665420064, 13021.0, 13023.41394637234, 13031.934840325737, 12722.427490762939, 13170.27563484008, 13171.143875648053, 13314.400851961685, 13343.199408035549, 10611.257211995164, 10639.734006649896, 10799.298045627087, 10984.340939543654, 11067.391293478855, 3610.4042832932537, 3650.7809531428197, 3686.7234957378037, 3721.0697325668584, 3724.962750372516, 47887.0, 48192.27711584329, 48196.99999999965, 48208.0, 48268.0, 9507.66723164686, 9618.51907404627, 9737.56180971858, 9832.410055396698, 10248.948755256177, 17640.94154350743, 17731.0, 17747.73378399325, 17767.822321776875, 17773.0, 7335.229800870832, 7466.365358944442, 7594.088709354803, 7754.108277548042, 7807.219278072147, 4363.47638283408, 4439.755813430293, 4517.186906356887, 4544.772761361919, 4615.0, 3011.141824579984, 3035.8178509289514, 3037.1951432870305, 3038.3011907261453, 3047.9542806857917, 508.8626070960894, 595.6217801695955, 615.984600384994, 623.7660877171061, 641.8844607970517, 593.1695626123376, 636.6848410037061, 661.6559389117632, 665.5308007854451, 672.515788632184, 7477.7008919643695, 7495.929924790955, 7629.2370762923265, 7958.2041795821115, 7991.72028978983, 505.1336957118559, 579.9739011744482, 632.8607706304606, 645.3320812958565, 673.0241150332038, 3797.3924172132324, 3813.809309534512, 3828.272628200633, 3850.441685955521, 3853.306404847154, 53282.46717532853, 54433.0, 54644.72677636586, 54674.453255466935, 55246.723766381714, 47447.288290675664, 47665.5233447668, 48376.27435588469, 50131.74934125379, 51030.74484627553, 44016.33975490306, 44106.11787764291, 44221.115577688906, 44325.77837110794, 44747.55252447434, 7585.0, 7797.805054873446, 7820.257075577811, 7973.44185906981, 8124.537583235075, 33867.66132338645, 33943.3211335767, 34207.0, 34820.82589587036, 34923.825380872935, 38818.2236355277, 39010.80494597509, 41335.37996930109, 42031.3695294577, 42550.0, 9824.901750982399, 9857.260705446977, 9948.651797187353, 10026.799464010825, 10075.798484030425, 11785.941070294593, 11827.994620457013, 11929.582464613697, 11969.16215864881, 12848.293343866177, 10397.428141452292, 10519.579216831547, 11410.714732131431, 11495.48270327854, 11681.06551475897, 10856.782864342827, 11115.610953616908, 11191.776164476827, 11467.139964502529, 11775.646730598095, 10368.481575921023, 10435.426051567236, 11035.779284414428, 11108.444577770917, 11457.770844583229, 8254.339652827879, 8276.462029968034, 8354.832903342021, 8575.0, 8852.867206992029, 8441.409101362846, 8456.492610443393, 8596.269317108116, 8604.354673399645, 9098.454092754457], "unit": "score", "name": "yui.html", "value": 6146.43293058904}], "name": "dromaeo_css", "value": 6718.497371955711}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 107.0, 114.0, 113.0, 111.0, 103.0, 113.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.6}, {"lowerIsBetter": true, "replicates": [152.0, 124.0, 152.0, 185.0, 125.0, 156.0, 153.0, 126.0, 165.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 146.4}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 162.0, 160.0, 161.0, 161.0, 160.0, 163.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 102.0, 96.0, 73.0, 73.0, 73.0, 105.0, 91.0, 72.0], "unit": "score", "name": "audio-fft", "value": 83.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 140.0, 96.0, 96.0, 96.0, 140.0, 96.0, 96.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 114.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.3}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 147.0, 146.0, 145.0, 144.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 97.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 58.0, 56.0, 56.0, 57.0, 57.0, 66.0, 54.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 57.7}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 67.0, 67.0, 70.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 85.0, 84.0, 84.0, 83.0, 83.0, 82.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.5}, {"lowerIsBetter": true, "replicates": [125.0, 114.0, 116.0, 115.0, 113.0, 114.0, 125.0, 115.0, 118.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.4}, {"lowerIsBetter": true, "replicates": [154.0, 140.0, 142.0, 149.0, 152.0, 138.0, 151.0, 143.0, 155.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.4}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 68.0, 68.0, 70.0, 70.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1510.2}]} 06:20:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1510.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6718.49"}}} 06:20:54 INFO - Return code: 0 06:20:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:20:54 INFO - # TBPL SUCCESS # 06:20:54 INFO - Running post-action listener: _resource_record_post_action 06:20:54 INFO - Running post-run listener: _resource_record_post_run 06:20:56 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 539213824; Read time: 0; Write time: 354584 06:20:56 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 240709632; Read time: 0; Write time: 196568 06:20:56 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 298504192; Read time: 0; Write time: 158016 06:20:56 INFO - Running post-run listener: _upload_blobber_files 06:20:56 INFO - Blob upload gear active. 06:20:56 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:20:56 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:20:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 06:20:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 06:20:56 INFO - (blobuploader) - INFO - Open directory for files ... 06:20:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 06:20:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:20:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:20:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:20:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:20:57 INFO - (blobuploader) - INFO - Done attempting. 06:20:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:20:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:20:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:20:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:20:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:20:57 INFO - (blobuploader) - INFO - Done attempting. 06:20:57 INFO - (blobuploader) - INFO - Iteration through files over. 06:20:57 INFO - Return code: 0 06:20:57 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:20:57 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:20:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c0d92238ac158ffff150a82f2fd8fa893221c17adbfc749eb15968da62c9a81189d4f95831fc1dc32896f4bbc5a3956fd59920bf332b05fa75edbb9176b0f7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/690b945c486b174a85f81ceeab3df215280780b817ddabeb17002a6e8e2aae7b4def249a1fd6fd323f7f7c282066f8dc365f80f5e133cc142a7134fdc7b294ae"} 06:20:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:20:57 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:20:57 INFO - Contents: 06:20:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c0d92238ac158ffff150a82f2fd8fa893221c17adbfc749eb15968da62c9a81189d4f95831fc1dc32896f4bbc5a3956fd59920bf332b05fa75edbb9176b0f7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/690b945c486b174a85f81ceeab3df215280780b817ddabeb17002a6e8e2aae7b4def249a1fd6fd323f7f7c282066f8dc365f80f5e133cc142a7134fdc7b294ae"} 06:20:57 INFO - Running post-run listener: copy_logs_to_upload_dir 06:20:57 INFO - Copying logs to upload dir... 06:20:57 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 06:20:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.518075 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-02-23 06:20:57.562675) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-23 06:20:57.566597) ========= 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=8887e36bb8e381bfd44124ac000001a8-1456234233.685923-1855228529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c0d92238ac158ffff150a82f2fd8fa893221c17adbfc749eb15968da62c9a81189d4f95831fc1dc32896f4bbc5a3956fd59920bf332b05fa75edbb9176b0f7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/690b945c486b174a85f81ceeab3df215280780b817ddabeb17002a6e8e2aae7b4def249a1fd6fd323f7f7c282066f8dc365f80f5e133cc142a7134fdc7b294ae"} build_url:https://queue.taskcluster.net/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011374 build_url: 'https://queue.taskcluster.net/v1/task/F3L9o7a4RkGm4govaunquA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c0d92238ac158ffff150a82f2fd8fa893221c17adbfc749eb15968da62c9a81189d4f95831fc1dc32896f4bbc5a3956fd59920bf332b05fa75edbb9176b0f7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/690b945c486b174a85f81ceeab3df215280780b817ddabeb17002a6e8e2aae7b4def249a1fd6fd323f7f7c282066f8dc365f80f5e133cc142a7134fdc7b294ae"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-23 06:20:57.590838) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 06:20:57.591138) ========= 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=8887e36bb8e381bfd44124ac000001a8-1456234233.685923-1855228529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004583 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 06:20:57.673947) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 06:20:57.674291) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 06:20:57.674583) ========= ========= Total master_lag: 0.32 =========