builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-021 starttime: 1460568697.75 results: success (0) buildid: 20160413074152 builduid: 4de4b3b8164b438eaa948b59d7f759bd revision: 359c46892e799a4d6b6aeb148681bbbd3a3da4c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 10:31:37.753986) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 10:31:37.754505) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 10:31:37.754838) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1460568697.219403-1239870872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006223 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 10:31:37.777666) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 10:31:37.777989) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 10:31:37.792501) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 10:31:37.792843) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1460568697.219403-1239870872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004562 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 10:31:37.843319) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 10:31:37.843657) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 10:31:37.844102) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 10:31:37.844528) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1460568697.219403-1239870872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-13 10:31:37-- 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% 232M=0s 2016-04-13 10:31:38 (232 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.146177 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 10:31:38.003747) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 10:31:38.004104) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1460568697.219403-1239870872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022911 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 10:31:38.054473) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 10:31:38.054871) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 359c46892e799a4d6b6aeb148681bbbd3a3da4c4 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 359c46892e799a4d6b6aeb148681bbbd3a3da4c4 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1460568697.219403-1239870872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-13 10:31:38,240 truncating revision to first 12 chars 2016-04-13 10:31:38,240 Setting DEBUG logging. 2016-04-13 10:31:38,240 attempt 1/10 2016-04-13 10:31:38,240 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/359c46892e79?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-13 10:31:38,499 unpacking tar archive at: mozilla-aurora-359c46892e79/testing/mozharness/ program finished with exit code 0 elapsedTime=0.546772 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 10:31:38.615147) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 10:31:38.615566) ========= echo 359c46892e799a4d6b6aeb148681bbbd3a3da4c4 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'359c46892e799a4d6b6aeb148681bbbd3a3da4c4'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1460568697.219403-1239870872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 359c46892e799a4d6b6aeb148681bbbd3a3da4c4 program finished with exit code 0 elapsedTime=0.003717 script_repo_revision: '359c46892e799a4d6b6aeb148681bbbd3a3da4c4' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 10:31:38.665889) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 10:31:38.666293) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 10:31:38.677922) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-04-13 10:31:38.678270) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1460568697.219403-1239870872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:31:38 INFO - MultiFileLogger online at 20160413 10:31:38 in /builds/slave/test-pgo 10:31:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:31:38 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:31:38 INFO - {'append_to_log': False, 10:31:38 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:31:38 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:31:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:31:38 INFO - 'branch': 'Mozilla-Aurora', 10:31:38 INFO - 'buildbot_json_path': 'buildprops.json', 10:31:38 INFO - 'config_files': ('talos/linux_config.py',), 10:31:38 INFO - 'default_actions': ('clobber', 10:31:38 INFO - 'read-buildbot-config', 10:31:38 INFO - 'download-and-extract', 10:31:38 INFO - 'populate-webroot', 10:31:38 INFO - 'create-virtualenv', 10:31:38 INFO - 'install', 10:31:38 INFO - 'run-tests'), 10:31:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:31:38 INFO - 'download_minidump_stackwalk': True, 10:31:38 INFO - 'download_symbols': 'ondemand', 10:31:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:31:38 INFO - 'tooltool.py': '/tools/tooltool.py', 10:31:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:31:38 INFO - '/tools/misc-python/virtualenv.py')}, 10:31:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:31:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:31:38 INFO - 'installer_path': 'installer.exe', 10:31:38 INFO - 'log_level': 'info', 10:31:38 INFO - 'log_name': 'talos', 10:31:38 INFO - 'log_to_console': True, 10:31:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:31:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:31:38 INFO - 'opt_config_files': (), 10:31:38 INFO - 'pip_index': False, 10:31:38 INFO - 'sps_profile': False, 10:31:38 INFO - 'sps_profile_interval': 0, 10:31:38 INFO - 'suite': 'dromaeojs-e10s', 10:31:38 INFO - 'system_bits': '32', 10:31:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:31:38 INFO - 'title': 'talos-linux64-ix-021', 10:31:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:31:38 INFO - 'use_talos_json': True, 10:31:38 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:31:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:31:38 INFO - 'work_dir': 'build'} 10:31:38 INFO - ##### 10:31:38 INFO - ##### Running clobber step. 10:31:38 INFO - ##### 10:31:38 INFO - Running pre-action listener: _resource_record_pre_action 10:31:38 INFO - Running main action method: clobber 10:31:38 INFO - rmtree: /builds/slave/test-pgo/build 10:31:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:31:39 INFO - Running post-action listener: _resource_record_post_action 10:31:39 INFO - ##### 10:31:39 INFO - ##### Running read-buildbot-config step. 10:31:39 INFO - ##### 10:31:39 INFO - Running pre-action listener: _resource_record_pre_action 10:31:39 INFO - Running main action method: read_buildbot_config 10:31:39 INFO - Using buildbot properties: 10:31:39 INFO - { 10:31:39 INFO - "project": "", 10:31:39 INFO - "product": "firefox", 10:31:39 INFO - "script_repo_revision": "production", 10:31:39 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 10:31:39 INFO - "repository": "", 10:31:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 10:31:39 INFO - "buildid": "20160413074152", 10:31:39 INFO - "pgo_build": "True", 10:31:39 INFO - "basedir": "/builds/slave/test-pgo", 10:31:39 INFO - "buildnumber": 195, 10:31:39 INFO - "slavename": "talos-linux64-ix-021", 10:31:39 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:31:39 INFO - "platform": "ubuntu64_hw", 10:31:39 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:31:39 INFO - "branch": "mozilla-aurora", 10:31:39 INFO - "repo_path": "releases/mozilla-aurora", 10:31:39 INFO - "revision": "359c46892e799a4d6b6aeb148681bbbd3a3da4c4", 10:31:39 INFO - "stage_platform": "linux64-pgo", 10:31:39 INFO - "builduid": "4de4b3b8164b438eaa948b59d7f759bd", 10:31:39 INFO - "slavebuilddir": "test" 10:31:39 INFO - } 10:31:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 10:31:39 INFO - Running post-action listener: _resource_record_post_action 10:31:39 INFO - ##### 10:31:39 INFO - ##### Running download-and-extract step. 10:31:39 INFO - ##### 10:31:39 INFO - Running pre-action listener: _resource_record_pre_action 10:31:39 INFO - Running main action method: download_and_extract 10:31:39 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:31:39 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')]} 10:31:39 INFO - https://queue.taskcluster.net/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:31:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 10:31:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 10:31:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 10:31:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:31:40 INFO - Downloaded 1448 bytes. 10:31:40 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 10:31:40 INFO - Using the following test package requirements: 10:31:40 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 10:31:40 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 10:31:40 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:31:40 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 10:31:40 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:31:40 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 10:31:40 INFO - u'jsshell-linux-x86_64.zip'], 10:31:40 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 10:31:40 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:31:40 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 10:31:40 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 10:31:40 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:31:40 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 10:31:40 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:31:40 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 10:31:40 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:31:40 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 10:31:40 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 10:31:40 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:31:40 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:31: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')]} 10:31:40 INFO - https://queue.taskcluster.net/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:31:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 10:31:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 10:31:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 10:31:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:31:42 INFO - Downloaded 23352259 bytes. 10:31:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:31:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 10:31:43 INFO - Return code: 0 10:31:43 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:31: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')]} 10:31:43 INFO - https://queue.taskcluster.net/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:31:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 10:31:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 10:31:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 10:31:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:31:45 INFO - Downloaded 23352259 bytes. 10:31:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:31:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 10:31:46 INFO - Return code: 0 10:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:31:46 INFO - https://queue.taskcluster.net/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:31:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 10:31:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 10:31:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 10:31:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:31:47 INFO - Downloaded 10845168 bytes. 10:31:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:31:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 10:31:47 INFO - Return code: 0 10:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:31:47 INFO - https://queue.taskcluster.net/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:31:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 10:31:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 10:31:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 10:31:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:31:49 INFO - Downloaded 60573268 bytes. 10:31:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 10:31:49 INFO - mkdir: /builds/slave/test-pgo/properties 10:31:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:31:49 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:31:49 INFO - Contents: 10:31:49 INFO - build_url:https://queue.taskcluster.net/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 10:31:49 INFO - Running post-action listener: _resource_record_post_action 10:31:49 INFO - Running post-action listener: set_extra_try_arguments 10:31:49 INFO - ##### 10:31:49 INFO - ##### Running populate-webroot step. 10:31:49 INFO - ##### 10:31:49 INFO - Running pre-action listener: _resource_record_pre_action 10:31:49 INFO - Running main action method: populate_webroot 10:31:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:31:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:31:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:31:49 INFO - '--tppagecycles', 10:31:49 INFO - '7'], 10:31:49 INFO - 'tests': ['tsvgm']}}, 10:31:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:31:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:31:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:31:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:31:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:31:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:31:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:31:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:49 INFO - 'talos_options': ['--e10s'], 10:31:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:31:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:49 INFO - 'tests': ['damp', 'tps']}, 10:31:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:49 INFO - 'talos_options': ['--e10s'], 10:31:49 INFO - 'tests': ['damp', 'tps']}, 10:31:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:31:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:31:49 INFO - 'other': {'tests': ['a11yr', 10:31:49 INFO - 'ts_paint', 10:31:49 INFO - 'tpaint', 10:31:49 INFO - 'sessionrestore', 10:31:49 INFO - 'sessionrestore_no_auto_restore', 10:31:49 INFO - 'tabpaint']}, 10:31:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:31:49 INFO - 'tests': ['a11yr', 10:31:49 INFO - 'ts_paint', 10:31:49 INFO - 'tpaint', 10:31:49 INFO - 'sessionrestore', 10:31:49 INFO - 'sessionrestore_no_auto_restore', 10:31:49 INFO - 'tabpaint']}, 10:31:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:31:49 INFO - 'tests': ['a11yr', 10:31:49 INFO - 'ts_paint', 10:31:49 INFO - 'tpaint', 10:31:49 INFO - 'sessionrestore', 10:31:49 INFO - 'sessionrestore_no_auto_restore', 10:31:49 INFO - 'tabpaint']}, 10:31:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:31:49 INFO - 'tests': ['a11yr', 10:31:49 INFO - 'ts_paint', 10:31:49 INFO - 'tpaint', 10:31:49 INFO - 'sessionrestore', 10:31:49 INFO - 'sessionrestore_no_auto_restore', 10:31:49 INFO - 'tabpaint']}, 10:31:49 INFO - 'other_l64': {'tests': ['a11yr', 10:31:49 INFO - 'ts_paint', 10:31:49 INFO - 'tpaint', 10:31:49 INFO - 'sessionrestore', 10:31:49 INFO - 'sessionrestore_no_auto_restore', 10:31:49 INFO - 'tabpaint']}, 10:31:49 INFO - 'other_nol64': {'tests': ['a11yr', 10:31:49 INFO - 'ts_paint', 10:31:49 INFO - 'tpaint', 10:31:49 INFO - 'sessionrestore', 10:31:49 INFO - 'sessionrestore_no_auto_restore', 10:31:49 INFO - 'tabpaint']}, 10:31:49 INFO - 'svgr': {'tests': ['tsvgx', 10:31:49 INFO - 'tsvgr_opacity', 10:31:49 INFO - 'tart', 10:31:49 INFO - 'tscrollx', 10:31:49 INFO - 'cart']}, 10:31:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:31:49 INFO - 'tests': ['tsvgx', 10:31:49 INFO - 'tsvgr_opacity', 10:31:49 INFO - 'tart', 10:31:49 INFO - 'tscrollx', 10:31:49 INFO - 'cart']}, 10:31:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:49 INFO - 'tests': ['tp5o']}, 10:31:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:49 INFO - 'talos_options': ['--e10s'], 10:31:49 INFO - 'tests': ['tp5o']}, 10:31:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:49 INFO - 'talos_options': ['--xperf_path', 10:31:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:31:49 INFO - 'tests': ['tp5n']}, 10:31:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:31:49 INFO - 'talos_options': ['--e10s', 10:31:49 INFO - '--xperf_path', 10:31:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:31:49 INFO - 'tests': ['tp5n']}}, 10:31:49 INFO - 'talos.zip': {'path': '', 10:31:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:31:49 INFO - Running post-action listener: _resource_record_post_action 10:31:49 INFO - ##### 10:31:49 INFO - ##### Running create-virtualenv step. 10:31:49 INFO - ##### 10:31:49 INFO - Running pre-action listener: _resource_record_pre_action 10:31:49 INFO - Running main action method: create_virtualenv 10:31:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:31:49 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 10:31:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:31:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:31:49 INFO - Using real prefix '/usr' 10:31:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:31:50 INFO - Installing distribute.............................................................................................................................................................................................done. 10:31:52 INFO - Installing pip.................done. 10:31:52 INFO - Return code: 0 10:31:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:31:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:52 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 0x7ff6c8891f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfe6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8d920>, '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 0x1e8e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e8ecb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460568697.219403-1239870872', '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 10:31:52 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 10:31:52 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 10:31:52 INFO - Using env: {'DISPLAY': ':0', 10:31:52 INFO - 'HOME': '/home/cltbld', 10:31:52 INFO - 'LANG': 'en_US.UTF-8', 10:31:52 INFO - 'LANGUAGE': 'en_US:en', 10:31:52 INFO - 'LOGNAME': 'cltbld', 10:31:52 INFO - 'MAIL': '/var/mail/cltbld', 10:31:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:52 INFO - 'MOZ_NO_REMOTE': '1', 10:31:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:52 INFO - 'NO_EM_RESTART': '1', 10:31:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:31:52 INFO - 'PWD': '/builds/slave/test-pgo', 10:31:52 INFO - 'SHELL': '/bin/bash', 10:31:52 INFO - 'SHLVL': '1', 10:31:52 INFO - 'TERM': 'linux', 10:31:52 INFO - 'TMOUT': '86400', 10:31:52 INFO - 'USER': 'cltbld', 10:31:52 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460568697.219403-1239870872', 10:31:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:52 INFO - '_': '/tools/buildbot/bin/python'} 10:31:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:52 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 10:31:52 INFO - Cleaning up... 10:31:52 INFO - Return code: 0 10:31:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:31:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:52 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 0x7ff6c8891f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfe6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8d920>, '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 0x1e8e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e8ecb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460568697.219403-1239870872', '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 10:31:52 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 10:31:52 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 10:31:52 INFO - Using env: {'DISPLAY': ':0', 10:31:52 INFO - 'HOME': '/home/cltbld', 10:31:52 INFO - 'LANG': 'en_US.UTF-8', 10:31:52 INFO - 'LANGUAGE': 'en_US:en', 10:31:52 INFO - 'LOGNAME': 'cltbld', 10:31:52 INFO - 'MAIL': '/var/mail/cltbld', 10:31:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:52 INFO - 'MOZ_NO_REMOTE': '1', 10:31:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:52 INFO - 'NO_EM_RESTART': '1', 10:31:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:31:52 INFO - 'PWD': '/builds/slave/test-pgo', 10:31:52 INFO - 'SHELL': '/bin/bash', 10:31:52 INFO - 'SHLVL': '1', 10:31:52 INFO - 'TERM': 'linux', 10:31:52 INFO - 'TMOUT': '86400', 10:31:52 INFO - 'USER': 'cltbld', 10:31:52 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460568697.219403-1239870872', 10:31:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:52 INFO - '_': '/tools/buildbot/bin/python'} 10:31:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:52 INFO - Downloading/unpacking psutil>=0.7.1 10:31: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 10:31: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 10:31: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 10:31: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 10:31: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 10:31: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 10:31:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:31:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:31:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:31:54 INFO - Installing collected packages: psutil 10:31:54 INFO - Running setup.py install for psutil 10:31:54 INFO - building 'psutil._psutil_linux' extension 10:31:54 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 10:31:55 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 10:31:55 INFO - building 'psutil._psutil_posix' extension 10:31:55 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 10:31:55 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 10:31:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:31:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:31:55 INFO - Successfully installed psutil 10:31:55 INFO - Cleaning up... 10:31:55 INFO - Return code: 0 10:31:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:55 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 0x7ff6c8891f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfe6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8d920>, '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 0x1e8e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e8ecb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460568697.219403-1239870872', '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 10:31:55 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 10:31:55 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 10:31:55 INFO - Using env: {'DISPLAY': ':0', 10:31:55 INFO - 'HOME': '/home/cltbld', 10:31:55 INFO - 'LANG': 'en_US.UTF-8', 10:31:55 INFO - 'LANGUAGE': 'en_US:en', 10:31:55 INFO - 'LOGNAME': 'cltbld', 10:31:55 INFO - 'MAIL': '/var/mail/cltbld', 10:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:55 INFO - 'MOZ_NO_REMOTE': '1', 10:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:55 INFO - 'NO_EM_RESTART': '1', 10:31:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:31:55 INFO - 'PWD': '/builds/slave/test-pgo', 10:31:55 INFO - 'SHELL': '/bin/bash', 10:31:55 INFO - 'SHLVL': '1', 10:31:55 INFO - 'TERM': 'linux', 10:31:55 INFO - 'TMOUT': '86400', 10:31:55 INFO - 'USER': 'cltbld', 10:31:55 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460568697.219403-1239870872', 10:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:55 INFO - '_': '/tools/buildbot/bin/python'} 10:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:31:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:31:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:31:57 INFO - Installing collected packages: mozsystemmonitor 10:31:57 INFO - Running setup.py install for mozsystemmonitor 10:31:57 INFO - Successfully installed mozsystemmonitor 10:31:57 INFO - Cleaning up... 10:31:57 INFO - Return code: 0 10:31:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:31: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')]} 10:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31: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')]} 10:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff6c8891f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfe6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8d920>, '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 0x1e8e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e8ecb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460568697.219403-1239870872', '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 10:31:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 10:31:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:31:57 INFO - Using env: {'DISPLAY': ':0', 10:31:57 INFO - 'HOME': '/home/cltbld', 10:31:57 INFO - 'LANG': 'en_US.UTF-8', 10:31:57 INFO - 'LANGUAGE': 'en_US:en', 10:31:57 INFO - 'LOGNAME': 'cltbld', 10:31:57 INFO - 'MAIL': '/var/mail/cltbld', 10:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:57 INFO - 'MOZ_NO_REMOTE': '1', 10:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:57 INFO - 'NO_EM_RESTART': '1', 10:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:31:57 INFO - 'PWD': '/builds/slave/test-pgo', 10:31:57 INFO - 'SHELL': '/bin/bash', 10:31:57 INFO - 'SHLVL': '1', 10:31:57 INFO - 'TERM': 'linux', 10:31:57 INFO - 'TMOUT': '86400', 10:31:57 INFO - 'USER': 'cltbld', 10:31:57 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460568697.219403-1239870872', 10:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:57 INFO - '_': '/tools/buildbot/bin/python'} 10:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:57 INFO - Downloading/unpacking blobuploader==1.2.4 10:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:59 INFO - Downloading blobuploader-1.2.4.tar.gz 10:31:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:31:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:32:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:00 INFO - Downloading docopt-0.6.1.tar.gz 10:32:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:32:00 INFO - Installing collected packages: blobuploader, requests, docopt 10:32:00 INFO - Running setup.py install for blobuploader 10:32:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:32:00 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:32:00 INFO - Running setup.py install for requests 10:32:00 INFO - Running setup.py install for docopt 10:32:01 INFO - Successfully installed blobuploader requests docopt 10:32:01 INFO - Cleaning up... 10:32:01 INFO - Return code: 0 10:32:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:01 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 0x7ff6c8891f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfe6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8d920>, '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 0x1e8e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e8ecb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460568697.219403-1239870872', '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 10:32:01 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 10:32:01 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 10:32:01 INFO - Using env: {'DISPLAY': ':0', 10:32:01 INFO - 'HOME': '/home/cltbld', 10:32:01 INFO - 'LANG': 'en_US.UTF-8', 10:32:01 INFO - 'LANGUAGE': 'en_US:en', 10:32:01 INFO - 'LOGNAME': 'cltbld', 10:32:01 INFO - 'MAIL': '/var/mail/cltbld', 10:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:01 INFO - 'MOZ_NO_REMOTE': '1', 10:32:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:01 INFO - 'NO_EM_RESTART': '1', 10:32:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:32:01 INFO - 'PWD': '/builds/slave/test-pgo', 10:32:01 INFO - 'SHELL': '/bin/bash', 10:32:01 INFO - 'SHLVL': '1', 10:32:01 INFO - 'TERM': 'linux', 10:32:01 INFO - 'TMOUT': '86400', 10:32:01 INFO - 'USER': 'cltbld', 10:32:01 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460568697.219403-1239870872', 10:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:01 INFO - '_': '/tools/buildbot/bin/python'} 10:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:32:01 INFO - Running setup.py (path:/tmp/pip-67VwMD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:32:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:32:01 INFO - Running setup.py (path:/tmp/pip-8aqr5h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:32:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:32:01 INFO - Running setup.py (path:/tmp/pip-GIlqOr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:32:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:32:01 INFO - Running setup.py (path:/tmp/pip-fbyF21-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:32:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:32:01 INFO - Running setup.py (path:/tmp/pip-lbfgiO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:32:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:32:01 INFO - Running setup.py (path:/tmp/pip-o0eFN0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:32:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:32:01 INFO - Running setup.py (path:/tmp/pip-VUBwC_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:32:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:32:01 INFO - Running setup.py (path:/tmp/pip-xtXNai-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:32:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:32:01 INFO - Running setup.py (path:/tmp/pip-jYgd5U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:32:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:32:01 INFO - Running setup.py (path:/tmp/pip-wEjg88-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:32:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:32:02 INFO - Running setup.py (path:/tmp/pip-GCD0Bv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:32:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:32:02 INFO - Running setup.py (path:/tmp/pip-6_kBZv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:32:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:32:02 INFO - Running setup.py (path:/tmp/pip-jvB_t5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:32:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:32:02 INFO - Running setup.py (path:/tmp/pip-yTpwzL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:32:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:32:02 INFO - Running setup.py (path:/tmp/pip-knRKdf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:32:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:32:02 INFO - Running setup.py (path:/tmp/pip-197nKs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:32:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:32:02 INFO - Running setup.py (path:/tmp/pip-lyUJyb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:32:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:32:02 INFO - Running setup.py install for manifestparser 10:32:02 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:32:02 INFO - Running setup.py install for mozcrash 10:32:02 INFO - Running setup.py install for mozdebug 10:32:02 INFO - Running setup.py install for mozdevice 10:32:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:32:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:32:02 INFO - Running setup.py install for mozfile 10:32:03 INFO - Running setup.py install for mozhttpd 10:32:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:32:03 INFO - Running setup.py install for mozinfo 10:32:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:32:03 INFO - Running setup.py install for mozInstall 10:32:03 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:32:03 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:32:03 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:32:03 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:32:03 INFO - Running setup.py install for mozleak 10:32:03 INFO - Running setup.py install for mozlog 10:32:03 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:32:03 INFO - Running setup.py install for moznetwork 10:32:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:32:03 INFO - Running setup.py install for mozprocess 10:32:03 INFO - Running setup.py install for mozprofile 10:32:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:32:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:32:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:32:03 INFO - Running setup.py install for mozrunner 10:32:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:32:03 INFO - Running setup.py install for mozscreenshot 10:32:04 INFO - Running setup.py install for moztest 10:32:04 INFO - Running setup.py install for mozversion 10:32:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:32:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:32:04 INFO - Cleaning up... 10:32:04 INFO - Return code: 0 10:32:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:32: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')]} 10:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32: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')]} 10:32:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32: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/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 0x7ff6c8891f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfe6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8d920>, '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 0x1e8e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e8ecb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460568697.219403-1239870872', '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 10:32:04 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 10:32:04 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 10:32:04 INFO - Using env: {'DISPLAY': ':0', 10:32:04 INFO - 'HOME': '/home/cltbld', 10:32:04 INFO - 'LANG': 'en_US.UTF-8', 10:32:04 INFO - 'LANGUAGE': 'en_US:en', 10:32:04 INFO - 'LOGNAME': 'cltbld', 10:32:04 INFO - 'MAIL': '/var/mail/cltbld', 10:32:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:04 INFO - 'MOZ_NO_REMOTE': '1', 10:32:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:04 INFO - 'NO_EM_RESTART': '1', 10:32:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:32:04 INFO - 'PWD': '/builds/slave/test-pgo', 10:32:04 INFO - 'SHELL': '/bin/bash', 10:32:04 INFO - 'SHLVL': '1', 10:32:04 INFO - 'TERM': 'linux', 10:32:04 INFO - 'TMOUT': '86400', 10:32:04 INFO - 'USER': 'cltbld', 10:32:04 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460568697.219403-1239870872', 10:32:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:04 INFO - '_': '/tools/buildbot/bin/python'} 10:32:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:32:04 INFO - Running setup.py (path:/tmp/pip-LE8_Xs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:32:04 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)) 10:32:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:32:04 INFO - Running setup.py (path:/tmp/pip-e3pGoT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:32:04 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)) 10:32:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:32:04 INFO - Running setup.py (path:/tmp/pip-RShTwt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:32:04 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)) 10:32:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:32:04 INFO - Running setup.py (path:/tmp/pip-qpwTGW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:32:04 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)) 10:32:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:32:04 INFO - Running setup.py (path:/tmp/pip-S7_eVK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:32:04 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)) 10:32:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:32:04 INFO - Running setup.py (path:/tmp/pip-sKusFb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:32:04 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)) 10:32:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:32:04 INFO - Running setup.py (path:/tmp/pip-gBq7w7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:32:05 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)) 10:32:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:32:05 INFO - Running setup.py (path:/tmp/pip-dpV4Hi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:32:05 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)) 10:32:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:32:05 INFO - Running setup.py (path:/tmp/pip-sdcDPr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:32:05 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)) 10:32:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:32:05 INFO - Running setup.py (path:/tmp/pip-je6CMw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:32:05 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)) 10:32:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:32:05 INFO - Running setup.py (path:/tmp/pip-o2UrJF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:32:05 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)) 10:32:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:32:05 INFO - Running setup.py (path:/tmp/pip-l5RGZR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:32:05 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)) 10:32:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:32:05 INFO - Running setup.py (path:/tmp/pip-vJK99V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:32:05 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)) 10:32:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:32:05 INFO - Running setup.py (path:/tmp/pip-asY9TM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:32:05 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)) 10:32:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:32:05 INFO - Running setup.py (path:/tmp/pip-GrTo2f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:32:05 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)) 10:32:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:32:05 INFO - Running setup.py (path:/tmp/pip-IZEiYj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:32:05 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)) 10:32:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:32:05 INFO - Running setup.py (path:/tmp/pip-c4MQ4o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:32:05 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)) 10:32:05 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)) 10:32:05 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)) 10:32:05 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)) 10:32:05 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)) 10:32:05 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)) 10:32:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:32:05 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 10:32:05 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 10:32:05 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 10:32:05 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 10:32:05 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 10:32:05 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 10:32:07 INFO - Downloading blessings-1.6.tar.gz 10:32:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:32:07 INFO - Installing collected packages: blessings 10:32:07 INFO - Running setup.py install for blessings 10:32:07 INFO - Successfully installed blessings 10:32:07 INFO - Cleaning up... 10:32:07 INFO - Return code: 0 10:32:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:32:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:32:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:32:08 INFO - Reading from file tmpfile_stdout 10:32:08 INFO - Current package versions: 10:32:08 INFO - argparse == 1.2.1 10:32:08 INFO - blessings == 1.6 10:32:08 INFO - blobuploader == 1.2.4 10:32:08 INFO - docopt == 0.6.1 10:32:08 INFO - manifestparser == 1.1 10:32:08 INFO - mozInstall == 1.12 10:32:08 INFO - mozcrash == 0.17 10:32:08 INFO - mozdebug == 0.1 10:32:08 INFO - mozdevice == 0.48 10:32:08 INFO - mozfile == 1.2 10:32:08 INFO - mozhttpd == 0.7 10:32:08 INFO - mozinfo == 0.9 10:32:08 INFO - mozleak == 0.1 10:32:08 INFO - mozlog == 3.1 10:32:08 INFO - moznetwork == 0.27 10:32:08 INFO - mozprocess == 0.22 10:32:08 INFO - mozprofile == 0.28 10:32:08 INFO - mozrunner == 6.11 10:32:08 INFO - mozscreenshot == 0.1 10:32:08 INFO - mozsystemmonitor == 0.0 10:32:08 INFO - moztest == 0.7 10:32:08 INFO - mozversion == 1.4 10:32:08 INFO - psutil == 3.1.1 10:32:08 INFO - requests == 1.2.3 10:32:08 INFO - wsgiref == 0.1.2 10:32:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:32:08 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')]} 10:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:08 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')]} 10:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:08 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 0x7ff6c8891f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfe6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8d920>, '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 0x1e8e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e8ecb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460568697.219403-1239870872', '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 10:32:08 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 10:32:08 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 10:32:08 INFO - Using env: {'DISPLAY': ':0', 10:32:08 INFO - 'HOME': '/home/cltbld', 10:32:08 INFO - 'LANG': 'en_US.UTF-8', 10:32:08 INFO - 'LANGUAGE': 'en_US:en', 10:32:08 INFO - 'LOGNAME': 'cltbld', 10:32:08 INFO - 'MAIL': '/var/mail/cltbld', 10:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:08 INFO - 'MOZ_NO_REMOTE': '1', 10:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:08 INFO - 'NO_EM_RESTART': '1', 10:32:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:32:08 INFO - 'PWD': '/builds/slave/test-pgo', 10:32:08 INFO - 'SHELL': '/bin/bash', 10:32:08 INFO - 'SHLVL': '1', 10:32:08 INFO - 'TERM': 'linux', 10:32:08 INFO - 'TMOUT': '86400', 10:32:08 INFO - 'USER': 'cltbld', 10:32:08 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460568697.219403-1239870872', 10:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:08 INFO - '_': '/tools/buildbot/bin/python'} 10:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:08 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)) 10:32:08 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)) 10:32:08 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)) 10:32:08 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)) 10:32:08 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)) 10:32:08 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)) 10:32:08 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)) 10:32:08 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)) 10:32:08 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)) 10:32:08 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)) 10:32:08 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)) 10:32:08 INFO - Cleaning up... 10:32:08 INFO - Return code: 0 10:32:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:32:08 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')]} 10:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:08 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')]} 10:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:08 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 0x7ff6c8891f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfe6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8d920>, '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 0x1e8e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e8ecb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460568697.219403-1239870872', '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 10:32:08 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 10:32:08 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 10:32:08 INFO - Using env: {'DISPLAY': ':0', 10:32:08 INFO - 'HOME': '/home/cltbld', 10:32:08 INFO - 'LANG': 'en_US.UTF-8', 10:32:08 INFO - 'LANGUAGE': 'en_US:en', 10:32:08 INFO - 'LOGNAME': 'cltbld', 10:32:08 INFO - 'MAIL': '/var/mail/cltbld', 10:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:08 INFO - 'MOZ_NO_REMOTE': '1', 10:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:08 INFO - 'NO_EM_RESTART': '1', 10:32:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:32:08 INFO - 'PWD': '/builds/slave/test-pgo', 10:32:08 INFO - 'SHELL': '/bin/bash', 10:32:08 INFO - 'SHLVL': '1', 10:32:08 INFO - 'TERM': 'linux', 10:32:08 INFO - 'TMOUT': '86400', 10:32:08 INFO - 'USER': 'cltbld', 10:32:08 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460568697.219403-1239870872', 10:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:08 INFO - '_': '/tools/buildbot/bin/python'} 10:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:08 INFO - Downloading/unpacking jsonschema 10:32:08 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 10:32:08 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 10:32:08 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 10:32:08 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 10:32:08 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 10:32:08 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 10:32:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:32:10 INFO - Downloading/unpacking functools32 (from jsonschema) 10:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:10 INFO - Downloading functools32-3.2.3-2.tar.gz 10:32:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:32:10 INFO - warning: no files found matching '*.txt' 10:32:10 INFO - no previously-included directories found matching 'build' 10:32:10 INFO - no previously-included directories found matching 'dist' 10:32:10 INFO - no previously-included directories found matching '.git*' 10:32:10 INFO - Installing collected packages: jsonschema, functools32 10:32:10 INFO - Running setup.py install for functools32 10:32:10 INFO - warning: no files found matching '*.txt' 10:32:10 INFO - no previously-included directories found matching 'build' 10:32:10 INFO - no previously-included directories found matching 'dist' 10:32:10 INFO - no previously-included directories found matching '.git*' 10:32:10 INFO - Successfully installed jsonschema functools32 10:32:10 INFO - Cleaning up... 10:32:10 INFO - Return code: 0 10:32:10 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:32:10 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')]} 10:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:10 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')]} 10:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:10 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 0x7ff6c8891f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfe6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8d920>, '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 0x1e8e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e8ecb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460568697.219403-1239870872', '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 10:32:10 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 10:32:10 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 10:32:10 INFO - Using env: {'DISPLAY': ':0', 10:32:10 INFO - 'HOME': '/home/cltbld', 10:32:10 INFO - 'LANG': 'en_US.UTF-8', 10:32:10 INFO - 'LANGUAGE': 'en_US:en', 10:32:10 INFO - 'LOGNAME': 'cltbld', 10:32:10 INFO - 'MAIL': '/var/mail/cltbld', 10:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:10 INFO - 'MOZ_NO_REMOTE': '1', 10:32:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:10 INFO - 'NO_EM_RESTART': '1', 10:32:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:32:10 INFO - 'PWD': '/builds/slave/test-pgo', 10:32:10 INFO - 'SHELL': '/bin/bash', 10:32:10 INFO - 'SHLVL': '1', 10:32:10 INFO - 'TERM': 'linux', 10:32:10 INFO - 'TMOUT': '86400', 10:32:10 INFO - 'USER': 'cltbld', 10:32:10 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460568697.219403-1239870872', 10:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:10 INFO - '_': '/tools/buildbot/bin/python'} 10:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:11 INFO - Downloading/unpacking flake8 10:32:11 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 10:32:11 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 10:32:11 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 10:32:11 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 10:32:11 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 10:32:11 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 10:32:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:32:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:32:12 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 10:32:12 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 10:32:12 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 10:32:12 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 10:32:12 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 10:32:12 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 10:32:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:32:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:32:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:32:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:32:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:32:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:32:13 INFO - no previously-included directories found matching 'docs/_build' 10:32:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:32:13 INFO - Running setup.py install for pep8 10:32:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:32:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:32:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:32:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:32:13 INFO - no previously-included directories found matching 'docs/_build' 10:32:13 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:32:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:32:13 INFO - Cleaning up... 10:32:13 INFO - Return code: 0 10:32:13 INFO - Running post-action listener: _resource_record_post_action 10:32:13 INFO - Running post-action listener: _start_resource_monitoring 10:32:13 INFO - Starting resource monitoring. 10:32:13 INFO - ##### 10:32:13 INFO - ##### Running install step. 10:32:13 INFO - ##### 10:32:13 INFO - Running pre-action listener: _resource_record_pre_action 10:32:13 INFO - Running main action method: install 10:32:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:32:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:32:14 INFO - Reading from file tmpfile_stdout 10:32:14 INFO - Detecting whether we're running mozinstall >=1.0... 10:32:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:32:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:32:14 INFO - Reading from file tmpfile_stdout 10:32:14 INFO - Output received: 10:32:14 INFO - Usage: mozinstall [options] installer 10:32:14 INFO - Options: 10:32:14 INFO - -h, --help show this help message and exit 10:32:14 INFO - -d DEST, --destination=DEST 10:32:14 INFO - Directory to install application into. [default: 10:32:14 INFO - "/builds/slave/test-pgo"] 10:32:14 INFO - --app=APP Application being installed. [default: firefox] 10:32:14 INFO - mkdir: /builds/slave/test-pgo/build/application 10:32:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 10:32:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 10:32:29 INFO - Reading from file tmpfile_stdout 10:32:29 INFO - Output received: 10:32:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:32:29 INFO - Running post-action listener: _resource_record_post_action 10:32:29 INFO - ##### 10:32:29 INFO - ##### Running run-tests step. 10:32:29 INFO - ##### 10:32:29 INFO - Running pre-action listener: _resource_record_pre_action 10:32:29 INFO - Running main action method: run_tests 10:32:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:32:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:32:29 INFO - Python 2.7.3 10:32:29 INFO - Return code: 0 10:32:29 INFO - grabbing minidump binary from tooltool 10:32:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:29 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 0x1e8d920>, '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 0x1e8e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e8ecb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:32:29 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 10:32:29 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 10:32:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:32:29 INFO - Return code: 0 10:32:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:32:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:32:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:32:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:32:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:32:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:32:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:32:30 INFO - Return code: 0 10:32:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 10:32:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 10:32:30 INFO - Using env: {'DISPLAY': ':0', 10:32:30 INFO - 'HOME': '/home/cltbld', 10:32:30 INFO - 'LANG': 'en_US.UTF-8', 10:32:30 INFO - 'LANGUAGE': 'en_US:en', 10:32:30 INFO - 'LOGNAME': 'cltbld', 10:32:30 INFO - 'MAIL': '/var/mail/cltbld', 10:32:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:32:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:30 INFO - 'MOZ_NO_REMOTE': '1', 10:32:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:30 INFO - 'NO_EM_RESTART': '1', 10:32:30 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:32:30 INFO - 'PWD': '/builds/slave/test-pgo', 10:32:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:32:30 INFO - 'SHELL': '/bin/bash', 10:32:30 INFO - 'SHLVL': '1', 10:32:30 INFO - 'TERM': 'linux', 10:32:30 INFO - 'TMOUT': '86400', 10:32:30 INFO - 'USER': 'cltbld', 10:32:30 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460568697.219403-1239870872', 10:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:30 INFO - '_': '/tools/buildbot/bin/python'} 10:32:30 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 10:32:30 INFO - mozversion application_buildid: 20160413074152 10:32:30 INFO - mozversion application_changeset: 359c46892e799a4d6b6aeb148681bbbd3a3da4c4 10:32:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:32:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:32:30 INFO - mozversion application_name: Firefox 10:32:30 INFO - mozversion application_remotingname: firefox-dev 10:32:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:32:30 INFO - mozversion application_vendor: Mozilla 10:32:30 INFO - mozversion application_version: 47.0a2 10:32:30 INFO - mozversion platform_buildid: 20160413074152 10:32:30 INFO - mozversion platform_changeset: 359c46892e799a4d6b6aeb148681bbbd3a3da4c4 10:32:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:32:30 INFO - mozversion platform_version: 47.0a2 10:32:30 INFO - using testdate: 1460568750 10:32:30 INFO - actual date: 1460568750 10:32:30 INFO - starting webserver on 'localhost:35423' 10:32:30 INFO - SUITE-START | Running 2 tests 10:32:30 INFO - TEST-START | dromaeo_css 10:32:30 INFO - operating with platform_type : linux_ 10:32:30 INFO - Initialising browser for dromaeo_css test... 10:32:30 INFO - TEST-INFO | started process 12864 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpReiNq3/profile http://localhost:35423/getInfo.html) 10:32:34 INFO - PROCESS | 12864 | 10:32:34 INFO - PROCESS | 12864 | (process:12945): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:32:35 INFO - PROCESS | 12864 | __metrics Screen width/height:1600/1200 10:32:35 INFO - PROCESS | 12864 | colorDepth:24 10:32:35 INFO - PROCESS | 12864 | Browser inner width/height: 1024/697 10:32:35 INFO - PROCESS | 12864 | __metrics 10:32:36 ERROR - PROCESS | 12864 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 10:32:37 INFO - TEST-INFO | 12864: exit 0 10:32:37 INFO - Browser initialized. 10:32:37 INFO - Running cycle 1/1 for dromaeo_css test... 10:32:37 INFO - TEST-INFO | started process 12996 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpReiNq3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:32:39 INFO - PROCESS | 12996 | 10:32:39 INFO - PROCESS | 12996 | (process:13064): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:32:49 INFO - PROCESS | 12996 | RSS: Main: 151310336 10:32:49 INFO - PROCESS | 12996 | 10:33:39 INFO - PROCESS | 12996 | 1460568819239 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] 10:35:47 INFO - PROCESS | 12996 | Cycle 1(1): loaded http://localhost:35423/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35423/tests/dromaeo/cssquery-ext.html) 10:35:48 INFO - PROCESS | 12996 | RSS: Main: 154902528 10:35:48 INFO - PROCESS | 12996 | 10:38:49 INFO - PROCESS | 12996 | Cycle 1(1): loaded http://localhost:35423/tests/dromaeo/cssquery-ext.html (next: http://localhost:35423/tests/dromaeo/cssquery-jquery.html) 10:38:50 INFO - PROCESS | 12996 | RSS: Main: 154329088 10:38:50 INFO - PROCESS | 12996 | 10:41:52 INFO - PROCESS | 12996 | Cycle 1(1): loaded http://localhost:35423/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35423/tests/dromaeo/cssquery-mootools.html) 10:41:52 INFO - PROCESS | 12996 | RSS: Main: 152403968 10:41:52 INFO - PROCESS | 12996 | 10:44:54 INFO - PROCESS | 12996 | Cycle 1(1): loaded http://localhost:35423/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35423/tests/dromaeo/cssquery-prototype.html) 10:44:55 INFO - PROCESS | 12996 | RSS: Main: 152244224 10:44:55 INFO - PROCESS | 12996 | 10:47:57 INFO - PROCESS | 12996 | Cycle 1(1): loaded http://localhost:35423/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35423/tests/dromaeo/cssquery-yui.html) 10:47:57 INFO - PROCESS | 12996 | RSS: Main: 153096192 10:47:57 INFO - PROCESS | 12996 | 10:50:59 INFO - PROCESS | 12996 | Cycle 1(1): loaded http://localhost:35423/tests/dromaeo/cssquery-yui.html (next: http://localhost:35423/tests/dromaeo/cssquery-dojo.html) 10:51:00 INFO - PROCESS | 12996 | RSS: Main: 154869760 10:51:00 INFO - PROCESS | 12996 | 10:51:00 INFO - PROCESS | 12996 | __start_tp_report 10:51:00 INFO - PROCESS | 12996 | _x_x_mozilla_page_load 10:51:00 INFO - PROCESS | 12996 | _x_x_mozilla_page_load_details 10:51:00 INFO - PROCESS | 12996 | |i|pagename|runs| 10:51:00 INFO - PROCESS | 12996 | |0;dojo.html;3315.7347412207027;3391.7795343302682;3411.3347897160065;3448.8792892248775;3460.740444466666;5483.5887308451875;5495.725213739307;5502.614816962814;5531.170324451329;5571.192177134313;5517.724113794315;5526.171074338851;5532.446755324466;5548.167774833777;5557.027520183972;5051.974740126294;5061.6962982221;5131.153359695646;5135.64050516464;5165.096108181072;4953.984433191205;5060.645754797166;5174.974125129369;5186.662866913657;5242.895142097156;5107.080725469414;5108.131617624994;5171;5179.249008893708;5215.113430716769;5127.102757017507;5133.101707201225;5136.203888397267;5146.922796158061;5165.870853228662;4928.704277743311;4953.578945789613;5019.774110165052;5057.393112826448;5099.59203263738;5394.298741163623;5445.401005889349;5446.700431476267;5459.290292262021;5473.75368108436;5960.433758792908;5986.102084687332;6023.208327107897;6030.246219222598;6039.396060393926;5842.532597392241;5938.406159384071;5995.37048609894;6018.759249630053;6022.969885150546;5560.860978475571;5570.805021824257;5574.9721251393885;5575.721213939328;5588.636738612018;5951.821445356646;6079.513638908877;6085;6085.4523092921845;6104.17593624855;5780.797672081457;5851.6781577012825;5858.8242352729485;5859.648421094748;5880.059190529495;5923.229980102559;5944.464998150187;5948.881022379528;5960.552958528127;5960.850978725566;5810.302763668386;5913.852153696192;5926.496247818984;5928.822135335947;5945.227120474311;5896.557758168155;5900.527957763368;5901.055831067095;5921.200637913913;5939.2575928009;4418.80115394808;4457.888552786207;4459.777011149429;4494.910101797946;4496.685232033727;4012.7792971386853;4020.296448121567;4061.7156799023783;4068.9186216275507;4087.080406908422;5664.433556644302;5668.234788303609;5713.514351280104;5732.799352022659;5794.217780599565;6004.729787159588;6005.3394126646035;6018.548608854353;6022.066579680157;6028.125921741323;5639.154126880919;5651.180578816049;5741.770329186869;5761.827145185651;5763.596548241583;5065.442801291855;5074.264231686385;5104.183330667075;5108.361454818148;5126.769295381717;6137.662428566382;6167.969160154171;6169.074638804125;6172.321044685081;6176.413240742122;5844.707764611838;6004.429579190058;6005.789797357072;6009.338972712911;6048.243969503812;6122.398155112157;6134.601250918676;6171.043488259327;6174.228221472316;6176.536759742948;5897.941020589739;5902.675352855634;5911.083782013795;5912.46787789101;5919.4080591940465;5811.244538210006;5961.4038596140035;6015.1278064681255;6033.366496517978;6072;5835.67903765297;5856.150858125633;5858.853528661817;5892.499137573354;5896.439838215363;5842.620229685057;5843.29880414353;5843.590948633725;5851.356350801493;5896.64620122794;5658.801941932177;5755.482006619424;5792.94207057924;5837.066069428871;5854.268216472941;5873.530117590668;5887.764489420375;5899.115132730125;5900.1149827526215;5909.734061967136;5632.267805185464;5770.422957704196;5771.076627739541;5773.162891380643;5789.421057894346 10:51:00 INFO - PROCESS | 12996 | |1;ext.html;536.2224774077586;537.4383768961435;548.0737553534524;563.1693252452633;589.761146735572;39880.60417885375;40599.39100913489;40662.796686016525;40745.59254407455;40824;44487;44734;44771.55228447715;45036.3244551332;45190.32214516777;8854.114588541142;8969.865452018224;8978.50618215998;9044.638214471413;9066.18404343609;8795.076516965722;8945;8983.910160898373;9082.954585227064;9161.633534658638;9124.954375228115;9149.313801464883;9185.127412895798;9203.493807840567;9217.723468295962;9083.227925626297;9115.772105697344;9129.452232865982;9154.633814647406;9167.083291670813;9013.278937684969;9163.404378715362;9169.587368568431;9194;9196.448213107167;37654.24691506182;37704.43443348324;37765.433518497244;38026.61973380258;38485.80757096224;3279.5244689520123;3593.82030898454;3632.164602141496;3690.6862916652117;4275.5296917339065;29475.70524294751;30171.245718856986;30403.695963040307;30504.08487745371;31039.534406983912;3735.2716220337047;3736.925261494755;3768.2086761779783;3827.502424684801;3852.325842977468;202994;203140;204423.99999999852;204459;206184;46756.5324346759;47465;63436.365636343966;64329.74845880372;64343.356566434675;44704.3294350585;45272.3209151863;45274.320885186746;45329.77335113303;45436.54563454323;17071.914640426967;17368.826311736975;17382.478525643997;17399.130043497775;17420.216090275968;13906.30468476572;13946;14036.508722194878;14063.85936140646;14069.155850648995;15199.468018619295;15854;15986.200689965455;16034.599135021484;16087.115208663401;5888.293404791452;5893.347993402986;5934.198883150806;5944.940550594439;5989.161517387569;989.2333441582687;1036.6519832579213;1046.9633562825265;1062.771504126601;1136.4431428599926;30340;31050.68949310478;31265;31279.68720312813;31674.524882126785;1066.6160182334354;1146.8394424780538;1187.9940600297116;1202.1044321980005;1251.5306759965013;15763.921180394025;15824.367025318857;16115.274812633459;16232.188390580424;16404.26180821866;345805;523989;748877;760912;761880;64088.67955660285;65031.67484162549;65266.34733652603;65268.347316526226;65302;1482.85171482853;1491.7240310542584;1500.6398464368474;1508.8491150885043;1512.122968678186;32379.51430728494;32498.67501325051;32954.17614559655;33211;33555.328893422484;51229.74385128199;51953;52031;52370.214446782564;52418;327050;328572;330611;330953;332086;36246.35248031364;36284.45573316349;36742.44886326654;36874.44688329731;36918.630813692595;47636.285455718884;47810.521894780606;48809;49042.509574903794;49552;40611.390829136995;40679;41218.38172427476;41460.1707965833;41782.58217417787;40303;40325;40753.59246407498;41311.793441032605;41691.37462938119;39574.2085158301;39932;40246.1950760989;40595.7970210147;40785.79607101945;34124.65875341215;34978.56632531523;35328;35458.822705886305;36056.639433606375;26998.730012699623;27370.315742106606;27406.725932741214;27544.347339159714;27814.16557503278 10:51:00 INFO - PROCESS | 12996 | |2;jquery.html;364.35145441114815;384.164442337915;385.4334128830618;389.34006858375056;393.25085711719186;17655.646887062252;18518.814811851877;18696.719549206773;19164.137613807394;19452.805471945278;11880.28718276904;11939.164258501887;12400.13199076065;17418.3032678693;17876.463706088838;4898.118338699032;5077.33994580704;5102.821401250957;5121.66709163905;6881.13985751781;7111.288871112899;7124.073870396841;7191.928080719178;7192.388646965014;7196.352328290479;6381.521385896053;6652.401283884449;6654.968479885625;7092.680829362691;7137.10786151731;6596.901046484307;6600.60396376219;6610.9669451652435;6662.300458451866;6998.405135563483;6705.1283333166375;6708.631025293607;6735.057092007123;6742.258351581322;6750.35871592198;24238;24822;25176.24471265865;26056.73943260581;26061.478770424674;2540.8602526861014;2610.673665791776;2650.907218247352;2653.854038027908;3161.1780936956325;14914.328855201433;15017.174055426947;15214.087154770748;15548.611284717972;15759.054456732632;1980.5840773437596;1990.7113468547125;2014.4560968538412;2029.8071683190074;2032.8576999610034;78052.60973695152;79547.20452795456;80002.19997800006;80181;80212.59893700494;14874.330655120546;15817.683646327008;15886.443974460839;15924.124173170587;16076.517704468884;13324.200547967153;13889.444422222998;27577.724222757915;27852.442951140863;27919.72080279212;6340.397662222082;6509.1863517060365;7542.811429714301;8095.02859656845;8273.33813294935;8224;8324.958375208207;8369.665213391518;8435.536045517556;8445.408821382567;3892.143728379752;4045.211183819127;4303.806328715215;4317.7193482423545;4353.064091220403;1894.3369820562693;1903.200655724599;1929.1415320182384;1956.6086782643529;1966.6853303471662;1001.2940876681922;1029.7683021320142;1035.994820025895;1055.6674647486018;1060.1571750458404;17262.82737172612;17334.566635834206;18843;19050.333238336592;19355.322563710204;993.1111655068673;995.3530205366425;1036.7770929250096;1063.6596289187385;1085.6851513061124;10151;10248.743781405525;10575.312604680672;10810;10824.512896919658;339964;343282;345489;346130;476209;51875.48124518782;53610.73194634002;75378.62310688412;81661.18338816655;82228;1017.8015287019108;1021.5862575656871;1027.547878933267;1047.4291511126303;1058.0847566854768;16301.755473668141;16469.176541172656;16495.505134845975;16685.91657041707;16914.238859251116;33343.83328083344;34437;34850;36186;36484.81757591195;45082.77458612817;47298.76350618225;48729.75635121802;48927;48944;8596.527191004554;8613.26787223068;8716.084811094745;8830.205281524437;8848.557572121497;7208.603526805866;9950.004999499992;10025.799484010426;13288.534901278408;13466;11236.213465057368;11249.606263780728;11303.095752339957;11346.602868899548;11529.711757206136;5281.894362112813;9495.05049495045;9783.80432391334;11258.493367798632;11374.374409407563;11541.82687259675;11687;11741.647750567497;11757.529698811952;11810.645680629596;8680.782980425287;8778.604962776562;8867.512286824287;8895.332850036144;9043.864342034743;10610.469476526298;11024.614138505114;11060.612878549213;11064.889351106385;11305.491252893475 10:51:00 INFO - PROCESS | 12996 | |3;mootools.html;1575.0628376116213;1616.9029858208505;1850.6761316769562;1889.4898377438083;1904.6190761847643;7354.669039893204;7984.920150798504;7990.320822730067;8210.178982101786;8265.628046737897;8078.434509584332;8088.312493438065;8117.066537348207;8190.9590452047805;8227.670893164266;2359.3629719975597;2359.716833979925;2360.1621424394352;2373.3829204406893;2376.7266764322067;2311.2372916937456;2326.499802542453;2423.236680445663;2428.089466450081;2434.914777982771;2373.4778348763243;2393.700787401575;2400.0399840063938;2419.6491508731224;2439.3413778279855;2364.397078744909;2370.1704403458825;2371;2384.332386931662;2411.2284069097896;2341.4263505441104;2356.681847950539;2363.61000434928;2372.7034120734907;2374.78626923576;8312.667493300261;8342.749717508485;8365.958170209171;8374.120717324655;8404;5088.847334579968;5201.8959620807755;5209.583233341324;5211.661242019257;5213.426523082458;3158.952615710766;3171.8255495947715;3218.6298575663864;3287.9506807397906;3291.1772056985756;1075.9031687148195;1095.11842966412;1107.8615173103362;1121.870984836746;1123.5168877382723;11633.53465861373;11638.6508404748;11702.473388697445;11718.23831450953;11804.645860624196;4410.272305069628;4483.14820184164;4558.544145585482;4619.46876109245;4627.375304333939;9956.601735930626;9993.650222242186;9995.400275983464;10030.197584193247;10039.694839670796;5234.816781412632;5248.606354523426;5270.683758974474;5276.261323414725;5278.076336641073;4542.659300552472;4652.209124448784;4672.929906051412;4697.412823397075;4713.528647135327;3519.1202199450136;3636.9818150909077;3641.3991691371157;3659.524261845943;3661.798601076913;1082.226208261097;1087.3693257910393;1098.8351747237978;1102.8786833448314;1133.5465813674432;1441.344188394278;1463.9048461849945;1463.9121652700871;1474.4765608209145;1501.909885406879;7917.366610671133;7929.5242285463055;7966.0839003514175;8098.190180981973;8102.351811855156;500.7120905479364;502.0786856119062;529.9205119232068;534.1827004682841;545.440923053873;5535.308086489189;5651.463111004448;5667.574931880125;5676.914846277309;5723.969685456575;9762.219022478184;10343.172546196287;10358;10425.426601536836;10481.790364192673;10001.34991225568;10168;10176.745581360525;10270.948645256725;10307.175425965905;7891.723789667334;8078.757637270891;8080;8088.312493438124;8125.4718443301;7628.1227658817725;7693.038370203724;7698.846023079395;7714.961425192838;7758.612069396395;8925.821483570162;9092.408993415407;9143.26853851677;9203.171714545722;9219.677311294072;9351.521846710491;9368.531573421165;9401.294902882448;9461.053894610484;9569.425834449677;6074.635521868702;6530.738770449128;6701.53089283765;6754.966225168842;6964.65176741171;7840.764777056697;7860.764177074697;7863.52818830872;7902.68389264446;7910.7231246906085;6951.443884489127;7039.718411263492;7062.293770622897;7119.644017799193;7178.174509931425;7132.322429369202;7183.5330703504105;7197.856042879218;7203.855922881408;7309.232530584212;7461.067366579177;7550.509216900884;7622.428317876293;7630.618469076635;7638.083429988437;6774.762883299061;6824.454043676593;6830.487713421414;6884.827879303058;6911;6782.898256526058;6846.383825455733;6861.4510839133745;6870.690818913061;6875.89686154698 10:51:00 INFO - PROCESS | 12996 | |4;prototype.html;342.0866287013673;352.73897315986164;356.4777600814806;356.5222601713703;360.8304097074376;6427.453666438352;6440.774572889944;6445.871082578352;6456;6472.935270647292;6427.421532062113;6429.710663020163;6431.967840160793;6433.420992110709;6439.806805795822;4718.339432479438;4813.542713442217;4824.565789079;4830.444498882621;4923.384576927884;4838.322634831126;4845.733484658343;4864.197407427788;4883.780229889663;4891.192953162724;4821.590164835976;4842.2736589511505;4860.441049279325;4863.635227357945;4871.147549178897;4848.757562121879;4867.902641947159;4874.098291816008;4887.511248875084;4887.657863949525;4231.090315582134;4234.195502854448;4237.957620423787;4239.236937351276;4247.023184667513;6002.699865006733;6147.47746441553;6152.692365381758;6154.5076393888385;6154.538409619252;5666.263385759866;5677.063284558043;5683.318001839806;5685.431456854281;5692.288463942007;6716.899246511306;6730.966345168292;6731.495137864631;6773.864522709568;6790.5925644460995;4646.79089440976;4650.395448591661;4652.930206046912;4655.813767449332;4661.836835710734;7070.399016083587;7107.857842843166;7128.679209435588;7131.536450130725;7160.785176444715;4688.203005489075;4767.427908650984;4790.880227994328;4794.760261986887;4807.086653535817;4806.711597304173;4832.782524786393;4845.370101886732;4847.175980083394;4848.054629347314;5631.521320687787;5636.830895073154;5637.46444087811;5649;5649.322081350264;6845.349691779273;6846.486513511507;6851.314868513208;6856.382925536725;6874.896876546856;1684.9578760531085;1686.7132587460162;1686.7807185066108;1690.3576640876388;1691.9407820726215;1046.8482070099792;1089.096050278267;1106.3859557945257;1111.6109361723493;1113.276370359273;6671.799846004627;6703.731850725916;6711.362420570038;6715.664216789239;6718.294579069225;7060.823479412953;7085.858282834314;7096;7100.396466300423;7120.430365570742;6441.420272175433;6519.511036672268;6584.078229047937;6701.865962680719;6747.460203183734;3838.596947320547;3873.8450461981206;3881.262560113569;3909.667678247324;3911.78485183312;7369.4472914531625;7379.926200737924;7380.372668323253;7390.556566605914;7391.741289054858;7315.597642129627;7322.560646361236;7339.302766237199;7371.631418429057;7372.741954031583;7132.358087772125;7357.227491113463;7358.0434543509;7361.779146625609;7367.079115110611;7091.9290807091265;7128.964355178191;7160.427165826617;7175.174854891546;7188.993540904382;6999.440044796303;7026.2271150174465;7038.260982596754;7051.1186101737285;7061.823454413475;7361.447891408273;7362.815929601803;7367.263273672805;7388.113426388652;7396.186419493743;4791.640626953063;4920.926186107283;4925.38432695913;4933.186024305949;5006.098902197639;7021;7045.436365090883;7056.400205982549;7080.468964827762;7102.218755936739;6778.186617605722;6810.6594670265295;6877.518573699793;6878.27778083314;6881.071055407656;6842.897356539556;6851.246362899978;6863.725450982104;6871.03805467245;6874.931250687429;6541.967290163519;6701.832454188684;6756.459483241427;6774.559653622498;6782.457403407617;6845.794626161223;6862.622555759481;6872.175338959357;6883.27725588806;6895.275996020547;6610.900836487361;6612.437942774918;6649.800505984828;6652.101966234496;6709.194896612243 10:51:00 INFO - PROCESS | 12996 | |5;yui.html;790;791.7426836278211;792.1286584756768;914.8627705844123;933.0715937642045;13040.347982600879;13182.340882955861;13211.405486753096;13223.603291901247;13227.735445291088;11817.822732658995;11823.467943942522;11838.112141589372;11852.111091668137;11880.227785193978;730.989035164473;890.9910900890973;904.9909500904972;908.0828363353028;908.2007833106857;910.3218102513637;913.4199783137722;914.6524320758102;914.9679761208359;919.8436265834824;953.323140570196;953.8855337359527;958.5973890965811;961.2118063188153;961.7066794627635;946.4179529589322;950.2825366848055;951.167728237792;952.3190918493276;956.8851737791475;707.4163814852716;708.4120180250432;708.4721882197796;709.0498731699547;711.5090587494612;12407.131500794949;12466.252024878537;12499.625011249676;12796.552120675731;12807;13719.862801371959;14038.087524310888;14093;14104.71790564183;14130.293485325692;11070.667879963614;11213.383263920481;11862.110341724405;12049.819252711217;12197.39013049344;3914.354131568288;3956.9208615827524;3977.5823538528325;4004.3993400989793;4044.3933409988736;49188.26217606739;49288.50711492875;49607.50392496065;49638.50361496375;49798.7510062451;10368.585256589802;10502.68491945243;10735.677929662123;10893.891061089445;11065.336079835235;17475.38836140729;17568.64862702739;17595.824041759675;17690.203940822696;17722.645547088985;8289.212524810133;8311;8316.833663326699;8411.747647570583;8498.447600905922;4655.51117132703;4676.251799712029;4691;4752.287156926489;4848.927266091011;3402.5236466894653;3415.504751811023;3442.122258823984;3442.7245820334315;3446.172918499592;627.7928283666379;634.3307810260128;637.4836382530073;637.9744810207633;639.3223183425583;650.7494614573424;659.9109120268703;706.1420374245316;713.7359177104505;722.1695050691746;8397.6221070052;8949.507777072324;9680.370775899544;9705.17506011997;9761.219102471785;748.1695318196797;749.7600767754267;755.7090520149782;757.3070640364116;776.7514395393533;3950.9012274693364;4276.615104640598;4294.613484786384;4398.362237475612;4422.115576884572;56022;56031.159532607046;56477;56574;56614.018509351976;51876;52622.21066684003;52822.20766688503;52860.73569632127;53041.2043819343;47900.28149577759;48227.75886120617;48317.275240871415;48705.5129448701;49444.75277623661;8571.4000019998;8720.171583699539;8899.510526921082;8921.910780892107;9021.90978090237;36592.817035915716;37257.441138382404;37335.81332093322;37457;38433.615663844124;43308.56691433171;44793.552064478936;47124;47178.528214717415;47344.053118938114;10947.890521094687;11100.888991109985;11159.665210043711;11209.887901120885;11404.657860264206;12318.630441086782;12441.066919981218;12455.750884982432;12502.124851260325;12630;10974.615888443866;12214.328211948072;12316.076294278144;12900.612981610566;13106.672333191365;11895.345755983504;12207.45066471993;12444.937775311066;12461.688457788265;12783.552575659807;11572.18994670365;12215;12268.263904165779;12360.134790564574;12664.366781660696;10065.741782277215;10640.84038739404;10662.786744265226;10691.572337106429;10878.129749619853;10235.590576376862;10627.893721063;10636.255462117888;10969.23215374948;11004.284721493077 10:51:00 INFO - PROCESS | 12996 | __end_tp_report 10:51:00 INFO - PROCESS | 12996 | __start_cc_report 10:51:00 INFO - PROCESS | 12996 | _x_x_mozilla_cycle_collect,329 10:51:00 INFO - PROCESS | 12996 | __end_cc_report 10:51:00 INFO - PROCESS | 12996 | __startTimestamp1460569860215__endTimestamp 10:51:00 INFO - PROCESS | 12996 | 10:51:00 INFO - PROCESS | 12996 | ------- Summary: start ------- 10:51:00 INFO - PROCESS | 12996 | Number of tests: 6 10:51:00 INFO - PROCESS | 12996 | 10:51:00 INFO - PROCESS | 12996 | [#0] dojo.html Cycles:165 Average:5547.00 Median:5792.94 stddev:613.87 (10.6%) stddev-sans-first:590.27 10:51:00 INFO - PROCESS | 12996 | Values: 3315.7 3391.8 3411.3 3448.9 3460.7 5483.6 5495.7 5502.6 5531.2 5571.2 5517.7 5526.2 5532.4 5548.2 5557.0 5052.0 5061.7 5131.2 5135.6 5165.1 4954.0 5060.6 5175.0 5186.7 5242.9 5107.1 5108.1 5171.0 5179.2 5215.1 5127.1 5133.1 5136.2 5146.9 5165.9 4928.7 4953.6 5019.8 5057.4 5099.6 5394.3 5445.4 5446.7 5459.3 5473.8 5960.4 5986.1 6023.2 6030.2 6039.4 5842.5 5938.4 5995.4 6018.8 6023.0 5560.9 5570.8 5575.0 5575.7 5588.6 5951.8 6079.5 6085.0 6085.5 6104.2 5780.8 5851.7 5858.8 5859.6 5880.1 5923.2 5944.5 5948.9 5960.6 5960.9 5810.3 5913.9 5926.5 5928.8 5945.2 5896.6 5900.5 5901.1 5921.2 5939.3 4418.8 4457.9 4459.8 4494.9 4496.7 4012.8 4020.3 4061.7 4068.9 4087.1 5664.4 5668.2 5713.5 5732.8 5794.2 6004.7 6005.3 6018.5 6022.1 6028.1 5639.2 5651.2 5741.8 5761.8 5763.6 5065.4 5074.3 5104.2 5108.4 5126.8 6137.7 6168.0 6169.1 6172.3 6176.4 5844.7 6004.4 6005.8 6009.3 6048.2 6122.4 6134.6 6171.0 6174.2 6176.5 5897.9 5902.7 5911.1 5912.5 5919.4 5811.2 5961.4 6015.1 6033.4 6072.0 5835.7 5856.2 5858.9 5892.5 5896.4 5842.6 5843.3 5843.6 5851.4 5896.6 5658.8 5755.5 5792.9 5837.1 5854.3 5873.5 5887.8 5899.1 5900.1 5909.7 5632.3 5770.4 5771.1 5773.2 5789.4 10:51:00 INFO - PROCESS | 12996 | 10:51:00 INFO - PROCESS | 12996 | [#1] ext.html Cycles:180 Average:55442.43 Median:39906.30 stddev:117622.18 (294.7%) stddev-sans-first:117879.90 10:51:00 INFO - PROCESS | 12996 | Values: 536.2 537.4 548.1 563.2 589.8 39880.6 40599.4 40662.8 40745.6 40824.0 44487.0 44734.0 44771.6 45036.3 45190.3 8854.1 8969.9 8978.5 9044.6 9066.2 8795.1 8945.0 8983.9 9083.0 9161.6 9125.0 9149.3 9185.1 9203.5 9217.7 9083.2 9115.8 9129.5 9154.6 9167.1 9013.3 9163.4 9169.6 9194.0 9196.4 37654.2 37704.4 37765.4 38026.6 38485.8 3279.5 3593.8 3632.2 3690.7 4275.5 29475.7 30171.2 30403.7 30504.1 31039.5 3735.3 3736.9 3768.2 3827.5 3852.3 202994.0 203140.0 204424.0 204459.0 206184.0 46756.5 47465.0 63436.4 64329.7 64343.4 44704.3 45272.3 45274.3 45329.8 45436.5 17071.9 17368.8 17382.5 17399.1 17420.2 13906.3 13946.0 14036.5 14063.9 14069.2 15199.5 15854.0 15986.2 16034.6 16087.1 5888.3 5893.3 5934.2 5944.9 5989.2 989.2 1036.7 1047.0 1062.8 1136.4 30340.0 31050.7 31265.0 31279.7 31674.5 1066.6 1146.8 1188.0 1202.1 1251.5 15763.9 15824.4 16115.3 16232.2 16404.3 345805.0 523989.0 748877.0 760912.0 761880.0 64088.7 65031.7 65266.3 65268.3 65302.0 1482.9 1491.7 1500.6 1508.8 1512.1 32379.5 32498.7 32954.2 33211.0 33555.3 51229.7 51953.0 52031.0 52370.2 52418.0 327050.0 328572.0 330611.0 330953.0 332086.0 36246.4 36284.5 36742.4 36874.4 36918.6 47636.3 47810.5 48809.0 49042.5 49552.0 40611.4 40679.0 41218.4 41460.2 41782.6 40303.0 40325.0 40753.6 41311.8 41691.4 39574.2 39932.0 40246.2 40595.8 40785.8 34124.7 34978.6 35328.0 35458.8 36056.6 26998.7 27370.3 27406.7 27544.3 27814.2 10:51:00 INFO - PROCESS | 12996 | 10:51:00 INFO - PROCESS | 12996 | [#2] jquery.html Cycles:180 Average:24810.09 Median:27886.08 stddev:61766.54 (221.5%) stddev-sans-first:61912.54 10:51:00 INFO - PROCESS | 12996 | Values: 364.4 384.2 385.4 389.3 393.3 17655.6 18518.8 18696.7 19164.1 19452.8 11880.3 11939.2 12400.1 17418.3 17876.5 4898.1 5077.3 5102.8 5121.7 6881.1 7111.3 7124.1 7191.9 7192.4 7196.4 6381.5 6652.4 6655.0 7092.7 7137.1 6596.9 6600.6 6611.0 6662.3 6998.4 6705.1 6708.6 6735.1 6742.3 6750.4 24238.0 24822.0 25176.2 26056.7 26061.5 2540.9 2610.7 2650.9 2653.9 3161.2 14914.3 15017.2 15214.1 15548.6 15759.1 1980.6 1990.7 2014.5 2029.8 2032.9 78052.6 79547.2 80002.2 80181.0 80212.6 14874.3 15817.7 15886.4 15924.1 16076.5 13324.2 13889.4 27577.7 27852.4 27919.7 6340.4 6509.2 7542.8 8095.0 8273.3 8224.0 8325.0 8369.7 8435.5 8445.4 3892.1 4045.2 4303.8 4317.7 4353.1 1894.3 1903.2 1929.1 1956.6 1966.7 1001.3 1029.8 1036.0 1055.7 1060.2 17262.8 17334.6 18843.0 19050.3 19355.3 993.1 995.4 1036.8 1063.7 1085.7 10151.0 10248.7 10575.3 10810.0 10824.5 339964.0 343282.0 345489.0 346130.0 476209.0 51875.5 53610.7 75378.6 81661.2 82228.0 1017.8 1021.6 1027.5 1047.4 1058.1 16301.8 16469.2 16495.5 16685.9 16914.2 33343.8 34437.0 34850.0 36186.0 36484.8 45082.8 47298.8 48729.8 48927.0 48944.0 8596.5 8613.3 8716.1 8830.2 8848.6 7208.6 9950.0 10025.8 13288.5 13466.0 11236.2 11249.6 11303.1 11346.6 11529.7 5281.9 9495.1 9783.8 11258.5 11374.4 11541.8 11687.0 11741.6 11757.5 11810.6 8680.8 8778.6 8867.5 8895.3 9043.9 10610.5 11024.6 11060.6 11064.9 11305.5 10:51:00 INFO - PROCESS | 12996 | 10:51:00 INFO - PROCESS | 12996 | [#3] mootools.html Cycles:180 Average:5804.44 Median:5273.47 stddev:3085.65 (58.5%) stddev-sans-first:3077.93 10:51:00 INFO - PROCESS | 12996 | Values: 1575.1 1616.9 1850.7 1889.5 1904.6 7354.7 7984.9 7990.3 8210.2 8265.6 8078.4 8088.3 8117.1 8191.0 8227.7 2359.4 2359.7 2360.2 2373.4 2376.7 2311.2 2326.5 2423.2 2428.1 2434.9 2373.5 2393.7 2400.0 2419.6 2439.3 2364.4 2370.2 2371.0 2384.3 2411.2 2341.4 2356.7 2363.6 2372.7 2374.8 8312.7 8342.7 8366.0 8374.1 8404.0 5088.8 5201.9 5209.6 5211.7 5213.4 3159.0 3171.8 3218.6 3288.0 3291.2 1075.9 1095.1 1107.9 1121.9 1123.5 11633.5 11638.7 11702.5 11718.2 11804.6 4410.3 4483.1 4558.5 4619.5 4627.4 9956.6 9993.7 9995.4 10030.2 10039.7 5234.8 5248.6 5270.7 5276.3 5278.1 4542.7 4652.2 4672.9 4697.4 4713.5 3519.1 3637.0 3641.4 3659.5 3661.8 1082.2 1087.4 1098.8 1102.9 1133.5 1441.3 1463.9 1463.9 1474.5 1501.9 7917.4 7929.5 7966.1 8098.2 8102.4 500.7 502.1 529.9 534.2 545.4 5535.3 5651.5 5667.6 5676.9 5724.0 9762.2 10343.2 10358.0 10425.4 10481.8 10001.3 10168.0 10176.7 10270.9 10307.2 7891.7 8078.8 8080.0 8088.3 8125.5 7628.1 7693.0 7698.8 7715.0 7758.6 8925.8 9092.4 9143.3 9203.2 9219.7 9351.5 9368.5 9401.3 9461.1 9569.4 6074.6 6530.7 6701.5 6755.0 6964.7 7840.8 7860.8 7863.5 7902.7 7910.7 6951.4 7039.7 7062.3 7119.6 7178.2 7132.3 7183.5 7197.9 7203.9 7309.2 7461.1 7550.5 7622.4 7630.6 7638.1 6774.8 6824.5 6830.5 6884.8 6911.0 6782.9 6846.4 6861.5 6870.7 6875.9 10:51:00 INFO - PROCESS | 12996 | 10:51:00 INFO - PROCESS | 12996 | [#4] prototype.html Cycles:180 Average:5719.05 Median:6496.22 stddev:1750.47 (26.9%) stddev-sans-first:1708.22 10:51:00 INFO - PROCESS | 12996 | Values: 342.1 352.7 356.5 356.5 360.8 6427.5 6440.8 6445.9 6456.0 6472.9 6427.4 6429.7 6432.0 6433.4 6439.8 4718.3 4813.5 4824.6 4830.4 4923.4 4838.3 4845.7 4864.2 4883.8 4891.2 4821.6 4842.3 4860.4 4863.6 4871.1 4848.8 4867.9 4874.1 4887.5 4887.7 4231.1 4234.2 4238.0 4239.2 4247.0 6002.7 6147.5 6152.7 6154.5 6154.5 5666.3 5677.1 5683.3 5685.4 5692.3 6716.9 6731.0 6731.5 6773.9 6790.6 4646.8 4650.4 4652.9 4655.8 4661.8 7070.4 7107.9 7128.7 7131.5 7160.8 4688.2 4767.4 4790.9 4794.8 4807.1 4806.7 4832.8 4845.4 4847.2 4848.1 5631.5 5636.8 5637.5 5649.0 5649.3 6845.3 6846.5 6851.3 6856.4 6874.9 1685.0 1686.7 1686.8 1690.4 1691.9 1046.8 1089.1 1106.4 1111.6 1113.3 6671.8 6703.7 6711.4 6715.7 6718.3 7060.8 7085.9 7096.0 7100.4 7120.4 6441.4 6519.5 6584.1 6701.9 6747.5 3838.6 3873.8 3881.3 3909.7 3911.8 7369.4 7379.9 7380.4 7390.6 7391.7 7315.6 7322.6 7339.3 7371.6 7372.7 7132.4 7357.2 7358.0 7361.8 7367.1 7091.9 7129.0 7160.4 7175.2 7189.0 6999.4 7026.2 7038.3 7051.1 7061.8 7361.4 7362.8 7367.3 7388.1 7396.2 4791.6 4920.9 4925.4 4933.2 5006.1 7021.0 7045.4 7056.4 7080.5 7102.2 6778.2 6810.7 6877.5 6878.3 6881.1 6842.9 6851.2 6863.7 6871.0 6874.9 6542.0 6701.8 6756.5 6774.6 6782.5 6845.8 6862.6 6872.2 6883.3 6895.3 6610.9 6612.4 6649.8 6652.1 6709.2 10:51:00 INFO - PROCESS | 12996 | 10:51:00 INFO - PROCESS | 12996 | [#5] yui.html Cycles:180 Average:14278.55 Median:24607.83 stddev:16226.89 (65.9%) stddev-sans-first:16240.79 10:51:00 INFO - PROCESS | 12996 | Values: 790.0 791.7 792.1 914.9 933.1 13040.3 13182.3 13211.4 13223.6 13227.7 11817.8 11823.5 11838.1 11852.1 11880.2 731.0 891.0 905.0 908.1 908.2 910.3 913.4 914.7 915.0 919.8 953.3 953.9 958.6 961.2 961.7 946.4 950.3 951.2 952.3 956.9 707.4 708.4 708.5 709.0 711.5 12407.1 12466.3 12499.6 12796.6 12807.0 13719.9 14038.1 14093.0 14104.7 14130.3 11070.7 11213.4 11862.1 12049.8 12197.4 3914.4 3956.9 3977.6 4004.4 4044.4 49188.3 49288.5 49607.5 49638.5 49798.8 10368.6 10502.7 10735.7 10893.9 11065.3 17475.4 17568.6 17595.8 17690.2 17722.6 8289.2 8311.0 8316.8 8411.7 8498.4 4655.5 4676.3 4691.0 4752.3 4848.9 3402.5 3415.5 3442.1 3442.7 3446.2 627.8 634.3 637.5 638.0 639.3 650.7 659.9 706.1 713.7 722.2 8397.6 8949.5 9680.4 9705.2 9761.2 748.2 749.8 755.7 757.3 776.8 3950.9 4276.6 4294.6 4398.4 4422.1 56022.0 56031.2 56477.0 56574.0 56614.0 51876.0 52622.2 52822.2 52860.7 53041.2 47900.3 48227.8 48317.3 48705.5 49444.8 8571.4 8720.2 8899.5 8921.9 9021.9 36592.8 37257.4 37335.8 37457.0 38433.6 43308.6 44793.6 47124.0 47178.5 47344.1 10947.9 11100.9 11159.7 11209.9 11404.7 12318.6 12441.1 12455.8 12502.1 12630.0 10974.6 12214.3 12316.1 12900.6 13106.7 11895.3 12207.5 12444.9 12461.7 12783.6 11572.2 12215.0 12268.3 12360.1 12664.4 10065.7 10640.8 10662.8 10691.6 10878.1 10235.6 10627.9 10636.3 10969.2 11004.3 10:51:00 INFO - PROCESS | 12996 | -------- Summary: end -------- 10:51:00 INFO - PROCESS | 12996 | 10:51:00 INFO - TEST-INFO | 12996: exit 0 10:51:00 INFO - TEST-OK | dromaeo_css | took 1110267ms 10:51:00 INFO - TEST-START | kraken 10:51:00 INFO - operating with platform_type : linux_ 10:51:00 INFO - Initialising browser for kraken test... 10:51:00 INFO - TEST-INFO | started process 13237 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjERYOA/profile http://localhost:35423/getInfo.html) 10:51:05 INFO - PROCESS | 13237 | 10:51:05 INFO - PROCESS | 13237 | (process:13315): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:51:06 INFO - PROCESS | 13237 | __metrics Screen width/height:1600/1200 10:51:06 INFO - PROCESS | 13237 | colorDepth:24 10:51:06 INFO - PROCESS | 13237 | Browser inner width/height: 1024/697 10:51:06 INFO - PROCESS | 13237 | __metrics 10:51:06 ERROR - PROCESS | 13237 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 10:51:07 INFO - TEST-INFO | 13237: exit 0 10:51:07 INFO - Browser initialized. 10:51:07 INFO - Running cycle 1/1 for kraken test... 10:51:07 INFO - TEST-INFO | started process 13366 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjERYOA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:51:09 INFO - PROCESS | 13366 | 10:51:09 INFO - PROCESS | 13366 | (process:13434): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:51:19 INFO - PROCESS | 13366 | RSS: Main: 151699456 10:51:19 INFO - PROCESS | 13366 | 10:51:22 INFO - PROCESS | 13366 | Cycle 1(1): loaded http://localhost:35423/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35423/tests/kraken/driver.html?testName=audio-beat-detection) 10:51:22 INFO - PROCESS | 13366 | RSS: Main: 156196864 10:51:22 INFO - PROCESS | 13366 | 10:51:25 INFO - PROCESS | 13366 | Cycle 1(1): loaded http://localhost:35423/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35423/tests/kraken/driver.html?testName=audio-dft) 10:51:26 INFO - PROCESS | 13366 | RSS: Main: 156110848 10:51:26 INFO - PROCESS | 13366 | 10:51:28 INFO - PROCESS | 13366 | Cycle 1(1): loaded http://localhost:35423/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35423/tests/kraken/driver.html?testName=audio-fft) 10:51:29 INFO - PROCESS | 13366 | RSS: Main: 156647424 10:51:29 INFO - PROCESS | 13366 | 10:51:31 INFO - PROCESS | 13366 | Cycle 1(1): loaded http://localhost:35423/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35423/tests/kraken/driver.html?testName=audio-oscillator) 10:51:32 INFO - PROCESS | 13366 | RSS: Main: 156065792 10:51:32 INFO - PROCESS | 13366 | 10:51:34 INFO - PROCESS | 13366 | Cycle 1(1): loaded http://localhost:35423/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35423/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:51:34 INFO - PROCESS | 13366 | RSS: Main: 156409856 10:51:34 INFO - PROCESS | 13366 | 10:51:38 INFO - PROCESS | 13366 | Cycle 1(1): loaded http://localhost:35423/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35423/tests/kraken/driver.html?testName=imaging-darkroom) 10:51:38 INFO - PROCESS | 13366 | RSS: Main: 156143616 10:51:38 INFO - PROCESS | 13366 | 10:51:42 INFO - PROCESS | 13366 | Cycle 1(1): loaded http://localhost:35423/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35423/tests/kraken/driver.html?testName=imaging-desaturate) 10:51:42 INFO - PROCESS | 13366 | RSS: Main: 156491776 10:51:42 INFO - PROCESS | 13366 | 10:51:45 INFO - PROCESS | 13366 | Cycle 1(1): loaded http://localhost:35423/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35423/tests/kraken/driver.html?testName=json-parse-financial) 10:51:46 INFO - PROCESS | 13366 | RSS: Main: 156643328 10:51:46 INFO - PROCESS | 13366 | 10:51:47 INFO - PROCESS | 13366 | Cycle 1(1): loaded http://localhost:35423/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35423/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:51:48 INFO - PROCESS | 13366 | RSS: Main: 156602368 10:51:48 INFO - PROCESS | 13366 | 10:51:50 INFO - PROCESS | 13366 | Cycle 1(1): loaded http://localhost:35423/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35423/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:51:50 INFO - PROCESS | 13366 | RSS: Main: 156872704 10:51:50 INFO - PROCESS | 13366 | 10:51:52 INFO - PROCESS | 13366 | Cycle 1(1): loaded http://localhost:35423/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35423/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:51:53 INFO - PROCESS | 13366 | RSS: Main: 156721152 10:51:53 INFO - PROCESS | 13366 | 10:51:55 INFO - PROCESS | 13366 | Cycle 1(1): loaded http://localhost:35423/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35423/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:51:56 INFO - PROCESS | 13366 | RSS: Main: 157196288 10:51:56 INFO - PROCESS | 13366 | 10:51:58 INFO - PROCESS | 13366 | Cycle 1(1): loaded http://localhost:35423/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35423/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:51:59 INFO - PROCESS | 13366 | RSS: Main: 156540928 10:51:59 INFO - PROCESS | 13366 | 10:52:01 INFO - PROCESS | 13366 | Cycle 1(1): loaded http://localhost:35423/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35423/tests/kraken/driver.html?testName=ai-astar) 10:52:01 INFO - PROCESS | 13366 | RSS: Main: 158740480 10:52:01 INFO - PROCESS | 13366 | 10:52:01 INFO - PROCESS | 13366 | __start_tp_report 10:52:01 INFO - PROCESS | 13366 | _x_x_mozilla_page_load 10:52:01 INFO - PROCESS | 13366 | _x_x_mozilla_page_load_details 10:52:01 INFO - PROCESS | 13366 | |i|pagename|runs| 10:52:01 INFO - PROCESS | 13366 | |0;ai-astar;111;105;112;111;114;122;112;111;113;111 10:52:01 INFO - PROCESS | 13366 | |1;audio-beat-detection;155;132;156;166;127;159;156;128;171;130 10:52:01 INFO - PROCESS | 13366 | |2;audio-dft;162;162;163;162;162;164;161;163;163;164 10:52:01 INFO - PROCESS | 13366 | |3;audio-fft;76;75;74;171;77;74;76;74;175;78 10:52:01 INFO - PROCESS | 13366 | |4;audio-oscillator;94;94;149;95;93;94;145;94;93;146 10:52:01 INFO - PROCESS | 13366 | |5;imaging-gaussian-blur;118;118;118;117;117;118;117;118;117;117 10:52:01 INFO - PROCESS | 13366 | |6;imaging-darkroom;147;147;146;147;147;146;146;146;147;147 10:52:01 INFO - PROCESS | 13366 | |7;imaging-desaturate;96;96;96;96;96;96;96;101;96;96 10:52:01 INFO - PROCESS | 13366 | |8;json-parse-financial;57;65;56;61;58;60;63;64;55;57 10:52:01 INFO - PROCESS | 13366 | |9;json-stringify-tinderbox;65;65;65;65;65;66;65;64;65;64 10:52:01 INFO - PROCESS | 13366 | |10;stanford-crypto-aes;80;80;79;80;77;79;79;87;79;79 10:52:01 INFO - PROCESS | 13366 | |11;stanford-crypto-ccm;116;111;118;117;119;117;124;116;114;115 10:52:01 INFO - PROCESS | 13366 | |12;stanford-crypto-pbkdf2;135;153;143;144;148;144;145;150;158;135 10:52:01 INFO - PROCESS | 13366 | |13;stanford-crypto-sha256-iterative;67;68;68;65;67;68;71;66;65;64 10:52:01 INFO - PROCESS | 13366 | __end_tp_report 10:52:01 INFO - PROCESS | 13366 | __start_cc_report 10:52:01 INFO - PROCESS | 13366 | _x_x_mozilla_cycle_collect,845 10:52:01 INFO - PROCESS | 13366 | __end_cc_report 10:52:01 INFO - PROCESS | 13366 | __startTimestamp1460569921400__endTimestamp 10:52:01 INFO - PROCESS | 13366 | 10:52:01 INFO - PROCESS | 13366 | ------- Summary: start ------- 10:52:01 INFO - PROCESS | 13366 | Number of tests: 14 10:52:01 INFO - PROCESS | 13366 | 10:52:01 INFO - PROCESS | 13366 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.00 stddev:4.18 (3.7%) stddev-sans-first:4.42 10:52:01 INFO - PROCESS | 13366 | Values: 111.0 105.0 112.0 111.0 114.0 122.0 112.0 111.0 113.0 111.0 10:52:01 INFO - PROCESS | 13366 | 10:52:01 INFO - PROCESS | 13366 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:156.00 stddev:16.90 (10.8%) stddev-sans-first:17.74 10:52:01 INFO - PROCESS | 13366 | Values: 155.0 132.0 156.0 166.0 127.0 159.0 156.0 128.0 171.0 130.0 10:52:01 INFO - PROCESS | 13366 | 10:52:01 INFO - PROCESS | 13366 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 10:52:01 INFO - PROCESS | 13366 | Values: 162.0 162.0 163.0 162.0 162.0 164.0 161.0 163.0 163.0 164.0 10:52:01 INFO - PROCESS | 13366 | 10:52:01 INFO - PROCESS | 13366 | [#3] audio-fft Cycles:10 Average:95.00 Median:75.50 stddev:41.14 (54.5%) stddev-sans-first:43.06 10:52:01 INFO - PROCESS | 13366 | Values: 76.0 75.0 74.0 171.0 77.0 74.0 76.0 74.0 175.0 78.0 10:52:01 INFO - PROCESS | 13366 | 10:52:01 INFO - PROCESS | 13366 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:94.00 stddev:25.53 (27.2%) stddev-sans-first:26.44 10:52:01 INFO - PROCESS | 13366 | Values: 94.0 94.0 149.0 95.0 93.0 94.0 145.0 94.0 93.0 146.0 10:52:01 INFO - PROCESS | 13366 | 10:52:01 INFO - PROCESS | 13366 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 10:52:01 INFO - PROCESS | 13366 | Values: 118.0 118.0 118.0 117.0 117.0 118.0 117.0 118.0 117.0 117.0 10:52:01 INFO - PROCESS | 13366 | 10:52:01 INFO - PROCESS | 13366 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:52:01 INFO - PROCESS | 13366 | Values: 147.0 147.0 146.0 147.0 147.0 146.0 146.0 146.0 147.0 147.0 10:52:01 INFO - PROCESS | 13366 | 10:52:01 INFO - PROCESS | 13366 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:1.58 (1.6%) stddev-sans-first:1.67 10:52:01 INFO - PROCESS | 13366 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 101.0 96.0 96.0 10:52:01 INFO - PROCESS | 13366 | 10:52:01 INFO - PROCESS | 13366 | [#8] json-parse-financial Cycles:10 Average:59.60 Median:60.50 stddev:3.53 (5.8%) stddev-sans-first:3.62 10:52:01 INFO - PROCESS | 13366 | Values: 57.0 65.0 56.0 61.0 58.0 60.0 63.0 64.0 55.0 57.0 10:52:01 INFO - PROCESS | 13366 | 10:52:01 INFO - PROCESS | 13366 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 10:52:01 INFO - PROCESS | 13366 | Values: 65.0 65.0 65.0 65.0 65.0 66.0 65.0 64.0 65.0 64.0 10:52:01 INFO - PROCESS | 13366 | 10:52:01 INFO - PROCESS | 13366 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:79.50 stddev:2.64 (3.3%) stddev-sans-first:2.80 10:52:01 INFO - PROCESS | 13366 | Values: 80.0 80.0 79.0 80.0 77.0 79.0 79.0 87.0 79.0 79.0 10:52:01 INFO - PROCESS | 13366 | 10:52:01 INFO - PROCESS | 13366 | [#11] stanford-crypto-ccm Cycles:10 Average:116.70 Median:117.00 stddev:3.40 (2.9%) stddev-sans-first:3.60 10:52:01 INFO - PROCESS | 13366 | Values: 116.0 111.0 118.0 117.0 119.0 117.0 124.0 116.0 114.0 115.0 10:52:01 INFO - PROCESS | 13366 | 10:52:01 INFO - PROCESS | 13366 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.50 Median:146.50 stddev:7.23 (4.9%) stddev-sans-first:6.60 10:52:01 INFO - PROCESS | 13366 | Values: 135.0 153.0 143.0 144.0 148.0 144.0 145.0 150.0 158.0 135.0 10:52:01 INFO - PROCESS | 13366 | 10:52:01 INFO - PROCESS | 13366 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.50 stddev:2.02 (3.0%) stddev-sans-first:2.15 10:52:01 INFO - PROCESS | 13366 | Values: 67.0 68.0 68.0 65.0 67.0 68.0 71.0 66.0 65.0 64.0 10:52:01 INFO - PROCESS | 13366 | -------- Summary: end -------- 10:52:01 INFO - PROCESS | 13366 | 10:52:02 INFO - TEST-INFO | 13366: exit 0 10:52:02 INFO - TEST-OK | kraken | took 61475ms 10:52:02 INFO - SUITE-END | took 1171s 10:52:02 INFO - Completed test suite (00:19:31) 10:52:02 INFO - javascript benchmark 10:52:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3315.7347412207027, 3391.7795343302682, 3411.3347897160065, 3448.8792892248775, 3460.740444466666, 5483.5887308451875, 5495.725213739307, 5502.614816962814, 5531.170324451329, 5571.192177134313, 5517.724113794315, 5526.171074338851, 5532.446755324466, 5548.167774833777, 5557.027520183972, 5051.974740126294, 5061.6962982221, 5131.153359695646, 5135.64050516464, 5165.096108181072, 4953.984433191205, 5060.645754797166, 5174.974125129369, 5186.662866913657, 5242.895142097156, 5107.080725469414, 5108.131617624994, 5171.0, 5179.249008893708, 5215.113430716769, 5127.102757017507, 5133.101707201225, 5136.203888397267, 5146.922796158061, 5165.870853228662, 4928.704277743311, 4953.578945789613, 5019.774110165052, 5057.393112826448, 5099.59203263738, 5394.298741163623, 5445.401005889349, 5446.700431476267, 5459.290292262021, 5473.75368108436, 5960.433758792908, 5986.102084687332, 6023.208327107897, 6030.246219222598, 6039.396060393926, 5842.532597392241, 5938.406159384071, 5995.37048609894, 6018.759249630053, 6022.969885150546, 5560.860978475571, 5570.805021824257, 5574.9721251393885, 5575.721213939328, 5588.636738612018, 5951.821445356646, 6079.513638908877, 6085.0, 6085.4523092921845, 6104.17593624855, 5780.797672081457, 5851.6781577012825, 5858.8242352729485, 5859.648421094748, 5880.059190529495, 5923.229980102559, 5944.464998150187, 5948.881022379528, 5960.552958528127, 5960.850978725566, 5810.302763668386, 5913.852153696192, 5926.496247818984, 5928.822135335947, 5945.227120474311, 5896.557758168155, 5900.527957763368, 5901.055831067095, 5921.200637913913, 5939.2575928009, 4418.80115394808, 4457.888552786207, 4459.777011149429, 4494.910101797946, 4496.685232033727, 4012.7792971386853, 4020.296448121567, 4061.7156799023783, 4068.9186216275507, 4087.080406908422, 5664.433556644302, 5668.234788303609, 5713.514351280104, 5732.799352022659, 5794.217780599565, 6004.729787159588, 6005.3394126646035, 6018.548608854353, 6022.066579680157, 6028.125921741323, 5639.154126880919, 5651.180578816049, 5741.770329186869, 5761.827145185651, 5763.596548241583, 5065.442801291855, 5074.264231686385, 5104.183330667075, 5108.361454818148, 5126.769295381717, 6137.662428566382, 6167.969160154171, 6169.074638804125, 6172.321044685081, 6176.413240742122, 5844.707764611838, 6004.429579190058, 6005.789797357072, 6009.338972712911, 6048.243969503812, 6122.398155112157, 6134.601250918676, 6171.043488259327, 6174.228221472316, 6176.536759742948, 5897.941020589739, 5902.675352855634, 5911.083782013795, 5912.46787789101, 5919.4080591940465, 5811.244538210006, 5961.4038596140035, 6015.1278064681255, 6033.366496517978, 6072.0, 5835.67903765297, 5856.150858125633, 5858.853528661817, 5892.499137573354, 5896.439838215363, 5842.620229685057, 5843.29880414353, 5843.590948633725, 5851.356350801493, 5896.64620122794, 5658.801941932177, 5755.482006619424, 5792.94207057924, 5837.066069428871, 5854.268216472941, 5873.530117590668, 5887.764489420375, 5899.115132730125, 5900.1149827526215, 5909.734061967136, 5632.267805185464, 5770.422957704196, 5771.076627739541, 5773.162891380643, 5789.421057894346], "unit": "score", "name": "dojo.html", "value": 5507.3611597710105}, {"lowerIsBetter": false, "replicates": [536.2224774077586, 537.4383768961435, 548.0737553534524, 563.1693252452633, 589.761146735572, 39880.60417885375, 40599.39100913489, 40662.796686016525, 40745.59254407455, 40824.0, 44487.0, 44734.0, 44771.55228447715, 45036.3244551332, 45190.32214516777, 8854.114588541142, 8969.865452018224, 8978.50618215998, 9044.638214471413, 9066.18404343609, 8795.076516965722, 8945.0, 8983.910160898373, 9082.954585227064, 9161.633534658638, 9124.954375228115, 9149.313801464883, 9185.127412895798, 9203.493807840567, 9217.723468295962, 9083.227925626297, 9115.772105697344, 9129.452232865982, 9154.633814647406, 9167.083291670813, 9013.278937684969, 9163.404378715362, 9169.587368568431, 9194.0, 9196.448213107167, 37654.24691506182, 37704.43443348324, 37765.433518497244, 38026.61973380258, 38485.80757096224, 3279.5244689520123, 3593.82030898454, 3632.164602141496, 3690.6862916652117, 4275.5296917339065, 29475.70524294751, 30171.245718856986, 30403.695963040307, 30504.08487745371, 31039.534406983912, 3735.2716220337047, 3736.925261494755, 3768.2086761779783, 3827.502424684801, 3852.325842977468, 202994.0, 203140.0, 204423.99999999852, 204459.0, 206184.0, 46756.5324346759, 47465.0, 63436.365636343966, 64329.74845880372, 64343.356566434675, 44704.3294350585, 45272.3209151863, 45274.320885186746, 45329.77335113303, 45436.54563454323, 17071.914640426967, 17368.826311736975, 17382.478525643997, 17399.130043497775, 17420.216090275968, 13906.30468476572, 13946.0, 14036.508722194878, 14063.85936140646, 14069.155850648995, 15199.468018619295, 15854.0, 15986.200689965455, 16034.599135021484, 16087.115208663401, 5888.293404791452, 5893.347993402986, 5934.198883150806, 5944.940550594439, 5989.161517387569, 989.2333441582687, 1036.6519832579213, 1046.9633562825265, 1062.771504126601, 1136.4431428599926, 30340.0, 31050.68949310478, 31265.0, 31279.68720312813, 31674.524882126785, 1066.6160182334354, 1146.8394424780538, 1187.9940600297116, 1202.1044321980005, 1251.5306759965013, 15763.921180394025, 15824.367025318857, 16115.274812633459, 16232.188390580424, 16404.26180821866, 345805.0, 523989.0, 748877.0, 760912.0, 761880.0, 64088.67955660285, 65031.67484162549, 65266.34733652603, 65268.347316526226, 65302.0, 1482.85171482853, 1491.7240310542584, 1500.6398464368474, 1508.8491150885043, 1512.122968678186, 32379.51430728494, 32498.67501325051, 32954.17614559655, 33211.0, 33555.328893422484, 51229.74385128199, 51953.0, 52031.0, 52370.214446782564, 52418.0, 327050.0, 328572.0, 330611.0, 330953.0, 332086.0, 36246.35248031364, 36284.45573316349, 36742.44886326654, 36874.44688329731, 36918.630813692595, 47636.285455718884, 47810.521894780606, 48809.0, 49042.509574903794, 49552.0, 40611.390829136995, 40679.0, 41218.38172427476, 41460.1707965833, 41782.58217417787, 40303.0, 40325.0, 40753.59246407498, 41311.793441032605, 41691.37462938119, 39574.2085158301, 39932.0, 40246.1950760989, 40595.7970210147, 40785.79607101945, 34124.65875341215, 34978.56632531523, 35328.0, 35458.822705886305, 36056.639433606375, 26998.730012699623, 27370.315742106606, 27406.725932741214, 27544.347339159714, 27814.16557503278], "unit": "score", "name": "ext.html", "value": 19546.837326560082}, {"lowerIsBetter": false, "replicates": [364.35145441114815, 384.164442337915, 385.4334128830618, 389.34006858375056, 393.25085711719186, 17655.646887062252, 18518.814811851877, 18696.719549206773, 19164.137613807394, 19452.805471945278, 11880.28718276904, 11939.164258501887, 12400.13199076065, 17418.3032678693, 17876.463706088838, 4898.118338699032, 5077.33994580704, 5102.821401250957, 5121.66709163905, 6881.13985751781, 7111.288871112899, 7124.073870396841, 7191.928080719178, 7192.388646965014, 7196.352328290479, 6381.521385896053, 6652.401283884449, 6654.968479885625, 7092.680829362691, 7137.10786151731, 6596.901046484307, 6600.60396376219, 6610.9669451652435, 6662.300458451866, 6998.405135563483, 6705.1283333166375, 6708.631025293607, 6735.057092007123, 6742.258351581322, 6750.35871592198, 24238.0, 24822.0, 25176.24471265865, 26056.73943260581, 26061.478770424674, 2540.8602526861014, 2610.673665791776, 2650.907218247352, 2653.854038027908, 3161.1780936956325, 14914.328855201433, 15017.174055426947, 15214.087154770748, 15548.611284717972, 15759.054456732632, 1980.5840773437596, 1990.7113468547125, 2014.4560968538412, 2029.8071683190074, 2032.8576999610034, 78052.60973695152, 79547.20452795456, 80002.19997800006, 80181.0, 80212.59893700494, 14874.330655120546, 15817.683646327008, 15886.443974460839, 15924.124173170587, 16076.517704468884, 13324.200547967153, 13889.444422222998, 27577.724222757915, 27852.442951140863, 27919.72080279212, 6340.397662222082, 6509.1863517060365, 7542.811429714301, 8095.02859656845, 8273.33813294935, 8224.0, 8324.958375208207, 8369.665213391518, 8435.536045517556, 8445.408821382567, 3892.143728379752, 4045.211183819127, 4303.806328715215, 4317.7193482423545, 4353.064091220403, 1894.3369820562693, 1903.200655724599, 1929.1415320182384, 1956.6086782643529, 1966.6853303471662, 1001.2940876681922, 1029.7683021320142, 1035.994820025895, 1055.6674647486018, 1060.1571750458404, 17262.82737172612, 17334.566635834206, 18843.0, 19050.333238336592, 19355.322563710204, 993.1111655068673, 995.3530205366425, 1036.7770929250096, 1063.6596289187385, 1085.6851513061124, 10151.0, 10248.743781405525, 10575.312604680672, 10810.0, 10824.512896919658, 339964.0, 343282.0, 345489.0, 346130.0, 476209.0, 51875.48124518782, 53610.73194634002, 75378.62310688412, 81661.18338816655, 82228.0, 1017.8015287019108, 1021.5862575656871, 1027.547878933267, 1047.4291511126303, 1058.0847566854768, 16301.755473668141, 16469.176541172656, 16495.505134845975, 16685.91657041707, 16914.238859251116, 33343.83328083344, 34437.0, 34850.0, 36186.0, 36484.81757591195, 45082.77458612817, 47298.76350618225, 48729.75635121802, 48927.0, 48944.0, 8596.527191004554, 8613.26787223068, 8716.084811094745, 8830.205281524437, 8848.557572121497, 7208.603526805866, 9950.004999499992, 10025.799484010426, 13288.534901278408, 13466.0, 11236.213465057368, 11249.606263780728, 11303.095752339957, 11346.602868899548, 11529.711757206136, 5281.894362112813, 9495.05049495045, 9783.80432391334, 11258.493367798632, 11374.374409407563, 11541.82687259675, 11687.0, 11741.647750567497, 11757.529698811952, 11810.645680629596, 8680.782980425287, 8778.604962776562, 8867.512286824287, 8895.332850036144, 9043.864342034743, 10610.469476526298, 11024.614138505114, 11060.612878549213, 11064.889351106385, 11305.491252893475], "unit": "score", "name": "jquery.html", "value": 9256.504163789583}, {"lowerIsBetter": false, "replicates": [1575.0628376116213, 1616.9029858208505, 1850.6761316769562, 1889.4898377438083, 1904.6190761847643, 7354.669039893204, 7984.920150798504, 7990.320822730067, 8210.178982101786, 8265.628046737897, 8078.434509584332, 8088.312493438065, 8117.066537348207, 8190.9590452047805, 8227.670893164266, 2359.3629719975597, 2359.716833979925, 2360.1621424394352, 2373.3829204406893, 2376.7266764322067, 2311.2372916937456, 2326.499802542453, 2423.236680445663, 2428.089466450081, 2434.914777982771, 2373.4778348763243, 2393.700787401575, 2400.0399840063938, 2419.6491508731224, 2439.3413778279855, 2364.397078744909, 2370.1704403458825, 2371.0, 2384.332386931662, 2411.2284069097896, 2341.4263505441104, 2356.681847950539, 2363.61000434928, 2372.7034120734907, 2374.78626923576, 8312.667493300261, 8342.749717508485, 8365.958170209171, 8374.120717324655, 8404.0, 5088.847334579968, 5201.8959620807755, 5209.583233341324, 5211.661242019257, 5213.426523082458, 3158.952615710766, 3171.8255495947715, 3218.6298575663864, 3287.9506807397906, 3291.1772056985756, 1075.9031687148195, 1095.11842966412, 1107.8615173103362, 1121.870984836746, 1123.5168877382723, 11633.53465861373, 11638.6508404748, 11702.473388697445, 11718.23831450953, 11804.645860624196, 4410.272305069628, 4483.14820184164, 4558.544145585482, 4619.46876109245, 4627.375304333939, 9956.601735930626, 9993.650222242186, 9995.400275983464, 10030.197584193247, 10039.694839670796, 5234.816781412632, 5248.606354523426, 5270.683758974474, 5276.261323414725, 5278.076336641073, 4542.659300552472, 4652.209124448784, 4672.929906051412, 4697.412823397075, 4713.528647135327, 3519.1202199450136, 3636.9818150909077, 3641.3991691371157, 3659.524261845943, 3661.798601076913, 1082.226208261097, 1087.3693257910393, 1098.8351747237978, 1102.8786833448314, 1133.5465813674432, 1441.344188394278, 1463.9048461849945, 1463.9121652700871, 1474.4765608209145, 1501.909885406879, 7917.366610671133, 7929.5242285463055, 7966.0839003514175, 8098.190180981973, 8102.351811855156, 500.7120905479364, 502.0786856119062, 529.9205119232068, 534.1827004682841, 545.440923053873, 5535.308086489189, 5651.463111004448, 5667.574931880125, 5676.914846277309, 5723.969685456575, 9762.219022478184, 10343.172546196287, 10358.0, 10425.426601536836, 10481.790364192673, 10001.34991225568, 10168.0, 10176.745581360525, 10270.948645256725, 10307.175425965905, 7891.723789667334, 8078.757637270891, 8080.0, 8088.312493438124, 8125.4718443301, 7628.1227658817725, 7693.038370203724, 7698.846023079395, 7714.961425192838, 7758.612069396395, 8925.821483570162, 9092.408993415407, 9143.26853851677, 9203.171714545722, 9219.677311294072, 9351.521846710491, 9368.531573421165, 9401.294902882448, 9461.053894610484, 9569.425834449677, 6074.635521868702, 6530.738770449128, 6701.53089283765, 6754.966225168842, 6964.65176741171, 7840.764777056697, 7860.764177074697, 7863.52818830872, 7902.68389264446, 7910.7231246906085, 6951.443884489127, 7039.718411263492, 7062.293770622897, 7119.644017799193, 7178.174509931425, 7132.322429369202, 7183.5330703504105, 7197.856042879218, 7203.855922881408, 7309.232530584212, 7461.067366579177, 7550.509216900884, 7622.428317876293, 7630.618469076635, 7638.083429988437, 6774.762883299061, 6824.454043676593, 6830.487713421414, 6884.827879303058, 6911.0, 6782.898256526058, 6846.383825455733, 6861.4510839133745, 6870.690818913061, 6875.89686154698], "unit": "score", "name": "mootools.html", "value": 4673.737963864754}, {"lowerIsBetter": false, "replicates": [342.0866287013673, 352.73897315986164, 356.4777600814806, 356.5222601713703, 360.8304097074376, 6427.453666438352, 6440.774572889944, 6445.871082578352, 6456.0, 6472.935270647292, 6427.421532062113, 6429.710663020163, 6431.967840160793, 6433.420992110709, 6439.806805795822, 4718.339432479438, 4813.542713442217, 4824.565789079, 4830.444498882621, 4923.384576927884, 4838.322634831126, 4845.733484658343, 4864.197407427788, 4883.780229889663, 4891.192953162724, 4821.590164835976, 4842.2736589511505, 4860.441049279325, 4863.635227357945, 4871.147549178897, 4848.757562121879, 4867.902641947159, 4874.098291816008, 4887.511248875084, 4887.657863949525, 4231.090315582134, 4234.195502854448, 4237.957620423787, 4239.236937351276, 4247.023184667513, 6002.699865006733, 6147.47746441553, 6152.692365381758, 6154.5076393888385, 6154.538409619252, 5666.263385759866, 5677.063284558043, 5683.318001839806, 5685.431456854281, 5692.288463942007, 6716.899246511306, 6730.966345168292, 6731.495137864631, 6773.864522709568, 6790.5925644460995, 4646.79089440976, 4650.395448591661, 4652.930206046912, 4655.813767449332, 4661.836835710734, 7070.399016083587, 7107.857842843166, 7128.679209435588, 7131.536450130725, 7160.785176444715, 4688.203005489075, 4767.427908650984, 4790.880227994328, 4794.760261986887, 4807.086653535817, 4806.711597304173, 4832.782524786393, 4845.370101886732, 4847.175980083394, 4848.054629347314, 5631.521320687787, 5636.830895073154, 5637.46444087811, 5649.0, 5649.322081350264, 6845.349691779273, 6846.486513511507, 6851.314868513208, 6856.382925536725, 6874.896876546856, 1684.9578760531085, 1686.7132587460162, 1686.7807185066108, 1690.3576640876388, 1691.9407820726215, 1046.8482070099792, 1089.096050278267, 1106.3859557945257, 1111.6109361723493, 1113.276370359273, 6671.799846004627, 6703.731850725916, 6711.362420570038, 6715.664216789239, 6718.294579069225, 7060.823479412953, 7085.858282834314, 7096.0, 7100.396466300423, 7120.430365570742, 6441.420272175433, 6519.511036672268, 6584.078229047937, 6701.865962680719, 6747.460203183734, 3838.596947320547, 3873.8450461981206, 3881.262560113569, 3909.667678247324, 3911.78485183312, 7369.4472914531625, 7379.926200737924, 7380.372668323253, 7390.556566605914, 7391.741289054858, 7315.597642129627, 7322.560646361236, 7339.302766237199, 7371.631418429057, 7372.741954031583, 7132.358087772125, 7357.227491113463, 7358.0434543509, 7361.779146625609, 7367.079115110611, 7091.9290807091265, 7128.964355178191, 7160.427165826617, 7175.174854891546, 7188.993540904382, 6999.440044796303, 7026.2271150174465, 7038.260982596754, 7051.1186101737285, 7061.823454413475, 7361.447891408273, 7362.815929601803, 7367.263273672805, 7388.113426388652, 7396.186419493743, 4791.640626953063, 4920.926186107283, 4925.38432695913, 4933.186024305949, 5006.098902197639, 7021.0, 7045.436365090883, 7056.400205982549, 7080.468964827762, 7102.218755936739, 6778.186617605722, 6810.6594670265295, 6877.518573699793, 6878.27778083314, 6881.071055407656, 6842.897356539556, 6851.246362899978, 6863.725450982104, 6871.03805467245, 6874.931250687429, 6541.967290163519, 6701.832454188684, 6756.459483241427, 6774.559653622498, 6782.457403407617, 6845.794626161223, 6862.622555759481, 6872.175338959357, 6883.27725588806, 6895.275996020547, 6610.900836487361, 6612.437942774918, 6649.800505984828, 6652.101966234496, 6709.194896612243], "unit": "score", "name": "prototype.html", "value": 5141.243659260399}, {"lowerIsBetter": false, "replicates": [790.0, 791.7426836278211, 792.1286584756768, 914.8627705844123, 933.0715937642045, 13040.347982600879, 13182.340882955861, 13211.405486753096, 13223.603291901247, 13227.735445291088, 11817.822732658995, 11823.467943942522, 11838.112141589372, 11852.111091668137, 11880.227785193978, 730.989035164473, 890.9910900890973, 904.9909500904972, 908.0828363353028, 908.2007833106857, 910.3218102513637, 913.4199783137722, 914.6524320758102, 914.9679761208359, 919.8436265834824, 953.323140570196, 953.8855337359527, 958.5973890965811, 961.2118063188153, 961.7066794627635, 946.4179529589322, 950.2825366848055, 951.167728237792, 952.3190918493276, 956.8851737791475, 707.4163814852716, 708.4120180250432, 708.4721882197796, 709.0498731699547, 711.5090587494612, 12407.131500794949, 12466.252024878537, 12499.625011249676, 12796.552120675731, 12807.0, 13719.862801371959, 14038.087524310888, 14093.0, 14104.71790564183, 14130.293485325692, 11070.667879963614, 11213.383263920481, 11862.110341724405, 12049.819252711217, 12197.39013049344, 3914.354131568288, 3956.9208615827524, 3977.5823538528325, 4004.3993400989793, 4044.3933409988736, 49188.26217606739, 49288.50711492875, 49607.50392496065, 49638.50361496375, 49798.7510062451, 10368.585256589802, 10502.68491945243, 10735.677929662123, 10893.891061089445, 11065.336079835235, 17475.38836140729, 17568.64862702739, 17595.824041759675, 17690.203940822696, 17722.645547088985, 8289.212524810133, 8311.0, 8316.833663326699, 8411.747647570583, 8498.447600905922, 4655.51117132703, 4676.251799712029, 4691.0, 4752.287156926489, 4848.927266091011, 3402.5236466894653, 3415.504751811023, 3442.122258823984, 3442.7245820334315, 3446.172918499592, 627.7928283666379, 634.3307810260128, 637.4836382530073, 637.9744810207633, 639.3223183425583, 650.7494614573424, 659.9109120268703, 706.1420374245316, 713.7359177104505, 722.1695050691746, 8397.6221070052, 8949.507777072324, 9680.370775899544, 9705.17506011997, 9761.219102471785, 748.1695318196797, 749.7600767754267, 755.7090520149782, 757.3070640364116, 776.7514395393533, 3950.9012274693364, 4276.615104640598, 4294.613484786384, 4398.362237475612, 4422.115576884572, 56022.0, 56031.159532607046, 56477.0, 56574.0, 56614.018509351976, 51876.0, 52622.21066684003, 52822.20766688503, 52860.73569632127, 53041.2043819343, 47900.28149577759, 48227.75886120617, 48317.275240871415, 48705.5129448701, 49444.75277623661, 8571.4000019998, 8720.171583699539, 8899.510526921082, 8921.910780892107, 9021.90978090237, 36592.817035915716, 37257.441138382404, 37335.81332093322, 37457.0, 38433.615663844124, 43308.56691433171, 44793.552064478936, 47124.0, 47178.528214717415, 47344.053118938114, 10947.890521094687, 11100.888991109985, 11159.665210043711, 11209.887901120885, 11404.657860264206, 12318.630441086782, 12441.066919981218, 12455.750884982432, 12502.124851260325, 12630.0, 10974.615888443866, 12214.328211948072, 12316.076294278144, 12900.612981610566, 13106.672333191365, 11895.345755983504, 12207.45066471993, 12444.937775311066, 12461.688457788265, 12783.552575659807, 11572.18994670365, 12215.0, 12268.263904165779, 12360.134790564574, 12664.366781660696, 10065.741782277215, 10640.84038739404, 10662.786744265226, 10691.572337106429, 10878.129749619853, 10235.590576376862, 10627.893721063, 10636.255462117888, 10969.23215374948, 11004.284721493077], "unit": "score", "name": "yui.html", "value": 6716.240515610308}], "name": "dromaeo_css", "value": 7374.406759331026}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 112.0, 111.0, 114.0, 122.0, 112.0, 111.0, 113.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [155.0, 132.0, 156.0, 166.0, 127.0, 159.0, 156.0, 128.0, 171.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 148.0}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 163.0, 162.0, 162.0, 164.0, 161.0, 163.0, 163.0, 164.0], "unit": "score", "name": "audio-dft", "value": 162.6}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 74.0, 171.0, 77.0, 74.0, 76.0, 74.0, 175.0, 78.0], "unit": "score", "name": "audio-fft", "value": 95.0}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 149.0, 95.0, 93.0, 94.0, 145.0, 94.0, 93.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 109.7}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.5}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 101.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [57.0, 65.0, 56.0, 61.0, 58.0, 60.0, 63.0, 64.0, 55.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.6}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 64.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.9}, {"lowerIsBetter": true, "replicates": [80.0, 80.0, 79.0, 80.0, 77.0, 79.0, 79.0, 87.0, 79.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.9}, {"lowerIsBetter": true, "replicates": [116.0, 111.0, 118.0, 117.0, 119.0, 117.0, 124.0, 116.0, 114.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.7}, {"lowerIsBetter": true, "replicates": [135.0, 153.0, 143.0, 144.0, 148.0, 144.0, 145.0, 150.0, 158.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.5}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 65.0, 67.0, 68.0, 71.0, 66.0, 65.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1521.6000000000004}]} 10:52:02 INFO - Return code: 0 10:52:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:52:02 ERROR - # TBPL SUCCESS # 10:52:02 INFO - Running post-action listener: _resource_record_post_action 10:52:02 INFO - Running post-run listener: _resource_record_post_run 10:52:03 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 503885824; Read time: 12; Write time: 1164388 10:52:03 INFO - install - Wall time: 15s; CPU: 20.0%; Read bytes: 0; Write bytes: 254951424; Read time: 0; Write time: 902260 10:52:03 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 248934400; Read time: 12; Write time: 262128 10:52:03 INFO - Running post-run listener: _upload_blobber_files 10:52:03 INFO - Blob upload gear active. 10:52:03 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 10:52:03 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 10:52:03 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', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 10:52:03 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 Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 10:52:04 INFO - (blobuploader) - INFO - Open directory for files ... 10:52:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:52:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:52:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:52:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:52:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:52:05 INFO - (blobuploader) - INFO - Done attempting. 10:52:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:52:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:52:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:52:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:52:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:52:05 INFO - (blobuploader) - INFO - Done attempting. 10:52:05 INFO - (blobuploader) - INFO - Iteration through files over. 10:52:05 INFO - Return code: 0 10:52:05 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 10:52:05 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 10:52:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cdf135ac030f1d46bfae4c5f460c375348d8693748a75508c3019254c2a1b29d7e13ecaa85ea1605468218b3bd681a325f5884a3dea244d29408b02e080d8d99", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6d76132a434aab28fc2d354141de51e6ed132b78b350ce2ba70f57613250d421510fa395732cef0bcdd33342ffdede9aeae8b3b4c43b9518fd3aa988ff581650"} 10:52:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 10:52:05 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 10:52:05 INFO - Contents: 10:52:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cdf135ac030f1d46bfae4c5f460c375348d8693748a75508c3019254c2a1b29d7e13ecaa85ea1605468218b3bd681a325f5884a3dea244d29408b02e080d8d99", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6d76132a434aab28fc2d354141de51e6ed132b78b350ce2ba70f57613250d421510fa395732cef0bcdd33342ffdede9aeae8b3b4c43b9518fd3aa988ff581650"} 10:52:05 INFO - Running post-run listener: copy_logs_to_upload_dir 10:52:05 INFO - Copying logs to upload dir... 10:52:05 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 10:52:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.061903 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-04-13 10:52:05.759719) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 10:52:05.763774) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1460568697.219403-1239870872 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/Mozilla-Aurora/sha512/cdf135ac030f1d46bfae4c5f460c375348d8693748a75508c3019254c2a1b29d7e13ecaa85ea1605468218b3bd681a325f5884a3dea244d29408b02e080d8d99", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6d76132a434aab28fc2d354141de51e6ed132b78b350ce2ba70f57613250d421510fa395732cef0bcdd33342ffdede9aeae8b3b4c43b9518fd3aa988ff581650"} build_url:https://queue.taskcluster.net/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011454 build_url: 'https://queue.taskcluster.net/v1/task/GGSDyhaCRlu60d0lpMf5xg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cdf135ac030f1d46bfae4c5f460c375348d8693748a75508c3019254c2a1b29d7e13ecaa85ea1605468218b3bd681a325f5884a3dea244d29408b02e080d8d99", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6d76132a434aab28fc2d354141de51e6ed132b78b350ce2ba70f57613250d421510fa395732cef0bcdd33342ffdede9aeae8b3b4c43b9518fd3aa988ff581650"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 10:52:05.790096) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 10:52:05.790497) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1460568697.219403-1239870872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004421 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 10:52:05.875757) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 10:52:05.876130) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 10:52:05.876498) ========= ========= Total master_lag: 0.28 =========