builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-032 starttime: 1457617954.84 results: success (0) buildid: 20160310030242 builduid: 8f534ec49a6543cf845c110dea8499bc revision: dd1abe874252e507b825a0a4e1063b0e13578288 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-10 05:52:34.837232) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-10 05:52:34.837724) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-10 05:52:34.838019) ========= 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=745a4373a2a16df560f216e000000264-1457617954.508200-1421425352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004902 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-10 05:52:34.859291) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-10 05:52:34.859652) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-10 05:52:34.873155) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 05:52:34.873542) ========= 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=745a4373a2a16df560f216e000000264-1457617954.508200-1421425352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004579 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 05:52:34.922632) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 05:52:34.922935) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 05:52:34.923284) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 05:52:34.923556) ========= 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=745a4373a2a16df560f216e000000264-1457617954.508200-1421425352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-10 05:52:35-- 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% 45.7M=0s 2016-03-10 05:52:35 (45.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083389 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 05:52:35.019509) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 05:52:35.019915) ========= 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=745a4373a2a16df560f216e000000264-1457617954.508200-1421425352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022450 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 05:52:35.069505) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 05:52:35.069901) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dd1abe874252e507b825a0a4e1063b0e13578288 --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 dd1abe874252e507b825a0a4e1063b0e13578288 --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=745a4373a2a16df560f216e000000264-1457617954.508200-1421425352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-10 05:52:35,456 truncating revision to first 12 chars 2016-03-10 05:52:35,456 Setting DEBUG logging. 2016-03-10 05:52:35,456 attempt 1/10 2016-03-10 05:52:35,456 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dd1abe874252?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-10 05:52:35,830 unpacking tar archive at: mozilla-central-dd1abe874252/testing/mozharness/ program finished with exit code 0 elapsedTime=0.681036 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 05:52:35.763833) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-10 05:52:35.764271) ========= echo dd1abe874252e507b825a0a4e1063b0e13578288 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'dd1abe874252e507b825a0a4e1063b0e13578288'] 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=745a4373a2a16df560f216e000000264-1457617954.508200-1421425352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False dd1abe874252e507b825a0a4e1063b0e13578288 program finished with exit code 0 elapsedTime=0.003569 script_repo_revision: 'dd1abe874252e507b825a0a4e1063b0e13578288' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-10 05:52:35.812506) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-10 05:52:35.812829) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-10 05:52:35.822635) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-03-10 05:52:35.823032) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=745a4373a2a16df560f216e000000264-1457617954.508200-1421425352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:52:36 INFO - MultiFileLogger online at 20160310 05:52:36 in /builds/slave/test-pgo 05:52:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:52:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:52:36 INFO - {'append_to_log': False, 05:52:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:52:36 INFO - 'blob_upload_branch': 'Firefox', 05:52:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:52:36 INFO - 'branch': 'Firefox', 05:52:36 INFO - 'buildbot_json_path': 'buildprops.json', 05:52:36 INFO - 'config_files': ('talos/linux_config.py',), 05:52:36 INFO - 'default_actions': ('clobber', 05:52:36 INFO - 'read-buildbot-config', 05:52:36 INFO - 'download-and-extract', 05:52:36 INFO - 'populate-webroot', 05:52:36 INFO - 'create-virtualenv', 05:52:36 INFO - 'install', 05:52:36 INFO - 'run-tests'), 05:52:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:52:36 INFO - 'download_minidump_stackwalk': True, 05:52:36 INFO - 'download_symbols': 'ondemand', 05:52:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:52:36 INFO - 'tooltool.py': '/tools/tooltool.py', 05:52:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:52:36 INFO - '/tools/misc-python/virtualenv.py')}, 05:52:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:52:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:52:36 INFO - 'installer_path': 'installer.exe', 05:52:36 INFO - 'log_level': 'info', 05:52:36 INFO - 'log_name': 'talos', 05:52:36 INFO - 'log_to_console': True, 05:52:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:52:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:52:36 INFO - 'opt_config_files': (), 05:52:36 INFO - 'pip_index': False, 05:52:36 INFO - 'sps_profile': False, 05:52:36 INFO - 'sps_profile_interval': 0, 05:52:36 INFO - 'suite': 'dromaeojs-e10s', 05:52:36 INFO - 'system_bits': '32', 05:52:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:52:36 INFO - 'title': 'talos-linux64-ix-032', 05:52:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:52:36 INFO - 'use_talos_json': True, 05:52:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:52:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:52:36 INFO - 'work_dir': 'build'} 05:52:36 INFO - ##### 05:52:36 INFO - ##### Running clobber step. 05:52:36 INFO - ##### 05:52:36 INFO - Running pre-action listener: _resource_record_pre_action 05:52:36 INFO - Running main action method: clobber 05:52:36 INFO - rmtree: /builds/slave/test-pgo/build 05:52:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:52:37 INFO - Running post-action listener: _resource_record_post_action 05:52:37 INFO - ##### 05:52:37 INFO - ##### Running read-buildbot-config step. 05:52:37 INFO - ##### 05:52:37 INFO - Running pre-action listener: _resource_record_pre_action 05:52:37 INFO - Running main action method: read_buildbot_config 05:52:37 INFO - Using buildbot properties: 05:52:37 INFO - { 05:52:37 INFO - "project": "", 05:52:37 INFO - "product": "firefox", 05:52:37 INFO - "script_repo_revision": "production", 05:52:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:52:37 INFO - "repository": "", 05:52:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:52:37 INFO - "buildid": "20160310030242", 05:52:37 INFO - "stage_platform": "linux64-pgo", 05:52:37 INFO - "basedir": "/builds/slave/test-pgo", 05:52:37 INFO - "nightly_build": "True", 05:52:37 INFO - "buildnumber": 661, 05:52:37 INFO - "slavename": "talos-linux64-ix-032", 05:52:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:52:37 INFO - "platform": "ubuntu64_hw", 05:52:37 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:52:37 INFO - "branch": "mozilla-central", 05:52:37 INFO - "repo_path": "mozilla-central", 05:52:37 INFO - "revision": "dd1abe874252e507b825a0a4e1063b0e13578288", 05:52:37 INFO - "pgo_build": "True", 05:52:37 INFO - "builduid": "8f534ec49a6543cf845c110dea8499bc", 05:52:37 INFO - "slavebuilddir": "test" 05:52:37 INFO - } 05:52:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:52:37 INFO - Running post-action listener: _resource_record_post_action 05:52:37 INFO - ##### 05:52:37 INFO - ##### Running download-and-extract step. 05:52:37 INFO - ##### 05:52:37 INFO - Running pre-action listener: _resource_record_pre_action 05:52:37 INFO - Running main action method: download_and_extract 05:52:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:52:37 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')]} 05:52:37 INFO - https://queue.taskcluster.net/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:52:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:52:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:52:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:52:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:52:37 INFO - Downloaded 1361 bytes. 05:52:37 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:52:37 INFO - Using the following test package requirements: 05:52:37 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:52:37 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:52:37 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:52:37 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:37 INFO - u'jsshell-linux-x86_64.zip'], 05:52:37 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:52:37 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:52:37 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:52:37 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:52:37 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:52:37 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:52:37 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:52:37 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')]} 05:52:37 INFO - https://queue.taskcluster.net/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:52:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:52:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:52:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:52:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:52:39 INFO - Downloaded 23406555 bytes. 05:52:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:52:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:52:40 INFO - Return code: 0 05:52:40 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:40 INFO - https://queue.taskcluster.net/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:52:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:52:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:52:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:52:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:52:41 INFO - Downloaded 23406555 bytes. 05:52:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:52:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:52:43 INFO - Return code: 0 05:52: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')]} 05:52:43 INFO - https://queue.taskcluster.net/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:52:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:52:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:52:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:52:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:52:44 INFO - Downloaded 10845161 bytes. 05:52:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:52:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 05:52:44 INFO - Return code: 0 05:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:44 INFO - https://queue.taskcluster.net/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:52:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:52:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:52:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:52:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:52:45 INFO - Downloaded 56224593 bytes. 05:52:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:52:45 INFO - mkdir: /builds/slave/test-pgo/properties 05:52:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:52:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:52:45 INFO - Contents: 05:52:45 INFO - build_url:https://queue.taskcluster.net/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:52:46 INFO - Running post-action listener: _resource_record_post_action 05:52:46 INFO - Running post-action listener: set_extra_try_arguments 05:52:46 INFO - ##### 05:52:46 INFO - ##### Running populate-webroot step. 05:52:46 INFO - ##### 05:52:46 INFO - Running pre-action listener: _resource_record_pre_action 05:52:46 INFO - Running main action method: populate_webroot 05:52:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:52:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:52:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:52:46 INFO - '--tppagecycles', 05:52:46 INFO - '7'], 05:52:46 INFO - 'tests': ['tsvgm']}}, 05:52:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:52:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:52:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:52:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:52:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:52:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:52:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:46 INFO - 'talos_options': ['--e10s'], 05:52:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:46 INFO - 'tests': ['damp', 'tps']}, 05:52:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:46 INFO - 'talos_options': ['--e10s'], 05:52:46 INFO - 'tests': ['damp', 'tps']}, 05:52:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:52:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:52:46 INFO - 'other': {'tests': ['a11yr', 05:52:46 INFO - 'ts_paint', 05:52:46 INFO - 'tpaint', 05:52:46 INFO - 'sessionrestore', 05:52:46 INFO - 'sessionrestore_no_auto_restore', 05:52:46 INFO - 'tabpaint']}, 05:52:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:52:46 INFO - 'tests': ['a11yr', 05:52:46 INFO - 'ts_paint', 05:52:46 INFO - 'tpaint', 05:52:46 INFO - 'sessionrestore', 05:52:46 INFO - 'sessionrestore_no_auto_restore', 05:52:46 INFO - 'tabpaint']}, 05:52:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:52:46 INFO - 'tests': ['a11yr', 05:52:46 INFO - 'ts_paint', 05:52:46 INFO - 'tpaint', 05:52:46 INFO - 'sessionrestore', 05:52:46 INFO - 'sessionrestore_no_auto_restore', 05:52:46 INFO - 'tabpaint']}, 05:52:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:52:46 INFO - 'tests': ['a11yr', 05:52:46 INFO - 'ts_paint', 05:52:46 INFO - 'tpaint', 05:52:46 INFO - 'sessionrestore', 05:52:46 INFO - 'sessionrestore_no_auto_restore', 05:52:46 INFO - 'tabpaint']}, 05:52:46 INFO - 'other_l64': {'tests': ['a11yr', 05:52:46 INFO - 'ts_paint', 05:52:46 INFO - 'tpaint', 05:52:46 INFO - 'sessionrestore', 05:52:46 INFO - 'sessionrestore_no_auto_restore', 05:52:46 INFO - 'tabpaint']}, 05:52:46 INFO - 'other_nol64': {'tests': ['a11yr', 05:52:46 INFO - 'ts_paint', 05:52:46 INFO - 'tpaint', 05:52:46 INFO - 'sessionrestore', 05:52:46 INFO - 'sessionrestore_no_auto_restore', 05:52:46 INFO - 'tabpaint']}, 05:52:46 INFO - 'svgr': {'tests': ['tsvgx', 05:52:46 INFO - 'tsvgr_opacity', 05:52:46 INFO - 'tart', 05:52:46 INFO - 'tscrollx', 05:52:46 INFO - 'cart']}, 05:52:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:52:46 INFO - 'tests': ['tsvgx', 05:52:46 INFO - 'tsvgr_opacity', 05:52:46 INFO - 'tart', 05:52:46 INFO - 'tscrollx', 05:52:46 INFO - 'cart']}, 05:52:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:46 INFO - 'tests': ['tp5o']}, 05:52:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:46 INFO - 'talos_options': ['--e10s'], 05:52:46 INFO - 'tests': ['tp5o']}, 05:52:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:46 INFO - 'talos_options': ['--xperf_path', 05:52:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:46 INFO - 'tests': ['tp5n']}, 05:52:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:46 INFO - 'talos_options': ['--e10s', 05:52:46 INFO - '--xperf_path', 05:52:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:46 INFO - 'tests': ['tp5n']}}, 05:52:46 INFO - 'talos.zip': {'path': '', 05:52:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:52:46 INFO - Running post-action listener: _resource_record_post_action 05:52:46 INFO - ##### 05:52:46 INFO - ##### Running create-virtualenv step. 05:52:46 INFO - ##### 05:52:46 INFO - Running pre-action listener: _resource_record_pre_action 05:52:46 INFO - Running main action method: create_virtualenv 05:52:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:52:46 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 05:52:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:52:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:52:46 INFO - Using real prefix '/usr' 05:52:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:52:47 INFO - Installing distribute.............................................................................................................................................................................................done. 05:52:49 INFO - Installing pip.................done. 05:52:49 INFO - Return code: 0 05:52:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb13720af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184e6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dd920>, '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 0x18de820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18decb0>, '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': '745a4373a2a16df560f216e000000264-1457617954.508200-1421425352', '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 05:52:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:52:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:52:49 INFO - Using env: {'DISPLAY': ':0', 05:52:49 INFO - 'HOME': '/home/cltbld', 05:52:49 INFO - 'LANG': 'en_US.UTF-8', 05:52:49 INFO - 'LANGUAGE': 'en_US:en', 05:52:49 INFO - 'LOGNAME': 'cltbld', 05:52:49 INFO - 'MAIL': '/var/mail/cltbld', 05:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:49 INFO - 'MOZ_NO_REMOTE': '1', 05:52:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:49 INFO - 'NO_EM_RESTART': '1', 05:52:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:49 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:49 INFO - 'SHELL': '/bin/bash', 05:52:49 INFO - 'SHLVL': '1', 05:52:49 INFO - 'TERM': 'linux', 05:52:49 INFO - 'TMOUT': '86400', 05:52:49 INFO - 'USER': 'cltbld', 05:52:49 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457617954.508200-1421425352', 05:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:49 INFO - '_': '/tools/buildbot/bin/python'} 05:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:49 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 05:52:49 INFO - Cleaning up... 05:52:49 INFO - Return code: 0 05:52:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb13720af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184e6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dd920>, '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 0x18de820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18decb0>, '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': '745a4373a2a16df560f216e000000264-1457617954.508200-1421425352', '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 05:52:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:52:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:52:49 INFO - Using env: {'DISPLAY': ':0', 05:52:49 INFO - 'HOME': '/home/cltbld', 05:52:49 INFO - 'LANG': 'en_US.UTF-8', 05:52:49 INFO - 'LANGUAGE': 'en_US:en', 05:52:49 INFO - 'LOGNAME': 'cltbld', 05:52:49 INFO - 'MAIL': '/var/mail/cltbld', 05:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:49 INFO - 'MOZ_NO_REMOTE': '1', 05:52:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:49 INFO - 'NO_EM_RESTART': '1', 05:52:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:49 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:49 INFO - 'SHELL': '/bin/bash', 05:52:49 INFO - 'SHLVL': '1', 05:52:49 INFO - 'TERM': 'linux', 05:52:49 INFO - 'TMOUT': '86400', 05:52:49 INFO - 'USER': 'cltbld', 05:52:49 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457617954.508200-1421425352', 05:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:49 INFO - '_': '/tools/buildbot/bin/python'} 05:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:49 INFO - Downloading/unpacking psutil>=0.7.1 05:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:52:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:51 INFO - Installing collected packages: psutil 05:52:51 INFO - Running setup.py install for psutil 05:52:51 INFO - building 'psutil._psutil_linux' extension 05:52:51 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 05:52:51 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 05:52:51 INFO - building 'psutil._psutil_posix' extension 05:52:51 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 05:52:51 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 05:52:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:51 INFO - Successfully installed psutil 05:52:51 INFO - Cleaning up... 05:52:51 INFO - Return code: 0 05:52:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:52: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')]} 05:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52: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')]} 05:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb13720af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184e6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dd920>, '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 0x18de820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18decb0>, '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': '745a4373a2a16df560f216e000000264-1457617954.508200-1421425352', '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 05:52:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:52:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:52:51 INFO - Using env: {'DISPLAY': ':0', 05:52:51 INFO - 'HOME': '/home/cltbld', 05:52:51 INFO - 'LANG': 'en_US.UTF-8', 05:52:51 INFO - 'LANGUAGE': 'en_US:en', 05:52:51 INFO - 'LOGNAME': 'cltbld', 05:52:51 INFO - 'MAIL': '/var/mail/cltbld', 05:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:51 INFO - 'MOZ_NO_REMOTE': '1', 05:52:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:51 INFO - 'NO_EM_RESTART': '1', 05:52:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:51 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:51 INFO - 'SHELL': '/bin/bash', 05:52:51 INFO - 'SHLVL': '1', 05:52:51 INFO - 'TERM': 'linux', 05:52:51 INFO - 'TMOUT': '86400', 05:52:51 INFO - 'USER': 'cltbld', 05:52:51 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457617954.508200-1421425352', 05:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:51 INFO - '_': '/tools/buildbot/bin/python'} 05:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:52:52 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 05:52:52 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 05:52:52 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 05:52:52 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 05:52:52 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 05:52:52 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 05:52:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:52:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:52:54 INFO - Installing collected packages: mozsystemmonitor 05:52:54 INFO - Running setup.py install for mozsystemmonitor 05:52:54 INFO - Successfully installed mozsystemmonitor 05:52:54 INFO - Cleaning up... 05:52:54 INFO - Return code: 0 05:52:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:52: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')]} 05:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52: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')]} 05:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:54 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 0x7fb13720af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184e6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dd920>, '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 0x18de820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18decb0>, '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': '745a4373a2a16df560f216e000000264-1457617954.508200-1421425352', '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 05:52:54 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 05:52:54 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 05:52:54 INFO - Using env: {'DISPLAY': ':0', 05:52:54 INFO - 'HOME': '/home/cltbld', 05:52:54 INFO - 'LANG': 'en_US.UTF-8', 05:52:54 INFO - 'LANGUAGE': 'en_US:en', 05:52:54 INFO - 'LOGNAME': 'cltbld', 05:52:54 INFO - 'MAIL': '/var/mail/cltbld', 05:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:54 INFO - 'MOZ_NO_REMOTE': '1', 05:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:54 INFO - 'NO_EM_RESTART': '1', 05:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:54 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:54 INFO - 'SHELL': '/bin/bash', 05:52:54 INFO - 'SHLVL': '1', 05:52:54 INFO - 'TERM': 'linux', 05:52:54 INFO - 'TMOUT': '86400', 05:52:54 INFO - 'USER': 'cltbld', 05:52:54 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457617954.508200-1421425352', 05:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:54 INFO - '_': '/tools/buildbot/bin/python'} 05:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:54 INFO - Downloading/unpacking blobuploader==1.2.4 05:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:56 INFO - Downloading blobuploader-1.2.4.tar.gz 05:52:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:52:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:52:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:56 INFO - Downloading docopt-0.6.1.tar.gz 05:52:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:52:56 INFO - Installing collected packages: blobuploader, requests, docopt 05:52:56 INFO - Running setup.py install for blobuploader 05:52:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:52:57 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:52:57 INFO - Running setup.py install for requests 05:52:57 INFO - Running setup.py install for docopt 05:52:57 INFO - Successfully installed blobuploader requests docopt 05:52:57 INFO - Cleaning up... 05:52:57 INFO - Return code: 0 05:52:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:57 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 0x7fb13720af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184e6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dd920>, '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 0x18de820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18decb0>, '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': '745a4373a2a16df560f216e000000264-1457617954.508200-1421425352', '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 05:52:57 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 05:52:57 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 05:52:57 INFO - Using env: {'DISPLAY': ':0', 05:52:57 INFO - 'HOME': '/home/cltbld', 05:52:57 INFO - 'LANG': 'en_US.UTF-8', 05:52:57 INFO - 'LANGUAGE': 'en_US:en', 05:52:57 INFO - 'LOGNAME': 'cltbld', 05:52:57 INFO - 'MAIL': '/var/mail/cltbld', 05:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:57 INFO - 'MOZ_NO_REMOTE': '1', 05:52:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:57 INFO - 'NO_EM_RESTART': '1', 05:52:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:57 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:57 INFO - 'SHELL': '/bin/bash', 05:52:57 INFO - 'SHLVL': '1', 05:52:57 INFO - 'TERM': 'linux', 05:52:57 INFO - 'TMOUT': '86400', 05:52:57 INFO - 'USER': 'cltbld', 05:52:57 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457617954.508200-1421425352', 05:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:57 INFO - '_': '/tools/buildbot/bin/python'} 05:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:52:57 INFO - Running setup.py (path:/tmp/pip-zkZRyg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:52:57 INFO - Running setup.py (path:/tmp/pip-KyAPEn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:52:57 INFO - Running setup.py (path:/tmp/pip-ISBC7o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:52:58 INFO - Running setup.py (path:/tmp/pip-YyEFTL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:52:58 INFO - Running setup.py (path:/tmp/pip-2GQWpC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:52:58 INFO - Running setup.py (path:/tmp/pip-VhuZI5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:52:58 INFO - Running setup.py (path:/tmp/pip-EbM1ry-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:52:58 INFO - Running setup.py (path:/tmp/pip-oB3NNV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:52:58 INFO - Running setup.py (path:/tmp/pip-WcDo8A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:52:58 INFO - Running setup.py (path:/tmp/pip-quAQ3m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:52:58 INFO - Running setup.py (path:/tmp/pip-tiyiWg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:52:58 INFO - Running setup.py (path:/tmp/pip-tXcrau-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:52:58 INFO - Running setup.py (path:/tmp/pip-DhFO0R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:52:58 INFO - Running setup.py (path:/tmp/pip-F2zGPJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:52:58 INFO - Running setup.py (path:/tmp/pip-gqmL7q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:52:58 INFO - Running setup.py (path:/tmp/pip-u8iGg9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:52:58 INFO - Running setup.py (path:/tmp/pip-qHGfPn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:52:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:52:59 INFO - Running setup.py install for manifestparser 05:52:59 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:52:59 INFO - Running setup.py install for mozcrash 05:52:59 INFO - Running setup.py install for mozdebug 05:52:59 INFO - Running setup.py install for mozdevice 05:52:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:52:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:52:59 INFO - Running setup.py install for mozfile 05:52:59 INFO - Running setup.py install for mozhttpd 05:52:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:52:59 INFO - Running setup.py install for mozinfo 05:52:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:52:59 INFO - Running setup.py install for mozInstall 05:52:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:52:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:52:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:52:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:52:59 INFO - Running setup.py install for mozleak 05:52:59 INFO - Running setup.py install for mozlog 05:53:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:53:00 INFO - Running setup.py install for moznetwork 05:53:00 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:53:00 INFO - Running setup.py install for mozprocess 05:53:00 INFO - Running setup.py install for mozprofile 05:53:00 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:53:00 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:53:00 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:53:00 INFO - Running setup.py install for mozrunner 05:53:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:53:00 INFO - Running setup.py install for mozscreenshot 05:53:00 INFO - Running setup.py install for moztest 05:53:00 INFO - Running setup.py install for mozversion 05:53:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:53:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:53:00 INFO - Cleaning up... 05:53:00 INFO - Return code: 0 05:53:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:53: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')]} 05:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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')]} 05:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:00 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 0x7fb13720af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184e6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dd920>, '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 0x18de820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18decb0>, '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': '745a4373a2a16df560f216e000000264-1457617954.508200-1421425352', '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 05:53:00 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 05:53:00 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 05:53:00 INFO - Using env: {'DISPLAY': ':0', 05:53:00 INFO - 'HOME': '/home/cltbld', 05:53:00 INFO - 'LANG': 'en_US.UTF-8', 05:53:00 INFO - 'LANGUAGE': 'en_US:en', 05:53:00 INFO - 'LOGNAME': 'cltbld', 05:53:00 INFO - 'MAIL': '/var/mail/cltbld', 05:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:00 INFO - 'MOZ_NO_REMOTE': '1', 05:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:00 INFO - 'NO_EM_RESTART': '1', 05:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:53:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:53:00 INFO - 'SHELL': '/bin/bash', 05:53:00 INFO - 'SHLVL': '1', 05:53:00 INFO - 'TERM': 'linux', 05:53:00 INFO - 'TMOUT': '86400', 05:53:00 INFO - 'USER': 'cltbld', 05:53:00 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457617954.508200-1421425352', 05:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:00 INFO - '_': '/tools/buildbot/bin/python'} 05:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:53:01 INFO - Running setup.py (path:/tmp/pip-v_G1Eg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:53:01 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)) 05:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:53:01 INFO - Running setup.py (path:/tmp/pip-VRLMYZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 05:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:53:01 INFO - Running setup.py (path:/tmp/pip-NgIg0S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:53:01 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)) 05:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:53:01 INFO - Running setup.py (path:/tmp/pip-zST037-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:53:01 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)) 05:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:53:01 INFO - Running setup.py (path:/tmp/pip-WwNIrL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:53:01 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)) 05:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:53:01 INFO - Running setup.py (path:/tmp/pip-3TicaB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:53:01 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)) 05:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:53:01 INFO - Running setup.py (path:/tmp/pip-rhppn8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:53:01 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)) 05:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:53:01 INFO - Running setup.py (path:/tmp/pip-pbOWk7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:53:01 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)) 05:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:53:01 INFO - Running setup.py (path:/tmp/pip-robOiL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:53:01 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)) 05:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:53:01 INFO - Running setup.py (path:/tmp/pip-ztaTso-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:53:01 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)) 05:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:53:01 INFO - Running setup.py (path:/tmp/pip-B8UHtN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:53:01 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)) 05:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:53:01 INFO - Running setup.py (path:/tmp/pip-uiwMmm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:53:01 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)) 05:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:53:01 INFO - Running setup.py (path:/tmp/pip-IV2A11-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:53:01 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)) 05:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:53:01 INFO - Running setup.py (path:/tmp/pip-DxTdgD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:53:02 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)) 05:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:53:02 INFO - Running setup.py (path:/tmp/pip-frrXi1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:53:02 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)) 05:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:53:02 INFO - Running setup.py (path:/tmp/pip-VRouo1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:53:02 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)) 05:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:53:02 INFO - Running setup.py (path:/tmp/pip-GQGFp9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:53:02 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)) 05:53:02 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:53:02 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)) 05:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:53:02 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)) 05:53:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53:04 INFO - Downloading blessings-1.6.tar.gz 05:53:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:53:04 INFO - Installing collected packages: blessings 05:53:04 INFO - Running setup.py install for blessings 05:53:04 INFO - Successfully installed blessings 05:53:04 INFO - Cleaning up... 05:53:04 INFO - Return code: 0 05:53:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:53:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:53:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:53:04 INFO - Reading from file tmpfile_stdout 05:53:04 INFO - Current package versions: 05:53:04 INFO - argparse == 1.2.1 05:53:04 INFO - blessings == 1.6 05:53:04 INFO - blobuploader == 1.2.4 05:53:04 INFO - docopt == 0.6.1 05:53:04 INFO - manifestparser == 1.1 05:53:04 INFO - mozInstall == 1.12 05:53:04 INFO - mozcrash == 0.17 05:53:04 INFO - mozdebug == 0.1 05:53:04 INFO - mozdevice == 0.48 05:53:04 INFO - mozfile == 1.2 05:53:04 INFO - mozhttpd == 0.7 05:53:04 INFO - mozinfo == 0.9 05:53:04 INFO - mozleak == 0.1 05:53:04 INFO - mozlog == 3.1 05:53:04 INFO - moznetwork == 0.27 05:53:04 INFO - mozprocess == 0.22 05:53:04 INFO - mozprofile == 0.28 05:53:04 INFO - mozrunner == 6.11 05:53:04 INFO - mozscreenshot == 0.1 05:53:04 INFO - mozsystemmonitor == 0.0 05:53:04 INFO - moztest == 0.7 05:53:04 INFO - mozversion == 1.4 05:53:04 INFO - psutil == 3.1.1 05:53:04 INFO - requests == 1.2.3 05:53:04 INFO - wsgiref == 0.1.2 05:53:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:04 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 0x7fb13720af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184e6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dd920>, '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 0x18de820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18decb0>, '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': '745a4373a2a16df560f216e000000264-1457617954.508200-1421425352', '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 05:53:04 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 05:53:04 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 05:53:04 INFO - Using env: {'DISPLAY': ':0', 05:53:04 INFO - 'HOME': '/home/cltbld', 05:53:04 INFO - 'LANG': 'en_US.UTF-8', 05:53:04 INFO - 'LANGUAGE': 'en_US:en', 05:53:04 INFO - 'LOGNAME': 'cltbld', 05:53:04 INFO - 'MAIL': '/var/mail/cltbld', 05:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:04 INFO - 'MOZ_NO_REMOTE': '1', 05:53:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:04 INFO - 'NO_EM_RESTART': '1', 05:53:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:53:04 INFO - 'PWD': '/builds/slave/test-pgo', 05:53:04 INFO - 'SHELL': '/bin/bash', 05:53:04 INFO - 'SHLVL': '1', 05:53:04 INFO - 'TERM': 'linux', 05:53:04 INFO - 'TMOUT': '86400', 05:53:04 INFO - 'USER': 'cltbld', 05:53:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457617954.508200-1421425352', 05:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:04 INFO - '_': '/tools/buildbot/bin/python'} 05:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:04 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)) 05:53:04 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)) 05:53:04 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)) 05:53:04 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)) 05:53:04 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)) 05:53:04 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)) 05:53:04 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)) 05:53:04 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)) 05:53:04 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)) 05:53:04 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)) 05:53:04 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)) 05:53:04 INFO - Cleaning up... 05:53:04 INFO - Return code: 0 05:53:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb13720af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184e6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dd920>, '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 0x18de820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18decb0>, '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': '745a4373a2a16df560f216e000000264-1457617954.508200-1421425352', '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 05:53:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:53:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:53:04 INFO - Using env: {'DISPLAY': ':0', 05:53:04 INFO - 'HOME': '/home/cltbld', 05:53:04 INFO - 'LANG': 'en_US.UTF-8', 05:53:04 INFO - 'LANGUAGE': 'en_US:en', 05:53:04 INFO - 'LOGNAME': 'cltbld', 05:53:04 INFO - 'MAIL': '/var/mail/cltbld', 05:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:04 INFO - 'MOZ_NO_REMOTE': '1', 05:53:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:04 INFO - 'NO_EM_RESTART': '1', 05:53:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:53:04 INFO - 'PWD': '/builds/slave/test-pgo', 05:53:04 INFO - 'SHELL': '/bin/bash', 05:53:04 INFO - 'SHLVL': '1', 05:53:04 INFO - 'TERM': 'linux', 05:53:04 INFO - 'TMOUT': '86400', 05:53:04 INFO - 'USER': 'cltbld', 05:53:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457617954.508200-1421425352', 05:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:04 INFO - '_': '/tools/buildbot/bin/python'} 05:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:04 INFO - Downloading/unpacking jsonschema 05:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:53:06 INFO - Downloading/unpacking functools32 (from jsonschema) 05:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:06 INFO - Downloading functools32-3.2.3-2.tar.gz 05:53:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:53:07 INFO - warning: no files found matching '*.txt' 05:53:07 INFO - no previously-included directories found matching 'build' 05:53:07 INFO - no previously-included directories found matching 'dist' 05:53:07 INFO - no previously-included directories found matching '.git*' 05:53:07 INFO - Installing collected packages: jsonschema, functools32 05:53:07 INFO - Running setup.py install for functools32 05:53:07 INFO - warning: no files found matching '*.txt' 05:53:07 INFO - no previously-included directories found matching 'build' 05:53:07 INFO - no previously-included directories found matching 'dist' 05:53:07 INFO - no previously-included directories found matching '.git*' 05:53:07 INFO - Successfully installed jsonschema functools32 05:53:07 INFO - Cleaning up... 05:53:07 INFO - Return code: 0 05:53:07 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:53:07 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')]} 05:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:07 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')]} 05:53:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:07 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 0x7fb13720af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184e6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dd920>, '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 0x18de820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18decb0>, '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': '745a4373a2a16df560f216e000000264-1457617954.508200-1421425352', '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 05:53:07 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 05:53:07 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 05:53:07 INFO - Using env: {'DISPLAY': ':0', 05:53:07 INFO - 'HOME': '/home/cltbld', 05:53:07 INFO - 'LANG': 'en_US.UTF-8', 05:53:07 INFO - 'LANGUAGE': 'en_US:en', 05:53:07 INFO - 'LOGNAME': 'cltbld', 05:53:07 INFO - 'MAIL': '/var/mail/cltbld', 05:53:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:07 INFO - 'MOZ_NO_REMOTE': '1', 05:53:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:07 INFO - 'NO_EM_RESTART': '1', 05:53:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:53:07 INFO - 'PWD': '/builds/slave/test-pgo', 05:53:07 INFO - 'SHELL': '/bin/bash', 05:53:07 INFO - 'SHLVL': '1', 05:53:07 INFO - 'TERM': 'linux', 05:53:07 INFO - 'TMOUT': '86400', 05:53:07 INFO - 'USER': 'cltbld', 05:53:07 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457617954.508200-1421425352', 05:53:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:07 INFO - '_': '/tools/buildbot/bin/python'} 05:53:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:07 INFO - Downloading/unpacking flake8 05:53:07 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 05:53:07 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 05:53:07 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 05:53:07 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 05:53:07 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 05:53:07 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 05:53:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:53:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:53:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:53:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:53:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:53:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:53:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:53:09 INFO - no previously-included directories found matching 'docs/_build' 05:53:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:53:10 INFO - Running setup.py install for pep8 05:53:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:53:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:53:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:53:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:53:10 INFO - no previously-included directories found matching 'docs/_build' 05:53:10 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:53:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:53:10 INFO - Cleaning up... 05:53:10 INFO - Return code: 0 05:53:10 INFO - Running post-action listener: _resource_record_post_action 05:53:10 INFO - Running post-action listener: _start_resource_monitoring 05:53:10 INFO - Starting resource monitoring. 05:53:10 INFO - ##### 05:53:10 INFO - ##### Running install step. 05:53:10 INFO - ##### 05:53:10 INFO - Running pre-action listener: _resource_record_pre_action 05:53:10 INFO - Running main action method: install 05:53:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:53:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:53:10 INFO - Reading from file tmpfile_stdout 05:53:10 INFO - Detecting whether we're running mozinstall >=1.0... 05:53:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:53:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:53:10 INFO - Reading from file tmpfile_stdout 05:53:10 INFO - Output received: 05:53:10 INFO - Usage: mozinstall [options] installer 05:53:10 INFO - Options: 05:53:10 INFO - -h, --help show this help message and exit 05:53:10 INFO - -d DEST, --destination=DEST 05:53:10 INFO - Directory to install application into. [default: 05:53:10 INFO - "/builds/slave/test-pgo"] 05:53:10 INFO - --app=APP Application being installed. [default: firefox] 05:53:10 INFO - mkdir: /builds/slave/test-pgo/build/application 05:53:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:53:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:53:26 INFO - Reading from file tmpfile_stdout 05:53:26 INFO - Output received: 05:53:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:53:26 INFO - Running post-action listener: _resource_record_post_action 05:53:26 INFO - ##### 05:53:26 INFO - ##### Running run-tests step. 05:53:26 INFO - ##### 05:53:26 INFO - Running pre-action listener: _resource_record_pre_action 05:53:26 INFO - Running main action method: run_tests 05:53:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:53:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:53:26 INFO - Python 2.7.3 05:53:26 INFO - Return code: 0 05:53:26 INFO - grabbing minidump binary from tooltool 05:53:26 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')]} 05:53:26 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 0x18dd920>, '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 0x18de820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18decb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:53:26 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 05:53:26 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 05:53:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:53:26 INFO - Return code: 0 05:53:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:53:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:53:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:53:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:53:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:53:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:53:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:53:27 INFO - Return code: 0 05:53:27 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 05:53:27 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:53:27 INFO - Using env: {'DISPLAY': ':0', 05:53:27 INFO - 'HOME': '/home/cltbld', 05:53:27 INFO - 'LANG': 'en_US.UTF-8', 05:53:27 INFO - 'LANGUAGE': 'en_US:en', 05:53:27 INFO - 'LOGNAME': 'cltbld', 05:53:27 INFO - 'MAIL': '/var/mail/cltbld', 05:53:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:53:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:27 INFO - 'MOZ_NO_REMOTE': '1', 05:53:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:53:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:27 INFO - 'NO_EM_RESTART': '1', 05:53:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:53:27 INFO - 'PWD': '/builds/slave/test-pgo', 05:53:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:53:27 INFO - 'SHELL': '/bin/bash', 05:53:27 INFO - 'SHLVL': '1', 05:53:27 INFO - 'TERM': 'linux', 05:53:27 INFO - 'TMOUT': '86400', 05:53:27 INFO - 'USER': 'cltbld', 05:53:27 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457617954.508200-1421425352', 05:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:27 INFO - '_': '/tools/buildbot/bin/python'} 05:53:27 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:53:27 INFO - mozversion application_buildid: 20160310030242 05:53:27 INFO - mozversion application_changeset: dd1abe874252e507b825a0a4e1063b0e13578288 05:53:27 INFO - mozversion application_display_name: Nightly 05:53:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:53:27 INFO - mozversion application_name: Firefox 05:53:27 INFO - mozversion application_remotingname: firefox 05:53:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:53:27 INFO - mozversion application_vendor: Mozilla 05:53:27 INFO - mozversion application_version: 48.0a1 05:53:27 INFO - mozversion platform_buildid: 20160310030242 05:53:27 INFO - mozversion platform_changeset: dd1abe874252e507b825a0a4e1063b0e13578288 05:53:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:53:27 INFO - mozversion platform_version: 48.0a1 05:53:27 INFO - using testdate: 1457618007 05:53:27 INFO - actual date: 1457618007 05:53:27 INFO - starting webserver on 'localhost:57489' 05:53:27 INFO - SUITE-START | Running 2 tests 05:53:27 INFO - TEST-START | dromaeo_css 05:53:27 INFO - operating with platform_type : linux_ 05:53:27 INFO - Initialising browser for dromaeo_css test... 05:53:27 INFO - TEST-INFO | started process 21744 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWk2SkQ/profile http://localhost:57489/getInfo.html) 05:53:31 INFO - PROCESS | 21744 | 05:53:31 INFO - PROCESS | 21744 | (process:21824): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:53:32 INFO - PROCESS | 21744 | __metrics Screen width/height:1600/1200 05:53:32 INFO - PROCESS | 21744 | colorDepth:24 05:53:32 INFO - PROCESS | 21744 | Browser inner width/height: 1024/697 05:53:32 INFO - PROCESS | 21744 | __metrics 05:53:33 ERROR - PROCESS | 21744 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 05:53:34 INFO - TEST-INFO | 21744: exit 0 05:53:34 INFO - Browser initialized. 05:53:34 INFO - Running cycle 1/1 for dromaeo_css test... 05:53:34 INFO - TEST-INFO | started process 21877 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWk2SkQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:53:36 INFO - PROCESS | 21877 | 05:53:36 INFO - PROCESS | 21877 | (process:21939): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:53:46 INFO - PROCESS | 21877 | RSS: Main: 166453248 05:53:46 INFO - PROCESS | 21877 | 05:54:35 INFO - PROCESS | 21877 | 1457618075778 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] 05:56:44 INFO - PROCESS | 21877 | Cycle 1(1): loaded http://localhost:57489/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57489/tests/dromaeo/cssquery-ext.html) 05:56:45 INFO - PROCESS | 21877 | RSS: Main: 171241472 05:56:45 INFO - PROCESS | 21877 | 05:59:47 INFO - PROCESS | 21877 | Cycle 1(1): loaded http://localhost:57489/tests/dromaeo/cssquery-ext.html (next: http://localhost:57489/tests/dromaeo/cssquery-jquery.html) 05:59:48 INFO - PROCESS | 21877 | RSS: Main: 169394176 05:59:48 INFO - PROCESS | 21877 | 06:02:50 INFO - PROCESS | 21877 | Cycle 1(1): loaded http://localhost:57489/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57489/tests/dromaeo/cssquery-mootools.html) 06:02:50 INFO - PROCESS | 21877 | RSS: Main: 169209856 06:02:50 INFO - PROCESS | 21877 | 06:05:52 INFO - PROCESS | 21877 | Cycle 1(1): loaded http://localhost:57489/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57489/tests/dromaeo/cssquery-prototype.html) 06:05:53 INFO - PROCESS | 21877 | RSS: Main: 168062976 06:05:53 INFO - PROCESS | 21877 | 06:08:55 INFO - PROCESS | 21877 | Cycle 1(1): loaded http://localhost:57489/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57489/tests/dromaeo/cssquery-yui.html) 06:08:55 INFO - PROCESS | 21877 | RSS: Main: 167395328 06:08:55 INFO - PROCESS | 21877 | 06:11:58 INFO - PROCESS | 21877 | Cycle 1(1): loaded http://localhost:57489/tests/dromaeo/cssquery-yui.html (next: http://localhost:57489/tests/dromaeo/cssquery-dojo.html) 06:11:58 INFO - PROCESS | 21877 | RSS: Main: 171474944 06:11:58 INFO - PROCESS | 21877 | 06:11:58 INFO - PROCESS | 21877 | __start_tp_report 06:11:58 INFO - PROCESS | 21877 | _x_x_mozilla_page_load 06:11:58 INFO - PROCESS | 21877 | _x_x_mozilla_page_load_details 06:11:58 INFO - PROCESS | 21877 | |i|pagename|runs| 06:11:58 INFO - PROCESS | 21877 | |0;dojo.html;3200.0559834848723;3237.2877966847286;3250.106220789283;3256.6743325667435;3273.819939903306;5302.363716354038;5303.840884773454;5332.3601167859815;5340.225667278242;5369.9463005369935;5226.764795584208;5286.947130528693;5323.760430780614;5326.946730532693;5374.516293533581;4809.110314591803;4849.999999999983;4898.41219053714;4929.704217746928;5034.773435195425;4774.665773395864;4816.373871396713;4838.322634831126;4876.317315575822;4893.266010098496;4750.429948406196;4844.903101937959;4924.679895806761;4936.48166942473;4953.876153096166;4839.27410888366;4869.586085182764;4874.975625121851;4889.8777530561665;4914.533119353656;4772.880677983044;4814.06125805468;4853.611711063107;4867.464578896319;4909.852704418873;5180.8963820723375;5193.091209038404;5208;5209.114450543417;5221.086309895753;5724.055530837407;5733.397993210695;5741.167530708024;5746.913796293059;5747.827565173052;5606.635568688063;5721.828345149652;5766.913496297559;5774.335951365605;5824.359320474744;5391.676499410009;5407.70257635826;5423.647462914937;5437.755301011464;5452.318460192476;5854.414558544197;5867.442592953663;5873.735681894325;5878.294604647384;5906.734196961147;5560.304961879765;5639.6334238274385;5655.462731040545;5678.205051292823;5684.317881854204;5657.717114144276;5720.942790572041;5722.170285308607;5749.712514374348;5758.596898217084;5687.544996400278;5688.744006519716;5692.31692196939;5710.971445142831;5727.5131613812455;5485.753141108659;5684.459976302244;5685.948099601587;5703.572232082611;5734.082546792493;4329.718568293114;4340.782960851945;4352.847650332224;4367.519572846984;4380.452443444569;3877.651011408987;3907.667848232932;3910.1006768443417;3921.9019524512114;3978.661813745864;5353.197020446964;5409.486098820606;5425.538829199562;5463.125899856004;5485.01269771445;5733.397993210653;5748.45389687979;5765.913511297334;5782.59521833476;5787.160861675117;5429.239906413105;5437.075697131497;5448.101063324507;5453.15476101205;5455.8363249102595;4743.549362810528;4829.203181475087;4852.393450818577;4852.684575502581;4898.2652602109965;5972;6013.398660133952;6014.248218972629;6018.939810601838;6025.126356678345;5545.750441230073;5701.971490142523;5727.1695604138;5728.312602487728;5745.626534275259;5982.282126144891;6012.6993650316435;6027.6986150693165;6031.517478601789;6076.574639775174;5639.3232812062815;5640.266765320482;5649.209110724584;5654.46282603152;5656.547476201812;5567.2762540871045;5672.319321681424;5732.59871808986;5732.656040637575;5742;5524.66851988882;5585.972070139624;5608.551315894801;5644.435556444487;5679.034564124191;5539.224508568723;5540.335159780852;5590.161475778503;5594.692291923983;5595.832125036255;5414.756335964812;5492.5605951524585;5496;5503.6697798130635;5505.284313039279;5568.303962004749;5618.073017952155;5627.8874422512135;5643.068893632505;5644.85887852807;5503.7798488060025;5507.917381239205;5508.394076651485;5514.6691198528215;5539.086050801734 06:11:58 INFO - PROCESS | 21877 | |1;ext.html;477.52009230723115;524.4702850121378;531.2535887078653;564.1284215886457;583.2213994317585;37180.07049823756;37455.62544374556;37654.62345376549;37656;37664;42943.3558496622;43557.56442435575;43647;43678.344824827574;43781.7810910945;8628.352873534479;8683.782905427352;8756;8811.77970550735;8819.911800882006;8602.09677983812;8771.254443372321;8786.384953053288;8792.47245165292;8804.64781408743;8689.95655021724;8731.912680873173;8747.256483198937;8801.207891289783;8846.15961483658;8720.694775682852;8782.912170878337;8805.427647202976;8810.118988101203;8832.425892316978;8649.567521623894;8781.912180878173;8792.472451652857;8817.691380801642;8830.161134692195;40815.7959210205;41044.58955410437;41241.175176496305;41364.1727165458;41450.79274603638;3141.4345417824784;3199.216192032967;3212.791168574035;3308.387948229585;3420.572428446444;30024.54963175554;30786.38427231443;31024.224394390094;31088.378232435225;31897.84051079753;3143.3241853001487;3192.537082123102;3228.4673028950197;3242.9837850810595;3344.4314466540745;270202;270420;270863;271155;271616;59330;59428;59701;59793.10310345348;59805.401945980855;67451.32548674548;68576;68713.3128668717;68735;68848.3115168852;15931.840681593036;15972;16102;16102.919485402497;16156.838431615768;11953.22304050234;11963.64109076729;11978.401079945968;11979.820302695467;11989.160758746804;19608.411747647595;20098.894560799297;20134.395968120978;20205.191792328143;20947.37157885266;8009.959950200212;8203.30271926881;8229.876551851727;8293.875591866126;8419;958.8034452937131;974.8927617962019;982.7739619887323;1043.7599352149048;1115.7200700913756;28404.43191136166;29393.706062939524;29429.55855662167;29746.40507189844;29809.40381192364;1001.1840350114634;1003.7289931718395;1011.600417834951;1030.9175265978704;1046.56567524478;13875.653108672162;14013.439462421593;14311.284435778169;14401.78397324041;14422.278886055656;321603;693718;695967;698960;703545;54464.45535544673;54677;54746.452535474935;55020.724896376065;55188.72405637946;1378.7518246715488;1383.6540864783803;1386.4471791593278;1395.9720805584034;1396.1762560089596;29106.56340154857;30243.848780755954;30671.2332191697;30842.074737757903;30927;46234;47082.76458617685;47119;47154.528454715015;47166.29250561176;251880;253925;255253;256216;258690;32255.677443225268;32435.513467298482;32711.182220443727;32797.672023280415;32816.671833282315;42356.788216058725;43090.28402390538;43411.56588434202;43570.34644480272;44028.55971440244;36689.81655091707;36696.81651591725;36919;37164.44253336148;37252.813735931144;36145.66772655029;36356.81821590875;36907.815460922524;36954.26091478209;37152.62847371492;30514;35407;35517.289654207285;36013.63986360103;36571.634283657884;28732.281692957844;28886.133415997552;28939;29174.56238156387;29304.413911721218;22836.885815570815;22879.77120228843;22993.195238166583;23041.88479057594;23246 06:11:58 INFO - PROCESS | 21877 | |2;jquery.html;342.96398878117793;357.7370632585051;357.7799653213273;359.1344858890075;362.59932774284414;16416;16773.329066837327;17353.13234338283;17370.13149342531;17466;15852.682946341067;15969.600759980976;15998.920005399987;16215.594610134753;16521.256543455544;5287.524122828954;5297.841064768044;5445.754941027663;5520.779168833242;5579.804706835262;4436.97781511092;5581.107022876341;5596.552275817925;5608.803691870786;5618.747156377953;5294.755732402882;5500.257465242201;5521.972390138064;5524.226608274845;5537.889242215153;5465.016297066526;5467.043267428184;5474.315710536183;5476.507114359707;5507.697076660782;4896.632752543574;4911.336969509106;4928.950710492885;4942.851714448572;4982.551570358685;13053.412596433183;13138.737225255538;13244.072914895962;13252.20486770797;13252.801207981887;1998.600279944017;2085.7705652378227;2110.7361579802523;2284.680144779732;2319.9188028419094;8899;9035.096490350978;9515.476648784314;9631.90368096317;9665.516724163834;1778.6976214043643;1843.7142242952364;1857.322077441724;1876.2682553804027;1900.7053906644492;51115.48884511182;59685.40314596842;62064.379356206315;64401.677991609744;68046;10036.749081273027;10160.898391016142;10368.688939331832;10482.266241363184;10540.156787456985;14102.85897141036;14189.219592922282;14235.928820355832;14266.643333916734;14299.57101286963;7620.771376858703;7636.618169091523;7653.808654783564;7667.654955527015;8030.83938321242;7312.853742925112;7428.925710742931;7455.515391499644;7600.1639819619795;7716.2669546393;4549.567791059844;4672.948586567995;4684.8360307389075;4699;4704.835330763475;1833.3216709817452;1844.2807305151002;1852.7869295030973;1866.0576408913682;1870.7755069391487;890.2299510923134;909.3134683314188;911.9863202051974;944.6079876851168;1034.6171916390983;16317.918410407872;16565;16692.24884880183;17144.742828857576;17200.82799171992;916.8578870275118;917.6833992272656;925.8518637018179;955.2739917662487;994.5126887824914;9540.475273860004;9821.116099551075;9890.456024918698;9916.25628077897;10007.399556026661;431557;435198;438722;443517;454740;74356.62821685857;76444;76697;78594;81712;441.7872938783061;456.3041361923094;456.75761927556994;456.915470637933;458.3972076719104;10019.398836069859;10423;10484.947575262075;10585.470726463493;11181.273217240854;33387.99508044287;34541.30917381689;34648.13379665528;34760.65239347574;35560;49095.26357104718;51161.48838511567;51820.481795181564;52083.73958130185;52343.130655898;8180.263776260165;8298.543580103153;8470;8519.148085191679;8624.051354351142;12235.93882030584;12607.306598137191;12831.871681283068;13062.54281100195;13183.340832958505;10960.945195273973;11272.210945233755;11333.943330283295;11404.48679809427;11600.30398176112;11154.721131971766;11309.208355415041;11480.253783504046;11578.42107894585;11668.591599293984;11266.436678165896;11382.260153090023;11424.771504570028;11749.647510574354;11754.05967522579;7613.6573854177805;7868.331191848528;8197.877031844646;8235.711750088718;8735.519546425008;10846.566137354417;11261.268017578832;11277.71805704864;11293.322400655987;11477.770444591228 06:11:58 INFO - PROCESS | 21877 | |3;mootools.html;1488.032778693849;1503.030545298283;1678.127373765642;1786.8838525495835;1812.9637407251846;7151.892721609167;7816.296533312001;7920.564368959705;8193.87709184362;8214.178582141783;7916.40626952978;7983.640736166872;8072.112067672551;8094.392920530969;8116;2243.2260869999823;2271.3072512883564;2273.283915566591;2277.8633282003134;2282.8858557072163;2240.932772016842;2247.494313779403;2281.851679640818;2285.0631241191113;2292.002978704261;2212.1372664660717;2239.484918468753;2254.1884921428273;2260.728712554496;2272.216085450517;2300.781425764558;2311.0524684879288;2315.5253173099472;2319.072371051576;2323.256557901472;2333.241696448661;2349.964750528726;2351.036075209156;2355.6819829323163;2362.0315670575155;8079.434439589231;8165.75502734913;8168.305694016016;8188.836223275501;8206.384521160937;4791.185498465269;4883.804647814083;4907.533784290486;4912.70523768575;4929.852104436873;3024.5311976643657;3027.969720302791;3138.8587513561943;3144.811311321328;3148.354587309596;954.4082668745423;956.1585804492072;958.5973890965811;963.2967933408651;976.7216343342185;10517.947410262976;10534.36793792375;10542.314749541332;10600.469976501145;10643.361398316125;4283.700140990163;4303.1608836277255;4358.21552120615;4390.143921935192;4422.314541246112;9035.096490350912;9095.272378209727;9102.681406150752;9115;9130.817383652422;4821.180399332122;4855.174620314555;4868.342773725572;4874.829380971649;4898.657094003457;4049.655779258796;4438;4461.776911154429;4466.3747075409465;4546.227141385973;3699.5375578052744;3767.811609419573;3785.3186426443503;3794.0704527390412;3798.3163030654196;1205.9638210853689;1221.432034104146;1227.7974134267924;1231.4889320931713;1232.3468561662332;1300.4473098933104;1302;1304.928228947417;1308.6205000549735;1339.4842985450477;7421;7481.738139165212;7710.691572337044;7727;7747;473.23572430524456;474.77210938749596;474.9026449577828;476.1999840268313;489.20015774209423;5374.865628359323;5406.026915155231;5424.972875135599;5438.211459338374;5479.369872464717;9537.47543885093;9641.084097010773;9988;10039.548220330104;10096.798064038678;9694.709158725249;9803.607855685692;9848.901510984942;9875.950620246997;9897.059779320953;7028.789136325919;7218.169910460259;7263.673134709056;7276.272372762787;7678.692852285958;7466.290702383265;7538.3592394644875;7602.771916842504;7622.771316860503;7635.618219089134;8719.084496128069;8758.255548278468;8841.071687472722;8863.955680221557;8993.820123597361;8951.955240223757;8987.955060224656;9072.863907041268;9082.137196966278;9120.680776172801;6166.167567378347;6752;6822.454203663596;7202.89195662076;7274.054372931485;7407.888881666671;7436.293552112541;7442.813929651802;7499.1750907399055;7499.325060744559;6566.376194261537;6700.966495167493;6715.160604924385;6801.2178599461695;6866.793996180123;6430.260520040255;6446.484281257582;6485.416312531895;6494.512911531749;6536.542442029203;7004.194517630538;7043.36609705129;7092.822679433056;7102.183248926233;7148.749793757193;6344.365563443619;6433.163688720623;6444.162258906312;6459.709313081016;6468.353164683682;6285.528585356208;6317.020861766434;6343.9682801585695;6356.459700925473;6357.1735674362035 06:11:58 INFO - PROCESS | 21877 | |4;prototype.html;316.9033444799336;322.9450993331133;324.3593902043463;328.6910304313946;335.2523871765962;6223.4398904098625;6259.248890133184;6293.496520278378;6299.748010079597;6325.2409710834645;6145.17040199573;6204.813855584329;6218.22272215973;6223.595466294688;6231.252249730039;4515.61617262533;4575.977120114395;4598.931016034762;4607.331936869152;4777.06847164803;4592.058627981256;4602.792874320647;4608.5621865922685;4612.262038073909;4614.423197100363;4517.344984977176;4527.4340707411575;4554.70394424363;4557.703749256304;4559.270516717326;4542.545745425447;4550.795214215368;4553.248713962193;4553.840615578455;4576.542345765397;3932.5674175840636;3933.606639336072;3938.4836837817647;3941.3693808990424;3944.6647035001774;5919.911201331984;5939.584229103964;5957.970210148921;5962.940370596325;5974.940250597482;5198.194279886624;5325.068113080234;5342.305500284977;5388.649737767072;5406.243125962368;6497.415232629039;6540.967295163494;6543.411093001605;6550.050242714828;6589.736410543573;4401.581849724271;4402.823887044515;4405.515393306734;4419.911601767979;4431.158079964796;6811.046453496514;6824.078749368871;6871.622060786654;6900.137482814648;6900.930990690129;4398.956010439919;4419.668524860584;4426.867193984185;4428.402165707653;4434.091011342667;4378.627816635558;4490.977545112319;4501.954980450154;4507.504174540798;4511.368408422823;5341.332333458317;5355.518003379637;5356.839294821161;5364.785408583691;5367.1680889462195;6639.468842492589;6658.467322614276;6664.86670266592;6673.065770792093;6683.532152749261;1596.074276919384;1619.4008216959564;1620.3761551802404;1621.2704283072428;1623.8051433828016;992.0377234082928;1010.6967909627083;1024.9231307651955;1031.5976769060073;1043.0768769638923;6301.243850737849;6301.306856245809;6334.619922804646;6344.39728225827;6372.904406433907;6772.187337519529;6791.2869148739655;6819.659017049128;6830.453563714891;6835.043093966849;6126;6254.468370188494;6309.14826498426;6364.649944253018;6437.388448097423;3692.6307369263395;3710.5547334320054;3716.851325946932;3721.4789929409903;3726.124360775216;7299.963500182465;7302.050733404623;7313.926860731431;7333.633318334062;7337.009503717037;7019;7048.541844780073;7064.823379415453;7075.716971321192;7081.256468070881;7103.360697537143;7224.711011559479;7245.203027666952;7299.41604671625;7329.816754581178;6830.59016459014;6859.9314006859295;6861.313868613099;6861.588304701734;6867.862642747217;6765.966170169315;6797.116374871235;6809.897851532132;6832.975053741979;6850.520463567503;7276.781696549112;7278.636068196675;7298;7305.744298949511;7309.122905251404;4395.626371758436;4498.05540836428;4498.190325741398;4498.347739577808;4519.163954668397;6832.658367081725;6886.24251332343;6887.690053947485;6890.793276201722;6893.931060689329;6597.769078082244;6600.405963463311;6604.405603495708;6608.074869518176;6656.001599760075;6643.202815662152;6648.468122550281;6652.334766523309;6655.334466553306;6664;6272.937270627418;6450.838729031811;6517.185351831021;6522.608643481406;6528.934710652833;6622.701978410887;6658.467322614082;6670.066190733204;6673.499487538551;6674.26583075871;6424.839379015375;6488;6515.706793194412;6523.24982627004;6525.771597994048 06:11:58 INFO - PROCESS | 21877 | |5;yui.html;654.1986067067841;681.8022773395716;716.1191734166974;724.9855002899945;735.3602365941632;11694.824577631342;11816;11864.881351186486;11913.702157446069;13755.449782008733;13307.866921330808;13357.465701371933;13395.933020334885;13412.59762207133;13453.394597243123;808.3694718119876;810.3760104719363;810.8824220488056;813.3858936502932;813.9308158806508;803.6182813163759;804.493169303341;807.8828569857367;812.4678335690132;821.5809936932178;840.5377042626561;845.3659755183612;845.5856630251163;851.1743608699552;856.9571521423935;836.4395854777283;839.8320335932838;840.3907167303717;842.6081871929521;860.5009094725076;638.4381744065239;639.7696829141505;641.4579680170249;642.2036674523604;642.3415998601471;12682.239065655998;12720.427580758887;13398;13512.391942362618;13606.115602485806;11586.18896677233;11628;11804.52781888732;11850.585229517012;11888.465019074163;9673.854892176623;9764.90235097647;9774.413535187912;9848.803023939481;10100.040496152928;3475.3396854597545;3533.0990597397754;3586.7489275750445;3607.062163837395;3624.7281453891064;46737;47019.764901175615;47506.28740568894;47815;48000.55998320056;9058.266526089596;9286.767830804283;9413.790700683894;9430.243728521524;9511.191548718436;16955.15224238783;17029.829701702824;17182.828171718375;17291;17458.214380352914;6612.537122401386;6683.5989840608745;6705.061291419205;6736.8989465158065;6772.932270677329;3624.771768086429;3624.9456258156147;3639.0542828907983;3683.8710645127294;3733.757305775116;2995.221242476928;3011.2471882029495;3022.894198703079;3033.529802880557;3037.0888733379898;530.6179550723473;537.3202898333611;599.9970000150058;619.804761500126;622.4771192198575;542.6689719271242;543.6137848486344;554.3209568278826;567.7643777832153;575.8013485347549;7660.73187438437;7751.728689495841;7789.64946577394;7935.325497332791;7973.122956474783;469.8332092107321;489.2172523961704;495.8215042584667;535.9383670877821;572.2932178759229;3386.102682789063;3640.1081734974573;3680.411134218512;3705.3330400527625;3734.215814678948;57083.71458142766;58071.419285807446;58164.964226251876;58415.415845841846;58512.4148758507;50662.49337506578;51761.22358164631;52175.73912130491;52284.738576306874;52718.47281527136;46170.76914615405;46338.76830615825;46517.06965860732;46711.29933051007;46872.765636172284;7290.088738907637;7305.159906610807;7314.268573142643;7470.178280389044;7499.3516985498345;35078.12304692403;35151.12122196965;36076.4588531167;36145.27709445744;36387.08903287678;41520.377194341505;41528.37707434451;44586.77706611576;45953;46011.53988460206;9310;9414.717558473258;9435.386699864486;9471.619980489206;9861.211103111877;10206.948965255126;10363.792724145324;10367.844482332923;10425.0096240857;10623.575056997943;9160.954195228982;9312.860307095263;9473.66842160521;9631.759206019906;10238.539265733209;9540.904590954002;9596.23230141573;9656.275779316438;9912;9935.254855885982;9633.277504187354;9844.114029737359;9881.555330010024;10006.549705263425;10080.445575493419;8894.753028243686;8908.821823563621;9007.459552426875;9110.498922559324;9431.62273509052;8733.606987685442;9115.316351273814;9308.95345523268;9572.425654460754;9574.856377154209 06:11:58 INFO - PROCESS | 21877 | __end_tp_report 06:11:58 INFO - PROCESS | 21877 | __start_cc_report 06:11:58 INFO - PROCESS | 21877 | _x_x_mozilla_cycle_collect,334 06:11:58 INFO - PROCESS | 21877 | __end_cc_report 06:11:58 INFO - PROCESS | 21877 | __startTimestamp1457619118449__endTimestamp 06:11:58 INFO - PROCESS | 21877 | 06:11:58 INFO - PROCESS | 21877 | ------- Summary: start ------- 06:11:58 INFO - PROCESS | 21877 | Number of tests: 6 06:11:58 INFO - PROCESS | 21877 | 06:11:58 INFO - PROCESS | 21877 | [#0] dojo.html Cycles:165 Average:5319.31 Median:5507.92 stddev:594.95 (10.8%) stddev-sans-first:573.07 06:11:58 INFO - PROCESS | 21877 | Values: 3200.1 3237.3 3250.1 3256.7 3273.8 5302.4 5303.8 5332.4 5340.2 5369.9 5226.8 5286.9 5323.8 5326.9 5374.5 4809.1 4850.0 4898.4 4929.7 5034.8 4774.7 4816.4 4838.3 4876.3 4893.3 4750.4 4844.9 4924.7 4936.5 4953.9 4839.3 4869.6 4875.0 4889.9 4914.5 4772.9 4814.1 4853.6 4867.5 4909.9 5180.9 5193.1 5208.0 5209.1 5221.1 5724.1 5733.4 5741.2 5746.9 5747.8 5606.6 5721.8 5766.9 5774.3 5824.4 5391.7 5407.7 5423.6 5437.8 5452.3 5854.4 5867.4 5873.7 5878.3 5906.7 5560.3 5639.6 5655.5 5678.2 5684.3 5657.7 5720.9 5722.2 5749.7 5758.6 5687.5 5688.7 5692.3 5711.0 5727.5 5485.8 5684.5 5685.9 5703.6 5734.1 4329.7 4340.8 4352.8 4367.5 4380.5 3877.7 3907.7 3910.1 3921.9 3978.7 5353.2 5409.5 5425.5 5463.1 5485.0 5733.4 5748.5 5765.9 5782.6 5787.2 5429.2 5437.1 5448.1 5453.2 5455.8 4743.5 4829.2 4852.4 4852.7 4898.3 5972.0 6013.4 6014.2 6018.9 6025.1 5545.8 5702.0 5727.2 5728.3 5745.6 5982.3 6012.7 6027.7 6031.5 6076.6 5639.3 5640.3 5649.2 5654.5 5656.5 5567.3 5672.3 5732.6 5732.7 5742.0 5524.7 5586.0 5608.6 5644.4 5679.0 5539.2 5540.3 5590.2 5594.7 5595.8 5414.8 5492.6 5496.0 5503.7 5505.3 5568.3 5618.1 5627.9 5643.1 5644.9 5503.8 5507.9 5508.4 5514.7 5539.1 06:11:58 INFO - PROCESS | 21877 | 06:11:58 INFO - PROCESS | 21877 | [#1] ext.html Cycles:180 Average:54245.43 Median:36693.32 stddev:115064.56 (313.6%) stddev-sans-first:115316.53 06:11:58 INFO - PROCESS | 21877 | Values: 477.5 524.5 531.3 564.1 583.2 37180.1 37455.6 37654.6 37656.0 37664.0 42943.4 43557.6 43647.0 43678.3 43781.8 8628.4 8683.8 8756.0 8811.8 8819.9 8602.1 8771.3 8786.4 8792.5 8804.6 8690.0 8731.9 8747.3 8801.2 8846.2 8720.7 8782.9 8805.4 8810.1 8832.4 8649.6 8781.9 8792.5 8817.7 8830.2 40815.8 41044.6 41241.2 41364.2 41450.8 3141.4 3199.2 3212.8 3308.4 3420.6 30024.5 30786.4 31024.2 31088.4 31897.8 3143.3 3192.5 3228.5 3243.0 3344.4 270202.0 270420.0 270863.0 271155.0 271616.0 59330.0 59428.0 59701.0 59793.1 59805.4 67451.3 68576.0 68713.3 68735.0 68848.3 15931.8 15972.0 16102.0 16102.9 16156.8 11953.2 11963.6 11978.4 11979.8 11989.2 19608.4 20098.9 20134.4 20205.2 20947.4 8010.0 8203.3 8229.9 8293.9 8419.0 958.8 974.9 982.8 1043.8 1115.7 28404.4 29393.7 29429.6 29746.4 29809.4 1001.2 1003.7 1011.6 1030.9 1046.6 13875.7 14013.4 14311.3 14401.8 14422.3 321603.0 693718.0 695967.0 698960.0 703545.0 54464.5 54677.0 54746.5 55020.7 55188.7 1378.8 1383.7 1386.4 1396.0 1396.2 29106.6 30243.8 30671.2 30842.1 30927.0 46234.0 47082.8 47119.0 47154.5 47166.3 251880.0 253925.0 255253.0 256216.0 258690.0 32255.7 32435.5 32711.2 32797.7 32816.7 42356.8 43090.3 43411.6 43570.3 44028.6 36689.8 36696.8 36919.0 37164.4 37252.8 36145.7 36356.8 36907.8 36954.3 37152.6 30514.0 35407.0 35517.3 36013.6 36571.6 28732.3 28886.1 28939.0 29174.6 29304.4 22836.9 22879.8 22993.2 23041.9 23246.0 06:11:58 INFO - PROCESS | 21877 | 06:11:58 INFO - PROCESS | 21877 | [#2] jquery.html Cycles:180 Average:25350.71 Median:221979.39 stddev:72374.47 (32.6%) stddev-sans-first:72553.14 06:11:58 INFO - PROCESS | 21877 | Values: 343.0 357.7 357.8 359.1 362.6 16416.0 16773.3 17353.1 17370.1 17466.0 15852.7 15969.6 15998.9 16215.6 16521.3 5287.5 5297.8 5445.8 5520.8 5579.8 4437.0 5581.1 5596.6 5608.8 5618.7 5294.8 5500.3 5522.0 5524.2 5537.9 5465.0 5467.0 5474.3 5476.5 5507.7 4896.6 4911.3 4929.0 4942.9 4982.6 13053.4 13138.7 13244.1 13252.2 13252.8 1998.6 2085.8 2110.7 2284.7 2319.9 8899.0 9035.1 9515.5 9631.9 9665.5 1778.7 1843.7 1857.3 1876.3 1900.7 51115.5 59685.4 62064.4 64401.7 68046.0 10036.7 10160.9 10368.7 10482.3 10540.2 14102.9 14189.2 14235.9 14266.6 14299.6 7620.8 7636.6 7653.8 7667.7 8030.8 7312.9 7428.9 7455.5 7600.2 7716.3 4549.6 4672.9 4684.8 4699.0 4704.8 1833.3 1844.3 1852.8 1866.1 1870.8 890.2 909.3 912.0 944.6 1034.6 16317.9 16565.0 16692.2 17144.7 17200.8 916.9 917.7 925.9 955.3 994.5 9540.5 9821.1 9890.5 9916.3 10007.4 431557.0 435198.0 438722.0 443517.0 454740.0 74356.6 76444.0 76697.0 78594.0 81712.0 441.8 456.3 456.8 456.9 458.4 10019.4 10423.0 10484.9 10585.5 11181.3 33388.0 34541.3 34648.1 34760.7 35560.0 49095.3 51161.5 51820.5 52083.7 52343.1 8180.3 8298.5 8470.0 8519.1 8624.1 12235.9 12607.3 12831.9 13062.5 13183.3 10960.9 11272.2 11333.9 11404.5 11600.3 11154.7 11309.2 11480.3 11578.4 11668.6 11266.4 11382.3 11424.8 11749.6 11754.1 7613.7 7868.3 8197.9 8235.7 8735.5 10846.6 11261.3 11277.7 11293.3 11477.8 06:11:58 INFO - PROCESS | 21877 | 06:11:58 INFO - PROCESS | 21877 | [#3] mootools.html Cycles:180 Average:5527.22 Median:6344.17 stddev:2913.15 (45.9%) stddev-sans-first:2905.50 06:11:58 INFO - PROCESS | 21877 | Values: 1488.0 1503.0 1678.1 1786.9 1813.0 7151.9 7816.3 7920.6 8193.9 8214.2 7916.4 7983.6 8072.1 8094.4 8116.0 2243.2 2271.3 2273.3 2277.9 2282.9 2240.9 2247.5 2281.9 2285.1 2292.0 2212.1 2239.5 2254.2 2260.7 2272.2 2300.8 2311.1 2315.5 2319.1 2323.3 2333.2 2350.0 2351.0 2355.7 2362.0 8079.4 8165.8 8168.3 8188.8 8206.4 4791.2 4883.8 4907.5 4912.7 4929.9 3024.5 3028.0 3138.9 3144.8 3148.4 954.4 956.2 958.6 963.3 976.7 10517.9 10534.4 10542.3 10600.5 10643.4 4283.7 4303.2 4358.2 4390.1 4422.3 9035.1 9095.3 9102.7 9115.0 9130.8 4821.2 4855.2 4868.3 4874.8 4898.7 4049.7 4438.0 4461.8 4466.4 4546.2 3699.5 3767.8 3785.3 3794.1 3798.3 1206.0 1221.4 1227.8 1231.5 1232.3 1300.4 1302.0 1304.9 1308.6 1339.5 7421.0 7481.7 7710.7 7727.0 7747.0 473.2 474.8 474.9 476.2 489.2 5374.9 5406.0 5425.0 5438.2 5479.4 9537.5 9641.1 9988.0 10039.5 10096.8 9694.7 9803.6 9848.9 9876.0 9897.1 7028.8 7218.2 7263.7 7276.3 7678.7 7466.3 7538.4 7602.8 7622.8 7635.6 8719.1 8758.3 8841.1 8864.0 8993.8 8952.0 8988.0 9072.9 9082.1 9120.7 6166.2 6752.0 6822.5 7202.9 7274.1 7407.9 7436.3 7442.8 7499.2 7499.3 6566.4 6701.0 6715.2 6801.2 6866.8 6430.3 6446.5 6485.4 6494.5 6536.5 7004.2 7043.4 7092.8 7102.2 7148.7 6344.4 6433.2 6444.2 6459.7 6468.4 6285.5 6317.0 6344.0 6356.5 6357.2 06:11:58 INFO - PROCESS | 21877 | 06:11:58 INFO - PROCESS | 21877 | [#4] prototype.html Cycles:180 Average:5491.56 Median:6300.50 stddev:1731.92 (27.5%) stddev-sans-first:1692.67 06:11:58 INFO - PROCESS | 21877 | Values: 316.9 322.9 324.4 328.7 335.3 6223.4 6259.2 6293.5 6299.7 6325.2 6145.2 6204.8 6218.2 6223.6 6231.3 4515.6 4576.0 4598.9 4607.3 4777.1 4592.1 4602.8 4608.6 4612.3 4614.4 4517.3 4527.4 4554.7 4557.7 4559.3 4542.5 4550.8 4553.2 4553.8 4576.5 3932.6 3933.6 3938.5 3941.4 3944.7 5919.9 5939.6 5958.0 5962.9 5974.9 5198.2 5325.1 5342.3 5388.6 5406.2 6497.4 6541.0 6543.4 6550.1 6589.7 4401.6 4402.8 4405.5 4419.9 4431.2 6811.0 6824.1 6871.6 6900.1 6900.9 4399.0 4419.7 4426.9 4428.4 4434.1 4378.6 4491.0 4502.0 4507.5 4511.4 5341.3 5355.5 5356.8 5364.8 5367.2 6639.5 6658.5 6664.9 6673.1 6683.5 1596.1 1619.4 1620.4 1621.3 1623.8 992.0 1010.7 1024.9 1031.6 1043.1 6301.2 6301.3 6334.6 6344.4 6372.9 6772.2 6791.3 6819.7 6830.5 6835.0 6126.0 6254.5 6309.1 6364.6 6437.4 3692.6 3710.6 3716.9 3721.5 3726.1 7300.0 7302.1 7313.9 7333.6 7337.0 7019.0 7048.5 7064.8 7075.7 7081.3 7103.4 7224.7 7245.2 7299.4 7329.8 6830.6 6859.9 6861.3 6861.6 6867.9 6766.0 6797.1 6809.9 6833.0 6850.5 7276.8 7278.6 7298.0 7305.7 7309.1 4395.6 4498.1 4498.2 4498.3 4519.2 6832.7 6886.2 6887.7 6890.8 6893.9 6597.8 6600.4 6604.4 6608.1 6656.0 6643.2 6648.5 6652.3 6655.3 6664.0 6272.9 6450.8 6517.2 6522.6 6528.9 6622.7 6658.5 6670.1 6673.5 6674.3 6424.8 6488.0 6515.7 6523.2 6525.8 06:11:58 INFO - PROCESS | 21877 | 06:11:58 INFO - PROCESS | 21877 | [#5] yui.html Cycles:180 Average:13332.61 Median:574.05 stddev:16097.48 (2804.2%) stddev-sans-first:16114.48 06:11:58 INFO - PROCESS | 21877 | Values: 654.2 681.8 716.1 725.0 735.4 11694.8 11816.0 11864.9 11913.7 13755.4 13307.9 13357.5 13395.9 13412.6 13453.4 808.4 810.4 810.9 813.4 813.9 803.6 804.5 807.9 812.5 821.6 840.5 845.4 845.6 851.2 857.0 836.4 839.8 840.4 842.6 860.5 638.4 639.8 641.5 642.2 642.3 12682.2 12720.4 13398.0 13512.4 13606.1 11586.2 11628.0 11804.5 11850.6 11888.5 9673.9 9764.9 9774.4 9848.8 10100.0 3475.3 3533.1 3586.7 3607.1 3624.7 46737.0 47019.8 47506.3 47815.0 48000.6 9058.3 9286.8 9413.8 9430.2 9511.2 16955.2 17029.8 17182.8 17291.0 17458.2 6612.5 6683.6 6705.1 6736.9 6772.9 3624.8 3624.9 3639.1 3683.9 3733.8 2995.2 3011.2 3022.9 3033.5 3037.1 530.6 537.3 600.0 619.8 622.5 542.7 543.6 554.3 567.8 575.8 7660.7 7751.7 7789.6 7935.3 7973.1 469.8 489.2 495.8 535.9 572.3 3386.1 3640.1 3680.4 3705.3 3734.2 57083.7 58071.4 58165.0 58415.4 58512.4 50662.5 51761.2 52175.7 52284.7 52718.5 46170.8 46338.8 46517.1 46711.3 46872.8 7290.1 7305.2 7314.3 7470.2 7499.4 35078.1 35151.1 36076.5 36145.3 36387.1 41520.4 41528.4 44586.8 45953.0 46011.5 9310.0 9414.7 9435.4 9471.6 9861.2 10206.9 10363.8 10367.8 10425.0 10623.6 9161.0 9312.9 9473.7 9631.8 10238.5 9540.9 9596.2 9656.3 9912.0 9935.3 9633.3 9844.1 9881.6 10006.5 10080.4 8894.8 8908.8 9007.5 9110.5 9431.6 8733.6 9115.3 9309.0 9572.4 9574.9 06:11:58 INFO - PROCESS | 21877 | -------- Summary: end -------- 06:11:58 INFO - PROCESS | 21877 | 06:11:59 INFO - TEST-INFO | 21877: exit 0 06:11:59 INFO - TEST-OK | dromaeo_css | took 1111199ms 06:11:59 INFO - TEST-START | kraken 06:11:59 INFO - operating with platform_type : linux_ 06:11:59 INFO - Initialising browser for kraken test... 06:11:59 INFO - TEST-INFO | started process 22115 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpi8e1WZ/profile http://localhost:57489/getInfo.html) 06:12:02 INFO - PROCESS | 22115 | 06:12:02 INFO - PROCESS | 22115 | (process:22184): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:12:03 INFO - PROCESS | 22115 | __metrics Screen width/height:1600/1200 06:12:03 INFO - PROCESS | 22115 | colorDepth:24 06:12:03 INFO - PROCESS | 22115 | Browser inner width/height: 1024/697 06:12:03 INFO - PROCESS | 22115 | __metrics 06:12:04 ERROR - PROCESS | 22115 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 06:12:05 INFO - TEST-INFO | 22115: exit 0 06:12:05 INFO - Browser initialized. 06:12:05 INFO - Running cycle 1/1 for kraken test... 06:12:05 INFO - TEST-INFO | started process 22236 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpi8e1WZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:12:07 INFO - PROCESS | 22236 | 06:12:07 INFO - PROCESS | 22236 | (process:22297): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:12:17 INFO - PROCESS | 22236 | RSS: Main: 166584320 06:12:17 INFO - PROCESS | 22236 | 06:12:19 INFO - PROCESS | 22236 | Cycle 1(1): loaded http://localhost:57489/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57489/tests/kraken/driver.html?testName=audio-beat-detection) 06:12:20 INFO - PROCESS | 22236 | RSS: Main: 170651648 06:12:20 INFO - PROCESS | 22236 | 06:12:22 INFO - PROCESS | 22236 | Cycle 1(1): loaded http://localhost:57489/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57489/tests/kraken/driver.html?testName=audio-dft) 06:12:23 INFO - PROCESS | 22236 | RSS: Main: 172195840 06:12:23 INFO - PROCESS | 22236 | 06:12:26 INFO - PROCESS | 22236 | Cycle 1(1): loaded http://localhost:57489/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57489/tests/kraken/driver.html?testName=audio-fft) 06:12:26 INFO - PROCESS | 22236 | RSS: Main: 166076416 06:12:26 INFO - PROCESS | 22236 | 06:12:29 INFO - PROCESS | 22236 | Cycle 1(1): loaded http://localhost:57489/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57489/tests/kraken/driver.html?testName=audio-oscillator) 06:12:29 INFO - PROCESS | 22236 | RSS: Main: 165732352 06:12:29 INFO - PROCESS | 22236 | 06:12:31 INFO - PROCESS | 22236 | Cycle 1(1): loaded http://localhost:57489/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57489/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:12:32 INFO - PROCESS | 22236 | RSS: Main: 167043072 06:12:32 INFO - PROCESS | 22236 | 06:12:35 INFO - PROCESS | 22236 | Cycle 1(1): loaded http://localhost:57489/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57489/tests/kraken/driver.html?testName=imaging-darkroom) 06:12:36 INFO - PROCESS | 22236 | RSS: Main: 166711296 06:12:36 INFO - PROCESS | 22236 | 06:12:39 INFO - PROCESS | 22236 | Cycle 1(1): loaded http://localhost:57489/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57489/tests/kraken/driver.html?testName=imaging-desaturate) 06:12:40 INFO - PROCESS | 22236 | RSS: Main: 167378944 06:12:40 INFO - PROCESS | 22236 | 06:12:43 INFO - PROCESS | 22236 | Cycle 1(1): loaded http://localhost:57489/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57489/tests/kraken/driver.html?testName=json-parse-financial) 06:12:43 INFO - PROCESS | 22236 | RSS: Main: 169779200 06:12:43 INFO - PROCESS | 22236 | 06:12:45 INFO - PROCESS | 22236 | Cycle 1(1): loaded http://localhost:57489/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57489/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:12:45 INFO - PROCESS | 22236 | RSS: Main: 171024384 06:12:45 INFO - PROCESS | 22236 | 06:12:47 INFO - PROCESS | 22236 | Cycle 1(1): loaded http://localhost:57489/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57489/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:12:48 INFO - PROCESS | 22236 | RSS: Main: 170029056 06:12:48 INFO - PROCESS | 22236 | 06:12:50 INFO - PROCESS | 22236 | Cycle 1(1): loaded http://localhost:57489/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57489/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:12:50 INFO - PROCESS | 22236 | RSS: Main: 170594304 06:12:50 INFO - PROCESS | 22236 | 06:12:53 INFO - PROCESS | 22236 | Cycle 1(1): loaded http://localhost:57489/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57489/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:12:54 INFO - PROCESS | 22236 | RSS: Main: 170393600 06:12:54 INFO - PROCESS | 22236 | 06:12:56 INFO - PROCESS | 22236 | Cycle 1(1): loaded http://localhost:57489/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57489/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:12:57 INFO - PROCESS | 22236 | RSS: Main: 170315776 06:12:57 INFO - PROCESS | 22236 | 06:12:58 INFO - PROCESS | 22236 | Cycle 1(1): loaded http://localhost:57489/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57489/tests/kraken/driver.html?testName=ai-astar) 06:12:59 INFO - PROCESS | 22236 | RSS: Main: 172113920 06:12:59 INFO - PROCESS | 22236 | 06:12:59 INFO - PROCESS | 22236 | __start_tp_report 06:12:59 INFO - PROCESS | 22236 | _x_x_mozilla_page_load 06:12:59 INFO - PROCESS | 22236 | _x_x_mozilla_page_load_details 06:12:59 INFO - PROCESS | 22236 | |i|pagename|runs| 06:12:59 INFO - PROCESS | 22236 | |0;ai-astar;111;105;111;109;113;122;110;109;110;111 06:12:59 INFO - PROCESS | 22236 | |1;audio-beat-detection;158;127;150;171;131;150;153;132;166;126 06:12:59 INFO - PROCESS | 22236 | |2;audio-dft;163;162;164;161;161;161;161;164;170;163 06:12:59 INFO - PROCESS | 22236 | |3;audio-fft;75;72;98;77;75;75;74;74;134;76 06:12:59 INFO - PROCESS | 22236 | |4;audio-oscillator;94;93;149;95;97;94;152;94;94;150 06:12:59 INFO - PROCESS | 22236 | |5;imaging-gaussian-blur;118;118;117;117;117;117;117;117;117;117 06:12:59 INFO - PROCESS | 22236 | |6;imaging-darkroom;147;146;147;145;147;147;146;147;149;146 06:12:59 INFO - PROCESS | 22236 | |7;imaging-desaturate;97;96;96;97;96;96;96;101;96;97 06:12:59 INFO - PROCESS | 22236 | |8;json-parse-financial;59;59;60;59;60;60;64;61;58;59 06:12:59 INFO - PROCESS | 22236 | |9;json-stringify-tinderbox;69;68;69;68;69;70;69;69;69;69 06:12:59 INFO - PROCESS | 22236 | |10;stanford-crypto-aes;83;82;83;82;84;82;83;82;82;83 06:12:59 INFO - PROCESS | 22236 | |11;stanford-crypto-ccm;126;115;124;116;129;127;116;116;119;118 06:12:59 INFO - PROCESS | 22236 | |12;stanford-crypto-pbkdf2;142;157;150;154;153;162;153;150;150;142 06:12:59 INFO - PROCESS | 22236 | |13;stanford-crypto-sha256-iterative;71;70;70;74;71;69;72;72;72;70 06:12:59 INFO - PROCESS | 22236 | __end_tp_report 06:12:59 INFO - PROCESS | 22236 | __start_cc_report 06:12:59 INFO - PROCESS | 22236 | _x_x_mozilla_cycle_collect,827 06:12:59 INFO - PROCESS | 22236 | __end_cc_report 06:12:59 INFO - PROCESS | 22236 | __startTimestamp1457619179207__endTimestamp 06:12:59 INFO - PROCESS | 22236 | 06:12:59 INFO - PROCESS | 22236 | ------- Summary: start ------- 06:12:59 INFO - PROCESS | 22236 | Number of tests: 14 06:12:59 INFO - PROCESS | 22236 | 06:12:59 INFO - PROCESS | 22236 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:4.36 (3.9%) stddev-sans-first:4.62 06:12:59 INFO - PROCESS | 22236 | Values: 111.0 105.0 111.0 109.0 113.0 122.0 110.0 109.0 110.0 111.0 06:12:59 INFO - PROCESS | 22236 | 06:12:59 INFO - PROCESS | 22236 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:151.50 stddev:16.43 (10.8%) stddev-sans-first:16.89 06:12:59 INFO - PROCESS | 22236 | Values: 158.0 127.0 150.0 171.0 131.0 150.0 153.0 132.0 166.0 126.0 06:12:59 INFO - PROCESS | 22236 | 06:12:59 INFO - PROCESS | 22236 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:2.75 (1.7%) stddev-sans-first:2.92 06:12:59 INFO - PROCESS | 22236 | Values: 163.0 162.0 164.0 161.0 161.0 161.0 161.0 164.0 170.0 163.0 06:12:59 INFO - PROCESS | 22236 | 06:12:59 INFO - PROCESS | 22236 | [#3] audio-fft Cycles:10 Average:83.00 Median:75.00 stddev:19.40 (25.9%) stddev-sans-first:20.36 06:12:59 INFO - PROCESS | 22236 | Values: 75.0 72.0 98.0 77.0 75.0 75.0 74.0 74.0 134.0 76.0 06:12:59 INFO - PROCESS | 22236 | 06:12:59 INFO - PROCESS | 22236 | [#4] audio-oscillator Cycles:10 Average:111.20 Median:94.00 stddev:27.03 (28.8%) stddev-sans-first:27.95 06:12:59 INFO - PROCESS | 22236 | Values: 94.0 93.0 149.0 95.0 97.0 94.0 152.0 94.0 94.0 150.0 06:12:59 INFO - PROCESS | 22236 | 06:12:59 INFO - PROCESS | 22236 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 06:12:59 INFO - PROCESS | 22236 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 06:12:59 INFO - PROCESS | 22236 | 06:12:59 INFO - PROCESS | 22236 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 06:12:59 INFO - PROCESS | 22236 | Values: 147.0 146.0 147.0 145.0 147.0 147.0 146.0 147.0 149.0 146.0 06:12:59 INFO - PROCESS | 22236 | 06:12:59 INFO - PROCESS | 22236 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.00 stddev:1.55 (1.6%) stddev-sans-first:1.64 06:12:59 INFO - PROCESS | 22236 | Values: 97.0 96.0 96.0 97.0 96.0 96.0 96.0 101.0 96.0 97.0 06:12:59 INFO - PROCESS | 22236 | 06:12:59 INFO - PROCESS | 22236 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:60.00 stddev:1.66 (2.8%) stddev-sans-first:1.73 06:12:59 INFO - PROCESS | 22236 | Values: 59.0 59.0 60.0 59.0 60.0 60.0 64.0 61.0 58.0 59.0 06:12:59 INFO - PROCESS | 22236 | 06:12:59 INFO - PROCESS | 22236 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 06:12:59 INFO - PROCESS | 22236 | Values: 69.0 68.0 69.0 68.0 69.0 70.0 69.0 69.0 69.0 69.0 06:12:59 INFO - PROCESS | 22236 | 06:12:59 INFO - PROCESS | 22236 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 06:12:59 INFO - PROCESS | 22236 | Values: 83.0 82.0 83.0 82.0 84.0 82.0 83.0 82.0 82.0 83.0 06:12:59 INFO - PROCESS | 22236 | 06:12:59 INFO - PROCESS | 22236 | [#11] stanford-crypto-ccm Cycles:10 Average:120.60 Median:121.50 stddev:5.34 (4.4%) stddev-sans-first:5.29 06:12:59 INFO - PROCESS | 22236 | Values: 126.0 115.0 124.0 116.0 129.0 127.0 116.0 116.0 119.0 118.0 06:12:59 INFO - PROCESS | 22236 | 06:12:59 INFO - PROCESS | 22236 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.30 Median:153.00 stddev:6.13 (4.0%) stddev-sans-first:5.50 06:12:59 INFO - PROCESS | 22236 | Values: 142.0 157.0 150.0 154.0 153.0 162.0 153.0 150.0 150.0 142.0 06:12:59 INFO - PROCESS | 22236 | 06:12:59 INFO - PROCESS | 22236 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:71.50 stddev:1.45 (2.0%) stddev-sans-first:1.54 06:12:59 INFO - PROCESS | 22236 | Values: 71.0 70.0 70.0 74.0 71.0 69.0 72.0 72.0 72.0 70.0 06:12:59 INFO - PROCESS | 22236 | -------- Summary: end -------- 06:12:59 INFO - PROCESS | 22236 | 06:13:00 INFO - TEST-INFO | 22236: exit 0 06:13:00 INFO - TEST-OK | kraken | took 61100ms 06:13:00 INFO - SUITE-END | took 1172s 06:13:00 INFO - Completed test suite (00:19:32) 06:13:00 INFO - javascript benchmark 06:13:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3200.0559834848723, 3237.2877966847286, 3250.106220789283, 3256.6743325667435, 3273.819939903306, 5302.363716354038, 5303.840884773454, 5332.3601167859815, 5340.225667278242, 5369.9463005369935, 5226.764795584208, 5286.947130528693, 5323.760430780614, 5326.946730532693, 5374.516293533581, 4809.110314591803, 4849.999999999983, 4898.41219053714, 4929.704217746928, 5034.773435195425, 4774.665773395864, 4816.373871396713, 4838.322634831126, 4876.317315575822, 4893.266010098496, 4750.429948406196, 4844.903101937959, 4924.679895806761, 4936.48166942473, 4953.876153096166, 4839.27410888366, 4869.586085182764, 4874.975625121851, 4889.8777530561665, 4914.533119353656, 4772.880677983044, 4814.06125805468, 4853.611711063107, 4867.464578896319, 4909.852704418873, 5180.8963820723375, 5193.091209038404, 5208.0, 5209.114450543417, 5221.086309895753, 5724.055530837407, 5733.397993210695, 5741.167530708024, 5746.913796293059, 5747.827565173052, 5606.635568688063, 5721.828345149652, 5766.913496297559, 5774.335951365605, 5824.359320474744, 5391.676499410009, 5407.70257635826, 5423.647462914937, 5437.755301011464, 5452.318460192476, 5854.414558544197, 5867.442592953663, 5873.735681894325, 5878.294604647384, 5906.734196961147, 5560.304961879765, 5639.6334238274385, 5655.462731040545, 5678.205051292823, 5684.317881854204, 5657.717114144276, 5720.942790572041, 5722.170285308607, 5749.712514374348, 5758.596898217084, 5687.544996400278, 5688.744006519716, 5692.31692196939, 5710.971445142831, 5727.5131613812455, 5485.753141108659, 5684.459976302244, 5685.948099601587, 5703.572232082611, 5734.082546792493, 4329.718568293114, 4340.782960851945, 4352.847650332224, 4367.519572846984, 4380.452443444569, 3877.651011408987, 3907.667848232932, 3910.1006768443417, 3921.9019524512114, 3978.661813745864, 5353.197020446964, 5409.486098820606, 5425.538829199562, 5463.125899856004, 5485.01269771445, 5733.397993210653, 5748.45389687979, 5765.913511297334, 5782.59521833476, 5787.160861675117, 5429.239906413105, 5437.075697131497, 5448.101063324507, 5453.15476101205, 5455.8363249102595, 4743.549362810528, 4829.203181475087, 4852.393450818577, 4852.684575502581, 4898.2652602109965, 5972.0, 6013.398660133952, 6014.248218972629, 6018.939810601838, 6025.126356678345, 5545.750441230073, 5701.971490142523, 5727.1695604138, 5728.312602487728, 5745.626534275259, 5982.282126144891, 6012.6993650316435, 6027.6986150693165, 6031.517478601789, 6076.574639775174, 5639.3232812062815, 5640.266765320482, 5649.209110724584, 5654.46282603152, 5656.547476201812, 5567.2762540871045, 5672.319321681424, 5732.59871808986, 5732.656040637575, 5742.0, 5524.66851988882, 5585.972070139624, 5608.551315894801, 5644.435556444487, 5679.034564124191, 5539.224508568723, 5540.335159780852, 5590.161475778503, 5594.692291923983, 5595.832125036255, 5414.756335964812, 5492.5605951524585, 5496.0, 5503.6697798130635, 5505.284313039279, 5568.303962004749, 5618.073017952155, 5627.8874422512135, 5643.068893632505, 5644.85887852807, 5503.7798488060025, 5507.917381239205, 5508.394076651485, 5514.6691198528215, 5539.086050801734], "unit": "score", "name": "dojo.html", "value": 5280.684574714212}, {"lowerIsBetter": false, "replicates": [477.52009230723115, 524.4702850121378, 531.2535887078653, 564.1284215886457, 583.2213994317585, 37180.07049823756, 37455.62544374556, 37654.62345376549, 37656.0, 37664.0, 42943.3558496622, 43557.56442435575, 43647.0, 43678.344824827574, 43781.7810910945, 8628.352873534479, 8683.782905427352, 8756.0, 8811.77970550735, 8819.911800882006, 8602.09677983812, 8771.254443372321, 8786.384953053288, 8792.47245165292, 8804.64781408743, 8689.95655021724, 8731.912680873173, 8747.256483198937, 8801.207891289783, 8846.15961483658, 8720.694775682852, 8782.912170878337, 8805.427647202976, 8810.118988101203, 8832.425892316978, 8649.567521623894, 8781.912180878173, 8792.472451652857, 8817.691380801642, 8830.161134692195, 40815.7959210205, 41044.58955410437, 41241.175176496305, 41364.1727165458, 41450.79274603638, 3141.4345417824784, 3199.216192032967, 3212.791168574035, 3308.387948229585, 3420.572428446444, 30024.54963175554, 30786.38427231443, 31024.224394390094, 31088.378232435225, 31897.84051079753, 3143.3241853001487, 3192.537082123102, 3228.4673028950197, 3242.9837850810595, 3344.4314466540745, 270202.0, 270420.0, 270863.0, 271155.0, 271616.0, 59330.0, 59428.0, 59701.0, 59793.10310345348, 59805.401945980855, 67451.32548674548, 68576.0, 68713.3128668717, 68735.0, 68848.3115168852, 15931.840681593036, 15972.0, 16102.0, 16102.919485402497, 16156.838431615768, 11953.22304050234, 11963.64109076729, 11978.401079945968, 11979.820302695467, 11989.160758746804, 19608.411747647595, 20098.894560799297, 20134.395968120978, 20205.191792328143, 20947.37157885266, 8009.959950200212, 8203.30271926881, 8229.876551851727, 8293.875591866126, 8419.0, 958.8034452937131, 974.8927617962019, 982.7739619887323, 1043.7599352149048, 1115.7200700913756, 28404.43191136166, 29393.706062939524, 29429.55855662167, 29746.40507189844, 29809.40381192364, 1001.1840350114634, 1003.7289931718395, 1011.600417834951, 1030.9175265978704, 1046.56567524478, 13875.653108672162, 14013.439462421593, 14311.284435778169, 14401.78397324041, 14422.278886055656, 321603.0, 693718.0, 695967.0, 698960.0, 703545.0, 54464.45535544673, 54677.0, 54746.452535474935, 55020.724896376065, 55188.72405637946, 1378.7518246715488, 1383.6540864783803, 1386.4471791593278, 1395.9720805584034, 1396.1762560089596, 29106.56340154857, 30243.848780755954, 30671.2332191697, 30842.074737757903, 30927.0, 46234.0, 47082.76458617685, 47119.0, 47154.528454715015, 47166.29250561176, 251880.0, 253925.0, 255253.0, 256216.0, 258690.0, 32255.677443225268, 32435.513467298482, 32711.182220443727, 32797.672023280415, 32816.671833282315, 42356.788216058725, 43090.28402390538, 43411.56588434202, 43570.34644480272, 44028.55971440244, 36689.81655091707, 36696.81651591725, 36919.0, 37164.44253336148, 37252.813735931144, 36145.66772655029, 36356.81821590875, 36907.815460922524, 36954.26091478209, 37152.62847371492, 30514.0, 35407.0, 35517.289654207285, 36013.63986360103, 36571.634283657884, 28732.281692957844, 28886.133415997552, 28939.0, 29174.56238156387, 29304.413911721218, 22836.885815570815, 22879.77120228843, 22993.195238166583, 23041.88479057594, 23246.0], "unit": "score", "name": "ext.html", "value": 18779.322544699444}, {"lowerIsBetter": false, "replicates": [342.96398878117793, 357.7370632585051, 357.7799653213273, 359.1344858890075, 362.59932774284414, 16416.0, 16773.329066837327, 17353.13234338283, 17370.13149342531, 17466.0, 15852.682946341067, 15969.600759980976, 15998.920005399987, 16215.594610134753, 16521.256543455544, 5287.524122828954, 5297.841064768044, 5445.754941027663, 5520.779168833242, 5579.804706835262, 4436.97781511092, 5581.107022876341, 5596.552275817925, 5608.803691870786, 5618.747156377953, 5294.755732402882, 5500.257465242201, 5521.972390138064, 5524.226608274845, 5537.889242215153, 5465.016297066526, 5467.043267428184, 5474.315710536183, 5476.507114359707, 5507.697076660782, 4896.632752543574, 4911.336969509106, 4928.950710492885, 4942.851714448572, 4982.551570358685, 13053.412596433183, 13138.737225255538, 13244.072914895962, 13252.20486770797, 13252.801207981887, 1998.600279944017, 2085.7705652378227, 2110.7361579802523, 2284.680144779732, 2319.9188028419094, 8899.0, 9035.096490350978, 9515.476648784314, 9631.90368096317, 9665.516724163834, 1778.6976214043643, 1843.7142242952364, 1857.322077441724, 1876.2682553804027, 1900.7053906644492, 51115.48884511182, 59685.40314596842, 62064.379356206315, 64401.677991609744, 68046.0, 10036.749081273027, 10160.898391016142, 10368.688939331832, 10482.266241363184, 10540.156787456985, 14102.85897141036, 14189.219592922282, 14235.928820355832, 14266.643333916734, 14299.57101286963, 7620.771376858703, 7636.618169091523, 7653.808654783564, 7667.654955527015, 8030.83938321242, 7312.853742925112, 7428.925710742931, 7455.515391499644, 7600.1639819619795, 7716.2669546393, 4549.567791059844, 4672.948586567995, 4684.8360307389075, 4699.0, 4704.835330763475, 1833.3216709817452, 1844.2807305151002, 1852.7869295030973, 1866.0576408913682, 1870.7755069391487, 890.2299510923134, 909.3134683314188, 911.9863202051974, 944.6079876851168, 1034.6171916390983, 16317.918410407872, 16565.0, 16692.24884880183, 17144.742828857576, 17200.82799171992, 916.8578870275118, 917.6833992272656, 925.8518637018179, 955.2739917662487, 994.5126887824914, 9540.475273860004, 9821.116099551075, 9890.456024918698, 9916.25628077897, 10007.399556026661, 431557.0, 435198.0, 438722.0, 443517.0, 454740.0, 74356.62821685857, 76444.0, 76697.0, 78594.0, 81712.0, 441.7872938783061, 456.3041361923094, 456.75761927556994, 456.915470637933, 458.3972076719104, 10019.398836069859, 10423.0, 10484.947575262075, 10585.470726463493, 11181.273217240854, 33387.99508044287, 34541.30917381689, 34648.13379665528, 34760.65239347574, 35560.0, 49095.26357104718, 51161.48838511567, 51820.481795181564, 52083.73958130185, 52343.130655898, 8180.263776260165, 8298.543580103153, 8470.0, 8519.148085191679, 8624.051354351142, 12235.93882030584, 12607.306598137191, 12831.871681283068, 13062.54281100195, 13183.340832958505, 10960.945195273973, 11272.210945233755, 11333.943330283295, 11404.48679809427, 11600.30398176112, 11154.721131971766, 11309.208355415041, 11480.253783504046, 11578.42107894585, 11668.591599293984, 11266.436678165896, 11382.260153090023, 11424.771504570028, 11749.647510574354, 11754.05967522579, 7613.6573854177805, 7868.331191848528, 8197.877031844646, 8235.711750088718, 8735.519546425008, 10846.566137354417, 11261.268017578832, 11277.71805704864, 11293.322400655987, 11477.770444591228], "unit": "score", "name": "jquery.html", "value": 8131.241079132055}, {"lowerIsBetter": false, "replicates": [1488.032778693849, 1503.030545298283, 1678.127373765642, 1786.8838525495835, 1812.9637407251846, 7151.892721609167, 7816.296533312001, 7920.564368959705, 8193.87709184362, 8214.178582141783, 7916.40626952978, 7983.640736166872, 8072.112067672551, 8094.392920530969, 8116.0, 2243.2260869999823, 2271.3072512883564, 2273.283915566591, 2277.8633282003134, 2282.8858557072163, 2240.932772016842, 2247.494313779403, 2281.851679640818, 2285.0631241191113, 2292.002978704261, 2212.1372664660717, 2239.484918468753, 2254.1884921428273, 2260.728712554496, 2272.216085450517, 2300.781425764558, 2311.0524684879288, 2315.5253173099472, 2319.072371051576, 2323.256557901472, 2333.241696448661, 2349.964750528726, 2351.036075209156, 2355.6819829323163, 2362.0315670575155, 8079.434439589231, 8165.75502734913, 8168.305694016016, 8188.836223275501, 8206.384521160937, 4791.185498465269, 4883.804647814083, 4907.533784290486, 4912.70523768575, 4929.852104436873, 3024.5311976643657, 3027.969720302791, 3138.8587513561943, 3144.811311321328, 3148.354587309596, 954.4082668745423, 956.1585804492072, 958.5973890965811, 963.2967933408651, 976.7216343342185, 10517.947410262976, 10534.36793792375, 10542.314749541332, 10600.469976501145, 10643.361398316125, 4283.700140990163, 4303.1608836277255, 4358.21552120615, 4390.143921935192, 4422.314541246112, 9035.096490350912, 9095.272378209727, 9102.681406150752, 9115.0, 9130.817383652422, 4821.180399332122, 4855.174620314555, 4868.342773725572, 4874.829380971649, 4898.657094003457, 4049.655779258796, 4438.0, 4461.776911154429, 4466.3747075409465, 4546.227141385973, 3699.5375578052744, 3767.811609419573, 3785.3186426443503, 3794.0704527390412, 3798.3163030654196, 1205.9638210853689, 1221.432034104146, 1227.7974134267924, 1231.4889320931713, 1232.3468561662332, 1300.4473098933104, 1302.0, 1304.928228947417, 1308.6205000549735, 1339.4842985450477, 7421.0, 7481.738139165212, 7710.691572337044, 7727.0, 7747.0, 473.23572430524456, 474.77210938749596, 474.9026449577828, 476.1999840268313, 489.20015774209423, 5374.865628359323, 5406.026915155231, 5424.972875135599, 5438.211459338374, 5479.369872464717, 9537.47543885093, 9641.084097010773, 9988.0, 10039.548220330104, 10096.798064038678, 9694.709158725249, 9803.607855685692, 9848.901510984942, 9875.950620246997, 9897.059779320953, 7028.789136325919, 7218.169910460259, 7263.673134709056, 7276.272372762787, 7678.692852285958, 7466.290702383265, 7538.3592394644875, 7602.771916842504, 7622.771316860503, 7635.618219089134, 8719.084496128069, 8758.255548278468, 8841.071687472722, 8863.955680221557, 8993.820123597361, 8951.955240223757, 8987.955060224656, 9072.863907041268, 9082.137196966278, 9120.680776172801, 6166.167567378347, 6752.0, 6822.454203663596, 7202.89195662076, 7274.054372931485, 7407.888881666671, 7436.293552112541, 7442.813929651802, 7499.1750907399055, 7499.325060744559, 6566.376194261537, 6700.966495167493, 6715.160604924385, 6801.2178599461695, 6866.793996180123, 6430.260520040255, 6446.484281257582, 6485.416312531895, 6494.512911531749, 6536.542442029203, 7004.194517630538, 7043.36609705129, 7092.822679433056, 7102.183248926233, 7148.749793757193, 6344.365563443619, 6433.163688720623, 6444.162258906312, 6459.709313081016, 6468.353164683682, 6285.528585356208, 6317.020861766434, 6343.9682801585695, 6356.459700925473, 6357.1735674362035], "unit": "score", "name": "mootools.html", "value": 4455.4883761790825}, {"lowerIsBetter": false, "replicates": [316.9033444799336, 322.9450993331133, 324.3593902043463, 328.6910304313946, 335.2523871765962, 6223.4398904098625, 6259.248890133184, 6293.496520278378, 6299.748010079597, 6325.2409710834645, 6145.17040199573, 6204.813855584329, 6218.22272215973, 6223.595466294688, 6231.252249730039, 4515.61617262533, 4575.977120114395, 4598.931016034762, 4607.331936869152, 4777.06847164803, 4592.058627981256, 4602.792874320647, 4608.5621865922685, 4612.262038073909, 4614.423197100363, 4517.344984977176, 4527.4340707411575, 4554.70394424363, 4557.703749256304, 4559.270516717326, 4542.545745425447, 4550.795214215368, 4553.248713962193, 4553.840615578455, 4576.542345765397, 3932.5674175840636, 3933.606639336072, 3938.4836837817647, 3941.3693808990424, 3944.6647035001774, 5919.911201331984, 5939.584229103964, 5957.970210148921, 5962.940370596325, 5974.940250597482, 5198.194279886624, 5325.068113080234, 5342.305500284977, 5388.649737767072, 5406.243125962368, 6497.415232629039, 6540.967295163494, 6543.411093001605, 6550.050242714828, 6589.736410543573, 4401.581849724271, 4402.823887044515, 4405.515393306734, 4419.911601767979, 4431.158079964796, 6811.046453496514, 6824.078749368871, 6871.622060786654, 6900.137482814648, 6900.930990690129, 4398.956010439919, 4419.668524860584, 4426.867193984185, 4428.402165707653, 4434.091011342667, 4378.627816635558, 4490.977545112319, 4501.954980450154, 4507.504174540798, 4511.368408422823, 5341.332333458317, 5355.518003379637, 5356.839294821161, 5364.785408583691, 5367.1680889462195, 6639.468842492589, 6658.467322614276, 6664.86670266592, 6673.065770792093, 6683.532152749261, 1596.074276919384, 1619.4008216959564, 1620.3761551802404, 1621.2704283072428, 1623.8051433828016, 992.0377234082928, 1010.6967909627083, 1024.9231307651955, 1031.5976769060073, 1043.0768769638923, 6301.243850737849, 6301.306856245809, 6334.619922804646, 6344.39728225827, 6372.904406433907, 6772.187337519529, 6791.2869148739655, 6819.659017049128, 6830.453563714891, 6835.043093966849, 6126.0, 6254.468370188494, 6309.14826498426, 6364.649944253018, 6437.388448097423, 3692.6307369263395, 3710.5547334320054, 3716.851325946932, 3721.4789929409903, 3726.124360775216, 7299.963500182465, 7302.050733404623, 7313.926860731431, 7333.633318334062, 7337.009503717037, 7019.0, 7048.541844780073, 7064.823379415453, 7075.716971321192, 7081.256468070881, 7103.360697537143, 7224.711011559479, 7245.203027666952, 7299.41604671625, 7329.816754581178, 6830.59016459014, 6859.9314006859295, 6861.313868613099, 6861.588304701734, 6867.862642747217, 6765.966170169315, 6797.116374871235, 6809.897851532132, 6832.975053741979, 6850.520463567503, 7276.781696549112, 7278.636068196675, 7298.0, 7305.744298949511, 7309.122905251404, 4395.626371758436, 4498.05540836428, 4498.190325741398, 4498.347739577808, 4519.163954668397, 6832.658367081725, 6886.24251332343, 6887.690053947485, 6890.793276201722, 6893.931060689329, 6597.769078082244, 6600.405963463311, 6604.405603495708, 6608.074869518176, 6656.001599760075, 6643.202815662152, 6648.468122550281, 6652.334766523309, 6655.334466553306, 6664.0, 6272.937270627418, 6450.838729031811, 6517.185351831021, 6522.608643481406, 6528.934710652833, 6622.701978410887, 6658.467322614082, 6670.066190733204, 6673.499487538551, 6674.26583075871, 6424.839379015375, 6488.0, 6515.706793194412, 6523.24982627004, 6525.771597994048], "unit": "score", "name": "prototype.html", "value": 4915.284785326986}, {"lowerIsBetter": false, "replicates": [654.1986067067841, 681.8022773395716, 716.1191734166974, 724.9855002899945, 735.3602365941632, 11694.824577631342, 11816.0, 11864.881351186486, 11913.702157446069, 13755.449782008733, 13307.866921330808, 13357.465701371933, 13395.933020334885, 13412.59762207133, 13453.394597243123, 808.3694718119876, 810.3760104719363, 810.8824220488056, 813.3858936502932, 813.9308158806508, 803.6182813163759, 804.493169303341, 807.8828569857367, 812.4678335690132, 821.5809936932178, 840.5377042626561, 845.3659755183612, 845.5856630251163, 851.1743608699552, 856.9571521423935, 836.4395854777283, 839.8320335932838, 840.3907167303717, 842.6081871929521, 860.5009094725076, 638.4381744065239, 639.7696829141505, 641.4579680170249, 642.2036674523604, 642.3415998601471, 12682.239065655998, 12720.427580758887, 13398.0, 13512.391942362618, 13606.115602485806, 11586.18896677233, 11628.0, 11804.52781888732, 11850.585229517012, 11888.465019074163, 9673.854892176623, 9764.90235097647, 9774.413535187912, 9848.803023939481, 10100.040496152928, 3475.3396854597545, 3533.0990597397754, 3586.7489275750445, 3607.062163837395, 3624.7281453891064, 46737.0, 47019.764901175615, 47506.28740568894, 47815.0, 48000.55998320056, 9058.266526089596, 9286.767830804283, 9413.790700683894, 9430.243728521524, 9511.191548718436, 16955.15224238783, 17029.829701702824, 17182.828171718375, 17291.0, 17458.214380352914, 6612.537122401386, 6683.5989840608745, 6705.061291419205, 6736.8989465158065, 6772.932270677329, 3624.771768086429, 3624.9456258156147, 3639.0542828907983, 3683.8710645127294, 3733.757305775116, 2995.221242476928, 3011.2471882029495, 3022.894198703079, 3033.529802880557, 3037.0888733379898, 530.6179550723473, 537.3202898333611, 599.9970000150058, 619.804761500126, 622.4771192198575, 542.6689719271242, 543.6137848486344, 554.3209568278826, 567.7643777832153, 575.8013485347549, 7660.73187438437, 7751.728689495841, 7789.64946577394, 7935.325497332791, 7973.122956474783, 469.8332092107321, 489.2172523961704, 495.8215042584667, 535.9383670877821, 572.2932178759229, 3386.102682789063, 3640.1081734974573, 3680.411134218512, 3705.3330400527625, 3734.215814678948, 57083.71458142766, 58071.419285807446, 58164.964226251876, 58415.415845841846, 58512.4148758507, 50662.49337506578, 51761.22358164631, 52175.73912130491, 52284.738576306874, 52718.47281527136, 46170.76914615405, 46338.76830615825, 46517.06965860732, 46711.29933051007, 46872.765636172284, 7290.088738907637, 7305.159906610807, 7314.268573142643, 7470.178280389044, 7499.3516985498345, 35078.12304692403, 35151.12122196965, 36076.4588531167, 36145.27709445744, 36387.08903287678, 41520.377194341505, 41528.37707434451, 44586.77706611576, 45953.0, 46011.53988460206, 9310.0, 9414.717558473258, 9435.386699864486, 9471.619980489206, 9861.211103111877, 10206.948965255126, 10363.792724145324, 10367.844482332923, 10425.0096240857, 10623.575056997943, 9160.954195228982, 9312.860307095263, 9473.66842160521, 9631.759206019906, 10238.539265733209, 9540.904590954002, 9596.23230141573, 9656.275779316438, 9912.0, 9935.254855885982, 9633.277504187354, 9844.114029737359, 9881.555330010024, 10006.549705263425, 10080.445575493419, 8894.753028243686, 8908.821823563621, 9007.459552426875, 9110.498922559324, 9431.62273509052, 8733.606987685442, 9115.316351273814, 9308.95345523268, 9572.425654460754, 9574.856377154209], "unit": "score", "name": "yui.html", "value": 5917.410385007907}], "name": "dromaeo_css", "value": 6863.150123012515}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 111.0, 109.0, 113.0, 122.0, 110.0, 109.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [158.0, 127.0, 150.0, 171.0, 131.0, 150.0, 153.0, 132.0, 166.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 146.4}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 164.0, 161.0, 161.0, 161.0, 161.0, 164.0, 170.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.0}, {"lowerIsBetter": true, "replicates": [75.0, 72.0, 98.0, 77.0, 75.0, 75.0, 74.0, 74.0, 134.0, 76.0], "unit": "score", "name": "audio-fft", "value": 83.0}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 149.0, 95.0, 97.0, 94.0, 152.0, 94.0, 94.0, 150.0], "unit": "score", "name": "audio-oscillator", "value": 111.2}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.2}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 145.0, 147.0, 147.0, 146.0, 147.0, 149.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 101.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 60.0, 59.0, 60.0, 60.0, 64.0, 61.0, 58.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 59.9}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 69.0, 68.0, 69.0, 70.0, 69.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 83.0, 82.0, 84.0, 82.0, 83.0, 82.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [126.0, 115.0, 124.0, 116.0, 129.0, 127.0, 116.0, 116.0, 119.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.6}, {"lowerIsBetter": true, "replicates": [142.0, 157.0, 150.0, 154.0, 153.0, 162.0, 153.0, 150.0, 150.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.3}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 70.0, 74.0, 71.0, 69.0, 72.0, 72.0, 72.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.1}], "name": "kraken", "value": 1529.8}]} 06:13:00 INFO - Return code: 0 06:13:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:13:00 ERROR - # TBPL SUCCESS # 06:13:00 INFO - Running post-action listener: _resource_record_post_action 06:13:00 INFO - Running post-run listener: _resource_record_post_run 06:13:01 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535003136; Read time: 12; Write time: 894340 06:13:01 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 241065984; Read time: 0; Write time: 550792 06:13:01 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293937152; Read time: 12; Write time: 343548 06:13:01 INFO - Running post-run listener: _upload_blobber_files 06:13:01 INFO - Blob upload gear active. 06:13:01 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:13:01 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:13:01 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:13:01 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:13:02 INFO - (blobuploader) - INFO - Open directory for files ... 06:13:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:13:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:13:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:03 INFO - (blobuploader) - INFO - Done attempting. 06:13:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:13:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:13:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:04 INFO - (blobuploader) - INFO - Done attempting. 06:13:04 INFO - (blobuploader) - INFO - Iteration through files over. 06:13:04 INFO - Return code: 0 06:13:04 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:13:04 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:13:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b6730a273e8925a91c69f7b80f848b0e3485dc5a239dff4efae81004c8002ae7bf78bfb158df29ed3c7875c3183530efd3197e540e3a1d08e7969e186327155", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b0872b22ee27d5df4c3e34a6af746977f6a3d1fe15065f26cd5b4de86a19d6e29534d129bfe3bd109c65b13fee325998fc3b6a380596213428b4cb8c2720641"} 06:13:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:13:04 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:13:04 INFO - Contents: 06:13:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b6730a273e8925a91c69f7b80f848b0e3485dc5a239dff4efae81004c8002ae7bf78bfb158df29ed3c7875c3183530efd3197e540e3a1d08e7969e186327155", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b0872b22ee27d5df4c3e34a6af746977f6a3d1fe15065f26cd5b4de86a19d6e29534d129bfe3bd109c65b13fee325998fc3b6a380596213428b4cb8c2720641"} 06:13:04 INFO - Running post-run listener: copy_logs_to_upload_dir 06:13:04 INFO - Copying logs to upload dir... 06:13:04 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 06:13:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.909546 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-03-10 06:13:03.747328) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-10 06:13:03.751199) ========= 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=745a4373a2a16df560f216e000000264-1457617954.508200-1421425352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b6730a273e8925a91c69f7b80f848b0e3485dc5a239dff4efae81004c8002ae7bf78bfb158df29ed3c7875c3183530efd3197e540e3a1d08e7969e186327155", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b0872b22ee27d5df4c3e34a6af746977f6a3d1fe15065f26cd5b4de86a19d6e29534d129bfe3bd109c65b13fee325998fc3b6a380596213428b4cb8c2720641"} build_url:https://queue.taskcluster.net/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011437 build_url: 'https://queue.taskcluster.net/v1/task/f_h18wqUSIKORuU1nq2Dtw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b6730a273e8925a91c69f7b80f848b0e3485dc5a239dff4efae81004c8002ae7bf78bfb158df29ed3c7875c3183530efd3197e540e3a1d08e7969e186327155", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b0872b22ee27d5df4c3e34a6af746977f6a3d1fe15065f26cd5b4de86a19d6e29534d129bfe3bd109c65b13fee325998fc3b6a380596213428b4cb8c2720641"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-10 06:13:03.775940) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 06:13:03.776275) ========= 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=745a4373a2a16df560f216e000000264-1457617954.508200-1421425352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 06:13:03.862542) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-10 06:13:03.862896) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-10 06:13:03.863318) ========= ========= Total master_lag: 0.27 =========