builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-006 starttime: 1456925974.63 results: success (0) buildid: 20160302030209 builduid: 7bf2b909ff52456385459e5ce12e7f62 revision: eb25b90a05c194bfd4f498ff3ffee7440f85f1cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 05:39:34.629202) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 05:39:34.629689) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 05:39:34.630368) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1456925464.581094-1940740797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006426 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 05:39:34.660395) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 05:39:34.660722) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 05:39:34.679923) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 05:39:34.680304) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1456925464.581094-1940740797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004680 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 05:39:34.730013) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 05:39:34.730343) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 05:39:34.730751) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 05:39:34.731110) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1456925464.581094-1940740797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-02 05:39:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 13.5M=0.001s 2016-03-02 05:39:35 (13.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115116 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 05:39:34.862735) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 05:39:34.863070) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1456925464.581094-1940740797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017787 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 05:39:34.912996) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-02 05:39:34.913639) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev eb25b90a05c194bfd4f498ff3ffee7440f85f1cd --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev eb25b90a05c194bfd4f498ff3ffee7440f85f1cd --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=e31afd3c0f0de4e86ebe4d94000001b5-1456925464.581094-1940740797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-02 05:39:35,454 truncating revision to first 12 chars 2016-03-02 05:39:35,454 Setting DEBUG logging. 2016-03-02 05:39:35,454 attempt 1/10 2016-03-02 05:39:35,454 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/eb25b90a05c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-02 05:39:36,716 unpacking tar archive at: mozilla-central-eb25b90a05c1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.626458 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-02 05:39:36.555585) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 05:39:36.555970) ========= echo eb25b90a05c194bfd4f498ff3ffee7440f85f1cd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'eb25b90a05c194bfd4f498ff3ffee7440f85f1cd'] 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=e31afd3c0f0de4e86ebe4d94000001b5-1456925464.581094-1940740797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False eb25b90a05c194bfd4f498ff3ffee7440f85f1cd program finished with exit code 0 elapsedTime=0.004808 script_repo_revision: 'eb25b90a05c194bfd4f498ff3ffee7440f85f1cd' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 05:39:36.608408) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 05:39:36.608762) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 05:39:36.619464) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-03-02 05:39:36.619804) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1456925464.581094-1940740797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:39:37 INFO - MultiFileLogger online at 20160302 05:39:37 in /builds/slave/test-pgo 05:39:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:39:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:39:37 INFO - {'append_to_log': False, 05:39:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:39:37 INFO - 'blob_upload_branch': 'Firefox', 05:39:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:39:37 INFO - 'branch': 'Firefox', 05:39:37 INFO - 'buildbot_json_path': 'buildprops.json', 05:39:37 INFO - 'config_files': ('talos/linux_config.py',), 05:39:37 INFO - 'default_actions': ('clobber', 05:39:37 INFO - 'read-buildbot-config', 05:39:37 INFO - 'download-and-extract', 05:39:37 INFO - 'populate-webroot', 05:39:37 INFO - 'create-virtualenv', 05:39:37 INFO - 'install', 05:39:37 INFO - 'run-tests'), 05:39:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:39:37 INFO - 'download_minidump_stackwalk': True, 05:39:37 INFO - 'download_symbols': 'ondemand', 05:39:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:39:37 INFO - 'tooltool.py': '/tools/tooltool.py', 05:39:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:39:37 INFO - '/tools/misc-python/virtualenv.py')}, 05:39:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:39:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:39:37 INFO - 'installer_path': 'installer.exe', 05:39:37 INFO - 'log_level': 'info', 05:39:37 INFO - 'log_name': 'talos', 05:39:37 INFO - 'log_to_console': True, 05:39:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:39:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:39:37 INFO - 'opt_config_files': (), 05:39:37 INFO - 'pip_index': False, 05:39:37 INFO - 'sps_profile': False, 05:39:37 INFO - 'sps_profile_interval': 0, 05:39:37 INFO - 'suite': 'dromaeojs-e10s', 05:39:37 INFO - 'system_bits': '32', 05:39:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:39:37 INFO - 'title': 'talos-linux64-ix-006', 05:39:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:39:37 INFO - 'use_talos_json': True, 05:39:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:39:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:39:37 INFO - 'work_dir': 'build'} 05:39:37 INFO - ##### 05:39:37 INFO - ##### Running clobber step. 05:39:37 INFO - ##### 05:39:37 INFO - Running pre-action listener: _resource_record_pre_action 05:39:37 INFO - Running main action method: clobber 05:39:37 INFO - rmtree: /builds/slave/test-pgo/build 05:39:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:39:37 INFO - Running post-action listener: _resource_record_post_action 05:39:37 INFO - ##### 05:39:37 INFO - ##### Running read-buildbot-config step. 05:39:37 INFO - ##### 05:39:37 INFO - Running pre-action listener: _resource_record_pre_action 05:39:37 INFO - Running main action method: read_buildbot_config 05:39:37 INFO - Using buildbot properties: 05:39:37 INFO - { 05:39:37 INFO - "project": "", 05:39:37 INFO - "product": "firefox", 05:39:37 INFO - "script_repo_revision": "production", 05:39:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:39:37 INFO - "repository": "", 05:39:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:39:37 INFO - "buildid": "20160302030209", 05:39:37 INFO - "stage_platform": "linux64-pgo", 05:39:37 INFO - "basedir": "/builds/slave/test-pgo", 05:39:37 INFO - "nightly_build": "True", 05:39:37 INFO - "buildnumber": 129, 05:39:37 INFO - "slavename": "talos-linux64-ix-006", 05:39:37 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:39:37 INFO - "platform": "ubuntu64_hw", 05:39:37 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:39:37 INFO - "branch": "mozilla-central", 05:39:37 INFO - "repo_path": "mozilla-central", 05:39:37 INFO - "revision": "eb25b90a05c194bfd4f498ff3ffee7440f85f1cd", 05:39:37 INFO - "pgo_build": "True", 05:39:37 INFO - "builduid": "7bf2b909ff52456385459e5ce12e7f62", 05:39:37 INFO - "slavebuilddir": "test" 05:39:37 INFO - } 05:39:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 05:39:37 INFO - Running post-action listener: _resource_record_post_action 05:39:37 INFO - ##### 05:39:37 INFO - ##### Running download-and-extract step. 05:39:37 INFO - ##### 05:39:37 INFO - Running pre-action listener: _resource_record_pre_action 05:39:37 INFO - Running main action method: download_and_extract 05:39:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:39:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:37 INFO - https://queue.taskcluster.net/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:39:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 05:39:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 05:39:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 05:39:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:39:40 INFO - Downloaded 1448 bytes. 05:39:40 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 05:39:40 INFO - Using the following test package requirements: 05:39:40 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:39:40 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:40 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:39:40 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:40 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:39:40 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:40 INFO - u'jsshell-linux-x86_64.zip'], 05:39:40 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:40 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:39:40 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:39:40 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:40 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:39:40 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:40 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:39:40 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:40 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:39:40 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:39:40 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:40 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:39:40 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:39:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:40 INFO - https://queue.taskcluster.net/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:39:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:39:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:39:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:39:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:39:41 INFO - Downloaded 23392154 bytes. 05:39:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:39:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:39:43 INFO - Return code: 0 05:39:43 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:43 INFO - https://queue.taskcluster.net/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:39:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:39:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:39:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:39:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:39:44 INFO - Downloaded 23392154 bytes. 05:39:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:39:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:39:45 INFO - Return code: 0 05:39:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:45 INFO - https://queue.taskcluster.net/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:39:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:39:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:39:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:39:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:39:47 INFO - Downloaded 10808456 bytes. 05:39:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:39:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 05:39:47 INFO - Return code: 0 05:39: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')]} 05:39:47 INFO - https://queue.taskcluster.net/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:39:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:39:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:39:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:39:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:39:48 INFO - Downloaded 56139538 bytes. 05:39:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:39:48 INFO - mkdir: /builds/slave/test-pgo/properties 05:39:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:39:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:39:48 INFO - Contents: 05:39:48 INFO - build_url:https://queue.taskcluster.net/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:39:49 INFO - Running post-action listener: _resource_record_post_action 05:39:49 INFO - Running post-action listener: set_extra_try_arguments 05:39:49 INFO - ##### 05:39:49 INFO - ##### Running populate-webroot step. 05:39:49 INFO - ##### 05:39:49 INFO - Running pre-action listener: _resource_record_pre_action 05:39:49 INFO - Running main action method: populate_webroot 05:39:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:39:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:39:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:39:49 INFO - '--tppagecycles', 05:39:49 INFO - '7'], 05:39:49 INFO - 'tests': ['tsvgm']}}, 05:39:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:39:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:39:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:39:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:39:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:39:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:39:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:39:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:49 INFO - 'talos_options': ['--e10s'], 05:39:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:39:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:49 INFO - 'tests': ['damp', 'tps']}, 05:39:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:49 INFO - 'talos_options': ['--e10s'], 05:39:49 INFO - 'tests': ['damp', 'tps']}, 05:39:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:39:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:39:49 INFO - 'other': {'tests': ['a11yr', 05:39:49 INFO - 'ts_paint', 05:39:49 INFO - 'tpaint', 05:39:49 INFO - 'sessionrestore', 05:39:49 INFO - 'sessionrestore_no_auto_restore']}, 05:39:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:39:49 INFO - 'tests': ['a11yr', 05:39:49 INFO - 'ts_paint', 05:39:49 INFO - 'tpaint', 05:39:49 INFO - 'sessionrestore', 05:39:49 INFO - 'sessionrestore_no_auto_restore']}, 05:39:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:39:49 INFO - 'tests': ['a11yr', 05:39:49 INFO - 'ts_paint', 05:39:49 INFO - 'tpaint', 05:39:49 INFO - 'sessionrestore', 05:39:49 INFO - 'sessionrestore_no_auto_restore']}, 05:39:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:39:49 INFO - 'tests': ['a11yr', 05:39:49 INFO - 'ts_paint', 05:39:49 INFO - 'tpaint', 05:39:49 INFO - 'sessionrestore', 05:39:49 INFO - 'sessionrestore_no_auto_restore']}, 05:39:49 INFO - 'other_l64': {'tests': ['a11yr', 05:39:49 INFO - 'ts_paint', 05:39:49 INFO - 'tpaint', 05:39:49 INFO - 'sessionrestore', 05:39:49 INFO - 'sessionrestore_no_auto_restore']}, 05:39:49 INFO - 'other_nol64': {'tests': ['a11yr', 05:39:49 INFO - 'ts_paint', 05:39:49 INFO - 'tpaint', 05:39:49 INFO - 'sessionrestore', 05:39:49 INFO - 'sessionrestore_no_auto_restore']}, 05:39:49 INFO - 'svgr': {'tests': ['tsvgx', 05:39:49 INFO - 'tsvgr_opacity', 05:39:49 INFO - 'tart', 05:39:49 INFO - 'tscrollx', 05:39:49 INFO - 'cart']}, 05:39:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:39:49 INFO - 'tests': ['tsvgx', 05:39:49 INFO - 'tsvgr_opacity', 05:39:49 INFO - 'tart', 05:39:49 INFO - 'tscrollx', 05:39:49 INFO - 'cart']}, 05:39:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:49 INFO - 'tests': ['tp5o']}, 05:39:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:49 INFO - 'talos_options': ['--e10s'], 05:39:49 INFO - 'tests': ['tp5o']}, 05:39:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:49 INFO - 'talos_options': ['--xperf_path', 05:39:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:39:49 INFO - 'tests': ['tp5n']}, 05:39:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:49 INFO - 'talos_options': ['--e10s', 05:39:49 INFO - '--xperf_path', 05:39:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:39:49 INFO - 'tests': ['tp5n']}}, 05:39:49 INFO - 'talos.zip': {'path': '', 05:39:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:39:49 INFO - Running post-action listener: _resource_record_post_action 05:39:49 INFO - ##### 05:39:49 INFO - ##### Running create-virtualenv step. 05:39:49 INFO - ##### 05:39:49 INFO - Running pre-action listener: _resource_record_pre_action 05:39:49 INFO - Running main action method: create_virtualenv 05:39:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:39: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 05:39:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:39:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:39:49 INFO - Using real prefix '/usr' 05:39:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:39:50 INFO - Installing distribute.............................................................................................................................................................................................done. 05:39:52 INFO - Installing pip.................done. 05:39:52 INFO - Return code: 0 05:39:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:39: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')]} 05:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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')]} 05:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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 0x7f514c884f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25af670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263e8c0>, '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 0x263f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263fc50>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1456925464.581094-1940740797', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:39: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 05:39: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 05:39:52 INFO - Using env: {'DISPLAY': ':0', 05:39:52 INFO - 'HOME': '/home/cltbld', 05:39:52 INFO - 'LANG': 'en_US.UTF-8', 05:39:52 INFO - 'LANGUAGE': 'en_US:en', 05:39:52 INFO - 'LOGNAME': 'cltbld', 05:39:52 INFO - 'MAIL': '/var/mail/cltbld', 05:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:52 INFO - 'MOZ_NO_REMOTE': '1', 05:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:52 INFO - 'NO_EM_RESTART': '1', 05:39:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:39:52 INFO - 'PWD': '/builds/slave/test-pgo', 05:39:52 INFO - 'SHELL': '/bin/bash', 05:39:52 INFO - 'SHLVL': '1', 05:39:52 INFO - 'TERM': 'linux', 05:39:52 INFO - 'TMOUT': '86400', 05:39:52 INFO - 'USER': 'cltbld', 05:39:52 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1456925464.581094-1940740797', 05:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:52 INFO - '_': '/tools/buildbot/bin/python'} 05:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39: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 05:39:52 INFO - Cleaning up... 05:39:52 INFO - Return code: 0 05:39:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:39: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')]} 05:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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')]} 05:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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 0x7f514c884f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25af670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263e8c0>, '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 0x263f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263fc50>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1456925464.581094-1940740797', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:39: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 05:39: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 05:39:52 INFO - Using env: {'DISPLAY': ':0', 05:39:52 INFO - 'HOME': '/home/cltbld', 05:39:52 INFO - 'LANG': 'en_US.UTF-8', 05:39:52 INFO - 'LANGUAGE': 'en_US:en', 05:39:52 INFO - 'LOGNAME': 'cltbld', 05:39:52 INFO - 'MAIL': '/var/mail/cltbld', 05:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:52 INFO - 'MOZ_NO_REMOTE': '1', 05:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:52 INFO - 'NO_EM_RESTART': '1', 05:39:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:39:52 INFO - 'PWD': '/builds/slave/test-pgo', 05:39:52 INFO - 'SHELL': '/bin/bash', 05:39:52 INFO - 'SHLVL': '1', 05:39:52 INFO - 'TERM': 'linux', 05:39:52 INFO - 'TMOUT': '86400', 05:39:52 INFO - 'USER': 'cltbld', 05:39:52 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1456925464.581094-1940740797', 05:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:52 INFO - '_': '/tools/buildbot/bin/python'} 05:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:52 INFO - Downloading/unpacking psutil>=0.7.1 05:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:39:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:39:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:39:54 INFO - Installing collected packages: psutil 05:39:54 INFO - Running setup.py install for psutil 05:39:54 INFO - building 'psutil._psutil_linux' extension 05:39: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 05:39:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:39:54 INFO - building 'psutil._psutil_posix' extension 05:39:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:39:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:39:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:39:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:39:55 INFO - Successfully installed psutil 05:39:55 INFO - Cleaning up... 05:39:55 INFO - Return code: 0 05:39:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:39: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')]} 05:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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')]} 05:39:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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 0x7f514c884f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25af670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263e8c0>, '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 0x263f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263fc50>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1456925464.581094-1940740797', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:39: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 05:39: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 05:39:55 INFO - Using env: {'DISPLAY': ':0', 05:39:55 INFO - 'HOME': '/home/cltbld', 05:39:55 INFO - 'LANG': 'en_US.UTF-8', 05:39:55 INFO - 'LANGUAGE': 'en_US:en', 05:39:55 INFO - 'LOGNAME': 'cltbld', 05:39:55 INFO - 'MAIL': '/var/mail/cltbld', 05:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:55 INFO - 'MOZ_NO_REMOTE': '1', 05:39:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:55 INFO - 'NO_EM_RESTART': '1', 05:39:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:39:55 INFO - 'PWD': '/builds/slave/test-pgo', 05:39:55 INFO - 'SHELL': '/bin/bash', 05:39:55 INFO - 'SHLVL': '1', 05:39:55 INFO - 'TERM': 'linux', 05:39:55 INFO - 'TMOUT': '86400', 05:39:55 INFO - 'USER': 'cltbld', 05:39:55 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1456925464.581094-1940740797', 05:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:55 INFO - '_': '/tools/buildbot/bin/python'} 05:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:39:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:39: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) 05:39:57 INFO - Installing collected packages: mozsystemmonitor 05:39:57 INFO - Running setup.py install for mozsystemmonitor 05:39:57 INFO - Successfully installed mozsystemmonitor 05:39:57 INFO - Cleaning up... 05:39:57 INFO - Return code: 0 05:39:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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 0x7f514c884f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25af670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263e8c0>, '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 0x263f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263fc50>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1456925464.581094-1940740797', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:39: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 05:39: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 05:39:57 INFO - Using env: {'DISPLAY': ':0', 05:39:57 INFO - 'HOME': '/home/cltbld', 05:39:57 INFO - 'LANG': 'en_US.UTF-8', 05:39:57 INFO - 'LANGUAGE': 'en_US:en', 05:39:57 INFO - 'LOGNAME': 'cltbld', 05:39:57 INFO - 'MAIL': '/var/mail/cltbld', 05:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:57 INFO - 'MOZ_NO_REMOTE': '1', 05:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:57 INFO - 'NO_EM_RESTART': '1', 05:39:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:39:57 INFO - 'PWD': '/builds/slave/test-pgo', 05:39:57 INFO - 'SHELL': '/bin/bash', 05:39:57 INFO - 'SHLVL': '1', 05:39:57 INFO - 'TERM': 'linux', 05:39:57 INFO - 'TMOUT': '86400', 05:39:57 INFO - 'USER': 'cltbld', 05:39:57 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1456925464.581094-1940740797', 05:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:57 INFO - '_': '/tools/buildbot/bin/python'} 05:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:57 INFO - Downloading/unpacking blobuploader==1.2.4 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39:59 INFO - Downloading blobuploader-1.2.4.tar.gz 05:39:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:39:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:39:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39:59 INFO - Downloading docopt-0.6.1.tar.gz 05:40:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:40:00 INFO - Installing collected packages: blobuploader, requests, docopt 05:40:00 INFO - Running setup.py install for blobuploader 05:40:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:40:00 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:40:00 INFO - Running setup.py install for requests 05:40:00 INFO - Running setup.py install for docopt 05:40:00 INFO - Successfully installed blobuploader requests docopt 05:40:00 INFO - Cleaning up... 05:40:00 INFO - Return code: 0 05:40:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:00 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 0x7f514c884f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25af670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263e8c0>, '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 0x263f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263fc50>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1456925464.581094-1940740797', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:40:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:40:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:40:00 INFO - Using env: {'DISPLAY': ':0', 05:40:00 INFO - 'HOME': '/home/cltbld', 05:40:00 INFO - 'LANG': 'en_US.UTF-8', 05:40:00 INFO - 'LANGUAGE': 'en_US:en', 05:40:00 INFO - 'LOGNAME': 'cltbld', 05:40:00 INFO - 'MAIL': '/var/mail/cltbld', 05:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:00 INFO - 'MOZ_NO_REMOTE': '1', 05:40:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:00 INFO - 'NO_EM_RESTART': '1', 05:40:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:00 INFO - 'SHELL': '/bin/bash', 05:40:00 INFO - 'SHLVL': '1', 05:40:00 INFO - 'TERM': 'linux', 05:40:00 INFO - 'TMOUT': '86400', 05:40:00 INFO - 'USER': 'cltbld', 05:40:00 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1456925464.581094-1940740797', 05:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:00 INFO - '_': '/tools/buildbot/bin/python'} 05:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:40:00 INFO - Running setup.py (path:/tmp/pip-_1eG59-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:40:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:40:00 INFO - Running setup.py (path:/tmp/pip-cuwyGz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:40:01 INFO - Running setup.py (path:/tmp/pip-vaaRW2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:40:01 INFO - Running setup.py (path:/tmp/pip-YGjmD8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:40:01 INFO - Running setup.py (path:/tmp/pip-FQGiJe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:40:01 INFO - Running setup.py (path:/tmp/pip-6UGNYD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:40:01 INFO - Running setup.py (path:/tmp/pip-_a4xeP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:40:01 INFO - Running setup.py (path:/tmp/pip-9hL7bL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:40:01 INFO - Running setup.py (path:/tmp/pip-DSGc5n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:40:01 INFO - Running setup.py (path:/tmp/pip-pqDEob-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:40:01 INFO - Running setup.py (path:/tmp/pip-SJy4yu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:40:01 INFO - Running setup.py (path:/tmp/pip-CH1VwM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:40:01 INFO - Running setup.py (path:/tmp/pip-iIIUa2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:40:01 INFO - Running setup.py (path:/tmp/pip-tRTdj4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:40:01 INFO - Running setup.py (path:/tmp/pip-NMfaaK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:40:01 INFO - Running setup.py (path:/tmp/pip-czLZK3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:40:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:40:02 INFO - Running setup.py (path:/tmp/pip-B9kZla-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:40:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:40:02 INFO - Running setup.py install for manifestparser 05:40:02 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:40:02 INFO - Running setup.py install for mozcrash 05:40:02 INFO - Running setup.py install for mozdebug 05:40:02 INFO - Running setup.py install for mozdevice 05:40:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:40:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:40:02 INFO - Running setup.py install for mozfile 05:40:02 INFO - Running setup.py install for mozhttpd 05:40:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:40:02 INFO - Running setup.py install for mozinfo 05:40:02 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:40:02 INFO - Running setup.py install for mozInstall 05:40:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:40:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:40:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:40:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:40:02 INFO - Running setup.py install for mozleak 05:40:03 INFO - Running setup.py install for mozlog 05:40:03 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:40:03 INFO - Running setup.py install for moznetwork 05:40:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:40:03 INFO - Running setup.py install for mozprocess 05:40:03 INFO - Running setup.py install for mozprofile 05:40:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:40:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:40:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:40:03 INFO - Running setup.py install for mozrunner 05:40:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:40:03 INFO - Running setup.py install for mozscreenshot 05:40:03 INFO - Running setup.py install for moztest 05:40:03 INFO - Running setup.py install for mozversion 05:40:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:40:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:40:03 INFO - Cleaning up... 05:40:03 INFO - Return code: 0 05:40:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:03 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 0x7f514c884f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25af670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263e8c0>, '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 0x263f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263fc50>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1456925464.581094-1940740797', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:40:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:40:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:40:03 INFO - Using env: {'DISPLAY': ':0', 05:40:03 INFO - 'HOME': '/home/cltbld', 05:40:03 INFO - 'LANG': 'en_US.UTF-8', 05:40:03 INFO - 'LANGUAGE': 'en_US:en', 05:40:03 INFO - 'LOGNAME': 'cltbld', 05:40:03 INFO - 'MAIL': '/var/mail/cltbld', 05:40:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:03 INFO - 'MOZ_NO_REMOTE': '1', 05:40:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:03 INFO - 'NO_EM_RESTART': '1', 05:40:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:03 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:03 INFO - 'SHELL': '/bin/bash', 05:40:03 INFO - 'SHLVL': '1', 05:40:03 INFO - 'TERM': 'linux', 05:40:03 INFO - 'TMOUT': '86400', 05:40:03 INFO - 'USER': 'cltbld', 05:40:03 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1456925464.581094-1940740797', 05:40:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:03 INFO - '_': '/tools/buildbot/bin/python'} 05:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:40:04 INFO - Running setup.py (path:/tmp/pip-i5nnPM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:40: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)) 05:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:40:04 INFO - Running setup.py (path:/tmp/pip-rYnAm7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:40:04 INFO - Running setup.py (path:/tmp/pip-DDfkJ7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:40: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)) 05:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:40:04 INFO - Running setup.py (path:/tmp/pip-YyQGdt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:40: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)) 05:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:40:04 INFO - Running setup.py (path:/tmp/pip-Z9RCDn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:40: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)) 05:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:40:04 INFO - Running setup.py (path:/tmp/pip-Kl_XmA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:40: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)) 05:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:40:04 INFO - Running setup.py (path:/tmp/pip-QYPCYs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:40:04 INFO - Running setup.py (path:/tmp/pip-ej8_7e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:40:04 INFO - Running setup.py (path:/tmp/pip-myZ0YY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:40:04 INFO - Running setup.py (path:/tmp/pip-wLLg98-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:40:04 INFO - Running setup.py (path:/tmp/pip-do7b9W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:40:04 INFO - Running setup.py (path:/tmp/pip-_sTQ_S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:40:04 INFO - Running setup.py (path:/tmp/pip-3n3x8G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:40: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)) 05:40:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:40:05 INFO - Running setup.py (path:/tmp/pip-Sk1TXq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:40: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)) 05:40:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:40:05 INFO - Running setup.py (path:/tmp/pip-8esKJj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:40: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)) 05:40:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:40:05 INFO - Running setup.py (path:/tmp/pip-gIpanm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:40: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)) 05:40:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:40:05 INFO - Running setup.py (path:/tmp/pip-ya6VmJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:40: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)) 05:40: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.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:40: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.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:40: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)) 05:40: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)) 05:40: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)) 05:40:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40:07 INFO - Downloading blessings-1.6.tar.gz 05:40:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:40:07 INFO - Installing collected packages: blessings 05:40:07 INFO - Running setup.py install for blessings 05:40:07 INFO - Successfully installed blessings 05:40:07 INFO - Cleaning up... 05:40:07 INFO - Return code: 0 05:40:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:40:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:40:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:40:07 INFO - Reading from file tmpfile_stdout 05:40:07 INFO - Current package versions: 05:40:07 INFO - argparse == 1.2.1 05:40:07 INFO - blessings == 1.6 05:40:07 INFO - blobuploader == 1.2.4 05:40:07 INFO - docopt == 0.6.1 05:40:07 INFO - manifestparser == 1.1 05:40:07 INFO - mozInstall == 1.12 05:40:07 INFO - mozcrash == 0.16 05:40:07 INFO - mozdebug == 0.1 05:40:07 INFO - mozdevice == 0.48 05:40:07 INFO - mozfile == 1.2 05:40:07 INFO - mozhttpd == 0.7 05:40:07 INFO - mozinfo == 0.9 05:40:07 INFO - mozleak == 0.1 05:40:07 INFO - mozlog == 3.1 05:40:07 INFO - moznetwork == 0.27 05:40:07 INFO - mozprocess == 0.22 05:40:07 INFO - mozprofile == 0.28 05:40:07 INFO - mozrunner == 6.11 05:40:07 INFO - mozscreenshot == 0.1 05:40:07 INFO - mozsystemmonitor == 0.0 05:40:07 INFO - moztest == 0.7 05:40:07 INFO - mozversion == 1.4 05:40:07 INFO - psutil == 3.1.1 05:40:07 INFO - requests == 1.2.3 05:40:07 INFO - wsgiref == 0.1.2 05:40:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:07 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 0x7f514c884f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25af670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263e8c0>, '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 0x263f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263fc50>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1456925464.581094-1940740797', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:40:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:40:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:40:07 INFO - Using env: {'DISPLAY': ':0', 05:40:07 INFO - 'HOME': '/home/cltbld', 05:40:07 INFO - 'LANG': 'en_US.UTF-8', 05:40:07 INFO - 'LANGUAGE': 'en_US:en', 05:40:07 INFO - 'LOGNAME': 'cltbld', 05:40:07 INFO - 'MAIL': '/var/mail/cltbld', 05:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:07 INFO - 'MOZ_NO_REMOTE': '1', 05:40:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:07 INFO - 'NO_EM_RESTART': '1', 05:40:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:07 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:07 INFO - 'SHELL': '/bin/bash', 05:40:07 INFO - 'SHLVL': '1', 05:40:07 INFO - 'TERM': 'linux', 05:40:07 INFO - 'TMOUT': '86400', 05:40:07 INFO - 'USER': 'cltbld', 05:40:07 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1456925464.581094-1940740797', 05:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:07 INFO - '_': '/tools/buildbot/bin/python'} 05:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:40:07 INFO - Cleaning up... 05:40:07 INFO - Return code: 0 05:40:07 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f514c884f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25af670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263e8c0>, '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 0x263f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263fc50>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1456925464.581094-1940740797', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:40:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:40:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:40:07 INFO - Using env: {'DISPLAY': ':0', 05:40:07 INFO - 'HOME': '/home/cltbld', 05:40:07 INFO - 'LANG': 'en_US.UTF-8', 05:40:07 INFO - 'LANGUAGE': 'en_US:en', 05:40:07 INFO - 'LOGNAME': 'cltbld', 05:40:07 INFO - 'MAIL': '/var/mail/cltbld', 05:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:07 INFO - 'MOZ_NO_REMOTE': '1', 05:40:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:07 INFO - 'NO_EM_RESTART': '1', 05:40:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:07 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:07 INFO - 'SHELL': '/bin/bash', 05:40:07 INFO - 'SHLVL': '1', 05:40:07 INFO - 'TERM': 'linux', 05:40:07 INFO - 'TMOUT': '86400', 05:40:07 INFO - 'USER': 'cltbld', 05:40:07 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1456925464.581094-1940740797', 05:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:07 INFO - '_': '/tools/buildbot/bin/python'} 05:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:08 INFO - Downloading/unpacking jsonschema 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:40:09 INFO - Downloading/unpacking functools32 (from jsonschema) 05:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:10 INFO - Downloading functools32-3.2.3-2.tar.gz 05:40:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:40:10 INFO - warning: no files found matching '*.txt' 05:40:10 INFO - no previously-included directories found matching 'build' 05:40:10 INFO - no previously-included directories found matching 'dist' 05:40:10 INFO - no previously-included directories found matching '.git*' 05:40:10 INFO - Installing collected packages: jsonschema, functools32 05:40:10 INFO - Running setup.py install for functools32 05:40:10 INFO - warning: no files found matching '*.txt' 05:40:10 INFO - no previously-included directories found matching 'build' 05:40:10 INFO - no previously-included directories found matching 'dist' 05:40:10 INFO - no previously-included directories found matching '.git*' 05:40:10 INFO - Successfully installed jsonschema functools32 05:40:10 INFO - Cleaning up... 05:40:10 INFO - Return code: 0 05:40:10 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:40: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')]} 05:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40: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')]} 05:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40: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 0x7f514c884f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25af670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263e8c0>, '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 0x263f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263fc50>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1456925464.581094-1940740797', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:40: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 05:40: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 05:40:10 INFO - Using env: {'DISPLAY': ':0', 05:40:10 INFO - 'HOME': '/home/cltbld', 05:40:10 INFO - 'LANG': 'en_US.UTF-8', 05:40:10 INFO - 'LANGUAGE': 'en_US:en', 05:40:10 INFO - 'LOGNAME': 'cltbld', 05:40:10 INFO - 'MAIL': '/var/mail/cltbld', 05:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:10 INFO - 'MOZ_NO_REMOTE': '1', 05:40:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:10 INFO - 'NO_EM_RESTART': '1', 05:40:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:10 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:10 INFO - 'SHELL': '/bin/bash', 05:40:10 INFO - 'SHLVL': '1', 05:40:10 INFO - 'TERM': 'linux', 05:40:10 INFO - 'TMOUT': '86400', 05:40:10 INFO - 'USER': 'cltbld', 05:40:10 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1456925464.581094-1940740797', 05:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:10 INFO - '_': '/tools/buildbot/bin/python'} 05:40:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:10 INFO - Downloading/unpacking flake8 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:40:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:40:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:40:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:40:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:40:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:40:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:40:13 INFO - no previously-included directories found matching 'docs/_build' 05:40:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:40:13 INFO - Running setup.py install for pep8 05:40:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:40:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:40:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:40:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:40:13 INFO - no previously-included directories found matching 'docs/_build' 05:40:13 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:40:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:40:13 INFO - Cleaning up... 05:40:13 INFO - Return code: 0 05:40:13 INFO - Running post-action listener: _resource_record_post_action 05:40:13 INFO - Running post-action listener: _start_resource_monitoring 05:40:13 INFO - Starting resource monitoring. 05:40:13 INFO - ##### 05:40:13 INFO - ##### Running install step. 05:40:13 INFO - ##### 05:40:13 INFO - Running pre-action listener: _resource_record_pre_action 05:40:13 INFO - Running main action method: install 05:40:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:40:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:40:13 INFO - Reading from file tmpfile_stdout 05:40:13 INFO - Detecting whether we're running mozinstall >=1.0... 05:40:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:40:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:40:13 INFO - Reading from file tmpfile_stdout 05:40:13 INFO - Output received: 05:40:13 INFO - Usage: mozinstall [options] installer 05:40:13 INFO - Options: 05:40:13 INFO - -h, --help show this help message and exit 05:40:13 INFO - -d DEST, --destination=DEST 05:40:13 INFO - Directory to install application into. [default: 05:40:13 INFO - "/builds/slave/test-pgo"] 05:40:13 INFO - --app=APP Application being installed. [default: firefox] 05:40:13 INFO - mkdir: /builds/slave/test-pgo/build/application 05:40:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:40:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:40:29 INFO - Reading from file tmpfile_stdout 05:40:29 INFO - Output received: 05:40:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:40:29 INFO - Running post-action listener: _resource_record_post_action 05:40:29 INFO - ##### 05:40:29 INFO - ##### Running run-tests step. 05:40:29 INFO - ##### 05:40:29 INFO - Running pre-action listener: _resource_record_pre_action 05:40:29 INFO - Running main action method: run_tests 05:40:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:40:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:40:29 INFO - Python 2.7.3 05:40:29 INFO - Return code: 0 05:40:29 INFO - grabbing minidump binary from tooltool 05:40: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')]} 05:40: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 0x263e8c0>, '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 0x263f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263fc50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:40: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 05:40: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 05:40:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:40:29 INFO - Return code: 0 05:40:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:40:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:40:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:40:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:40:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:40:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:40:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:40:30 INFO - Return code: 0 05:40:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 05:40:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:40:30 INFO - Using env: {'DISPLAY': ':0', 05:40:30 INFO - 'HOME': '/home/cltbld', 05:40:30 INFO - 'LANG': 'en_US.UTF-8', 05:40:30 INFO - 'LANGUAGE': 'en_US:en', 05:40:30 INFO - 'LOGNAME': 'cltbld', 05:40:30 INFO - 'MAIL': '/var/mail/cltbld', 05:40:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:40:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:40:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:30 INFO - 'MOZ_NO_REMOTE': '1', 05:40:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:40:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:30 INFO - 'NO_EM_RESTART': '1', 05:40:30 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:30 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:40:30 INFO - 'SHELL': '/bin/bash', 05:40:30 INFO - 'SHLVL': '1', 05:40:30 INFO - 'TERM': 'linux', 05:40:30 INFO - 'TMOUT': '86400', 05:40:30 INFO - 'USER': 'cltbld', 05:40:30 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1456925464.581094-1940740797', 05:40:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:30 INFO - '_': '/tools/buildbot/bin/python'} 05:40:30 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:40:31 INFO - mozversion application_buildid: 20160302030209 05:40:31 INFO - mozversion application_changeset: eb25b90a05c194bfd4f498ff3ffee7440f85f1cd 05:40:31 INFO - mozversion application_display_name: Nightly 05:40:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:40:31 INFO - mozversion application_name: Firefox 05:40:31 INFO - mozversion application_remotingname: firefox 05:40:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:40:31 INFO - mozversion application_vendor: Mozilla 05:40:31 INFO - mozversion application_version: 47.0a1 05:40:31 INFO - mozversion platform_buildid: 20160302030209 05:40:31 INFO - mozversion platform_changeset: eb25b90a05c194bfd4f498ff3ffee7440f85f1cd 05:40:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:40:31 INFO - mozversion platform_version: 47.0a1 05:40:31 INFO - using testdate: 1456926031 05:40:31 INFO - actual date: 1456926031 05:40:31 INFO - starting webserver on 'localhost:54258' 05:40:31 INFO - SUITE-START | Running 2 tests 05:40:31 INFO - TEST-START | dromaeo_css 05:40:31 INFO - operating with platform_type : linux_ 05:40:31 INFO - Initialising browser for dromaeo_css test... 05:40:31 INFO - TEST-INFO | started process 4501 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsCiIZo/profile http://localhost:54258/getInfo.html) 05:40:34 INFO - PROCESS | 4501 | 05:40:34 INFO - PROCESS | 4501 | (process:4584): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:40:35 INFO - PROCESS | 4501 | __metrics Screen width/height:1600/1200 05:40:35 INFO - PROCESS | 4501 | colorDepth:24 05:40:35 INFO - PROCESS | 4501 | Browser inner width/height: 1024/697 05:40:35 INFO - PROCESS | 4501 | __metrics 05:40:36 ERROR - PROCESS | 4501 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 05:40:36 INFO - TEST-INFO | 4501: exit 0 05:40:36 INFO - Browser initialized. 05:40:36 INFO - Running cycle 1/1 for dromaeo_css test... 05:40:36 INFO - TEST-INFO | started process 4636 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsCiIZo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:40:38 INFO - PROCESS | 4636 | 05:40:38 INFO - PROCESS | 4636 | (process:4695): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:40:48 INFO - PROCESS | 4636 | RSS: Main: 161161216 05:40:48 INFO - PROCESS | 4636 | 05:41:38 INFO - PROCESS | 4636 | 1456926098261 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:43:46 INFO - PROCESS | 4636 | Cycle 1(1): loaded http://localhost:54258/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54258/tests/dromaeo/cssquery-ext.html) 05:43:47 INFO - PROCESS | 4636 | RSS: Main: 168173568 05:43:47 INFO - PROCESS | 4636 | 05:46:49 INFO - PROCESS | 4636 | Cycle 1(1): loaded http://localhost:54258/tests/dromaeo/cssquery-ext.html (next: http://localhost:54258/tests/dromaeo/cssquery-jquery.html) 05:46:49 INFO - PROCESS | 4636 | RSS: Main: 165163008 05:46:49 INFO - PROCESS | 4636 | 05:49:51 INFO - PROCESS | 4636 | Cycle 1(1): loaded http://localhost:54258/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54258/tests/dromaeo/cssquery-mootools.html) 05:49:52 INFO - PROCESS | 4636 | RSS: Main: 166285312 05:49:52 INFO - PROCESS | 4636 | 05:52:53 INFO - PROCESS | 4636 | Cycle 1(1): loaded http://localhost:54258/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54258/tests/dromaeo/cssquery-prototype.html) 05:52:54 INFO - PROCESS | 4636 | RSS: Main: 164671488 05:52:54 INFO - PROCESS | 4636 | 05:55:56 INFO - PROCESS | 4636 | Cycle 1(1): loaded http://localhost:54258/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54258/tests/dromaeo/cssquery-yui.html) 05:55:57 INFO - PROCESS | 4636 | RSS: Main: 164343808 05:55:57 INFO - PROCESS | 4636 | 05:58:59 INFO - PROCESS | 4636 | Cycle 1(1): loaded http://localhost:54258/tests/dromaeo/cssquery-yui.html (next: http://localhost:54258/tests/dromaeo/cssquery-dojo.html) 05:58:59 INFO - PROCESS | 4636 | RSS: Main: 168067072 05:58:59 INFO - PROCESS | 4636 | 05:58:59 INFO - PROCESS | 4636 | __start_tp_report 05:58:59 INFO - PROCESS | 4636 | _x_x_mozilla_page_load 05:58:59 INFO - PROCESS | 4636 | _x_x_mozilla_page_load_details 05:58:59 INFO - PROCESS | 4636 | |i|pagename|runs| 05:58:59 INFO - PROCESS | 4636 | |0;dojo.html;3213.2609499815044;3229.047431007853;3237.8866739664118;3258.804471731696;3269.591301087363;5128.333316668837;5130;5143.408508021578;5221.556167725738;5229.1371923632605;5154.458781827911;5164.9483505164935;5208.921866172001;5254.7635356408955;5320.9467905320935;14.911745408329473;4754.690945088567;4795.832145874895;4857.222844344906;4873.24464707969;4701.318308845215;4717.528247175289;4766.38037055184;4767.809287628508;4801.663883528155;4690.671652984292;4713.7643117844145;4730.432348118231;4780.354652121954;4804.903901921977;4756.857294281177;4795.472498025214;4798.136335459616;4803.663743537953;4832.347633069526;4717.103750287434;4719.315699223627;4746;4804.903901921977;4848.466668666444;5053.823116190915;5066.36670416198;5088.618353623493;5098.566621837148;5141.2545180948555;5643.520300774439;5644.153376993443;5648.227555062028;5651;5680.545556355523;5652.971735141339;5669.26299581056;5673.602847800656;5714.828555143311;5789.594728369016;5273;5284.947150528484;5294.894102117936;5301.522862942354;5320.14877619579;5731.283589551306;5737.5983681141915;5738.340090889517;5742.712864356766;5781.566382521328;5519.144532597454;5555.861103472364;5573.665580065209;5625.09998400254;5693.345265294544;5641.323041235078;5677.290338707661;5685.5167310778215;5692.6299790513485;5716.79991200306;5616.466435688603;5655.717214139277;5668.744906479218;5675.489205971482;5683.431656834367;5539.501444869981;5542.168674698827;5589.469000445032;5594.356648985337;5639.182318563785;4282.057947251599;4282.935755963663;4323.697341186087;4326.156399502067;4350.434443522385;3822;3945.072907866649;3952.3873799561115;3955.169414422946;4003.4795476587856;5322.787088516493;5327.3074500314715;5394.136938089887;5430.239766432703;5505.614606977553;5628;5643.209950606918;5655.604107712421;5661.943380566224;5686.2039314496005;5340.038793017294;5370.516653501204;5376.542993845489;5377.623566350318;5384.138537833927;4808.567228949411;4818.807247710122;4843.75781210938;4854.805807767721;4884.975575122173;5885;5887.234659494238;5895.587308888336;5904.76380944766;5913.58604897653;5654.915176272277;5661.547076233974;5678.971605141948;5711.428857114422;5712.6286791358425;5888.764449421975;5893.705314734332;5894.322152952465;5916.171735956884;5943.257092863392;5515.338159420735;5534.695591742493;5543.722813859372;5554.666719996813;5563.193336966036;5448.727563621882;5574.247476590608;5591.776328946797;5639.746211420414;5643.633163844337;5432.59255555827;5433.483819037185;5457.99027179973;5459.5632349412745;5496.0931446310915;5429.7556609953435;5439.238506609157;5461.262729531462;5465.262189604353;5491.066518691912;5381.246625472515;5398.1902714593125;5404.675719456845;5439.972800135974;5503.3395992481155;5516;5521.641093328921;5543.556515478833;5557.41647127062;5568.749406276808;5350.598705097055;5370.275012873369;5384.273123128484;5390.62265641417;5436.320459942507 05:58:59 INFO - PROCESS | 4636 | |1;ext.html;501.35325430195076;516.6564234783868;563.2733773432273;579.904315787895;584.7281014328337;35899.4615080774;35939.46090808637;36269.274614507696;36311.273774524496;36495.45256821146;39266.8036659817;39589.802050989776;39738;39784.80107599458;39822.60177398225;8424.536650484237;8606.56967151643;8640.524771137585;8672.34957378196;8673.826523469526;8255.25702686758;8403.95798021009;8437.071922088597;8630.827383452328;8652.8702069469;8554.05905350411;8625.698100566482;8640.265577425926;8643.481391116553;8658.004329502124;8543.316534677242;8545.786355341135;8609.354298427581;8616.698415555456;8637.39538232324;8576.828463430697;8661.393702440831;8691.04398516169;8697.695580654647;8720.781980450476;39305;40171.39742903859;40273.798631006954;40425;40591.18817623631;2917.3435976905025;3108.844557772125;3316.4527852904243;3340.699337059652;3561.554805649294;27297.863510682517;27750.02874899369;27810.16569502918;27810.860945695345;27885.58171627427;2987.4622567937763;3020.8489575521135;3046.8324242166673;3057.6636569977286;3133.7649676274373;182374.08812955982;183254.08372958182;183889;184444;184530.07734961374;40141.79929100336;41189.176216475505;41227.1754564913;41383.379249311285;55609.44390556042;40265.396019059735;40283.79858100691;40427.797861011095;40533;40540.79729601392;14228;14235.857641423454;14246;14325.57023289303;14371.64070898215;11174.10607151426;11201.21591488588;11281.379524126252;11290.209685321948;11390.772184556263;14432.927835360755;14444.855551444562;14471.85528144726;14482.782758258634;14495.420183192766;5788.623739456922;5854.443827836434;5919.467247947706;5930.169776231331;5959.612625179436;912.7124955638952;965.560669895196;966.7438128895848;1027.2039169643438;1071.6035067025095;28363;28539.28651783722;29000.7099928998;29095;29153;1035.808375450544;1092.5192915117323;1094.2067001423904;1104.5416152296707;1147.7933971884975;14639.707205855822;15111;15200.163990980602;15368.615784605474;15394.846051539342;286745;290586;292514;292630;292842;51246;51722.224166637534;51766.48233517692;51967.74016129895;52182.21726674103;1269.428757059327;1304.4716889659703;1347.6765576261625;1356.1049707193206;1368.0423703407655;27148.1855544334;28257.858710706314;28316.43367132687;28408.43183136367;28478.857605712667;46717;47034.29448558343;47426.76286618545;47455.52544474649;47615.28577071278;270804;275033;275249;275567;275921;32333;32659.510107348884;43784.78107609441;44728.55271447244;45150;40066.79966600265;40688.79655601703;40750.59249407468;41176.58823411848;41252;34184.31631367309;34365;34526;34685.82657086799;34857.8257108723;34315.828420858736;34333.48499772555;34559.30881382308;34568.30863382668;34685.306293874484;33504.83247583844;36060.4590931131;36501.81749091238;38645.61354386533;39235.80382098071;30059.248518787204;31174.37651246917;31292;31308.843455782575;31321.8433907829;23890.283291501284;24347.634785477876;25597.61603575985;25602.359941001625;25864 05:58:59 INFO - PROCESS | 4636 | |2;jquery.html;345.70787684406685;351.8856371679203;352.5223322398151;358.4998926497536;361.7359327690787;16349.836501634994;16668.499945001655;17591.296348146076;17711.380101696443;17716.557086072855;15845.445409410673;15858.762118568202;15992.680146397066;16036.919815400906;16053.357865685359;5294.1529355303155;5303.575713942885;5582.609217354787;5616.63491873029;5618.353889302721;5515.255440515519;5555.2778138841895;5570.442955704438;5595.21666966625;5605.1872478490595;4971.179755340365;5180.740962951856;5539.14143307788;5560.86097847553;5565.109582466806;5166.225066240057;5171.379434467869;5180.067587834188;5183.196604526304;5188.92216616751;4916.729579873106;5413.2150838128255;5430.891382172374;5431;5432.130859062531;12436.502539898393;12626.116171867972;12716.109872308942;14536.491222807257;20043.59912801736;2206.702095217141;2212.369474699703;2242.248846636379;2292.1404473322505;2790.6093146959442;8952.328575356874;9243.02948190437;12179;12386.75226495465;12948.842367946767;1873.5503479164902;1903.6954087345957;1924.3264857299973;1945.4455480188078;1947.805219478041;59252.40747592512;61234;62017.7596448073;62711;63003.36996630067;9401.106894845116;9487.383320084173;9679.70960871161;9715.27135464843;9889.406635601887;12227.449764760608;12369.196002259825;12371.443285052193;12384.256944583354;12393.752124957631;6884.208316043619;6945.166580010431;7225.783226503213;7259.274072592699;7300.014498042802;6805.115335006517;6812.897806532906;6895.55178913369;6916.273791251947;6940.7917762467205;4081.1225586499045;4119.134981653886;4144.3990621360335;4167.187398457332;4180.581941805856;1754.2982806877096;1755.3066538717135;1798.9460316190534;1800.2267766250234;1809.5837957269903;874.3136637739344;938.5025936253796;971.8542218667116;993.3146129170849;994.9204063674889;14480.203588802506;15653.843461565239;16319.510414687578;16391.672166556604;16985.49043528696;928.8281667891462;950.296780382512;965.8020105878278;967.8209531236603;1029.1355261580309;7675.270849269311;9560.28297877648;9657;9714.174295184988;9715.514224288758;391959;399691;403347;406351;414709;45168.774156129664;66086;66149.33850661432;67815.32184678188;73665.63167184238;1004.0963133180051;1041.8385150301565;1049.9422531760827;1052.6947185316326;1054.530733823441;14447.349869255699;14677.70644587081;14757.557273281818;14776.852231477978;15081.472148474752;30404.847975759978;31622.67961864063;31716.682833171373;31988.520172197903;34045.14887127842;43067.7846610765;43764;46328.768356158005;48147.51852481571;49888.50111498839;10674.89325106739;11148.163887708291;11234.382108984084;11266.155038371991;11476.368799716096;12054.09594280415;12737.108402412114;12855.421506032439;12908.419121139383;12920.935395323339;10762.08522275584;10874.238803283693;11215.383153926286;11292.717682058013;11441.199116061796;10950.178736594627;11089.611863584736;11624.883751162719;11710;11872.168948173545;10709.625163119254;11497.195196336175;11568.88431115678;11755.88244117548;12103.152779305365;11168.72078198019;11247.381394023407;11313.71715707114;11334.14993875446;11365.204435689753;11203.831942520706;11274.436278185894;11623.941880290544;11625.476853541442;11718.765624687629 05:58:59 INFO - PROCESS | 4636 | |3;mootools.html;1453.8982271241011;1455.5415044261058;1633.2976819967416;1803.4769916724151;1844.7786265648124;6757.526973111884;7179.317964793349;7422.814429639262;7611.619419029047;7660.578668173248;7647.502912310696;7685.884711729329;7719.961400192991;7735.651895664694;7746.690132394711;2214.546018066301;2241.4620491082105;2243.4839986803045;2247.1236217875044;2250.718660167479;2220.367195349326;2223.299660606912;2265.864048157116;2269.7616750241236;2276.203328834911;2232.899519521617;2237.8881055947218;2241.618924782783;2266.2634643740766;2291.0606651272983;2225.332400279926;2247.550489902026;2249.257744944173;2250.1224522436264;2264.218844498662;2204.647256438962;2224.1103558576697;2224.4661281292533;2232.475368288451;2236.1279101150562;7601.543907365576;7601.961990190069;7622.123455802598;7633.5419874807685;7657.272559106876;4442.489113751928;4496.505384407713;4552.271636538171;4553.203189441868;4573.314002899559;2850.914472565826;2975.2561859535117;2979;2995.0415866922594;3003.039027511197;896.9596368163449;899.5727029660859;906.8231694819513;931.2922179143832;1000.3847633705292;10784.5686172553;10789.514471848706;10797.5680972761;10808.189385796019;10853.837192442119;4113.691473139526;4116.650084742831;4156.106437116035;4287.056847493546;4288.656907447396;9123.863142052875;9128.3153763468;9161.725148245563;9171.266298696088;9186.26509879208;4438.667099967515;4450.777461126931;4456.376107344974;4473.261911784584;4477.104579084196;3805.46723458716;3997.320455522568;4037.4751282333696;4070.6132917373393;4180.6446452051305;3522.5244591980268;3554.3779838528153;3607.22444674391;3610.530631017951;3634.200475895299;1100.4167791070745;1145.954161833534;1149.431031639327;1150.6950658075616;1156.0693641618577;1357.5520078374113;1358.151155527795;1359.5513480551394;1390.6662401023682;1393.7491251574813;7153.463490238253;7209.783706488814;7271.272872712686;7287.854242915112;7289.2346303638415;484.0730002046042;490.1226804020763;492.1141944499886;499.1389852504401;505.7774579185147;5342.118550439134;5351.892962140735;5355.357357117171;5369.892602147936;5409.188621706776;8565.871511927326;8795.252403545643;9286.489243091559;9313.20837728787;9325.720228393024;9010.27917766577;9059.59231834569;9070.86393704095;9078.092190781;9126;6847.794566163023;7023.122109736283;7028.753993610301;7038.331358520933;7049.259827718119;7046.048783414379;7091.716331346688;7103.857922841617;7110.537815042006;7132.322429369202;7809.297163255334;8050.557219352758;8124.309433698202;8131.918680813353;8190.672373105009;8091.474054186459;8105.432619716563;8114.594270286344;8240.876386854083;8266.83466330658;6627.204735431586;6690.866182676416;6983.231844497;7013.263607321362;7035.7537486189785;6988.580685158907;7001.159860816734;7019.438444924496;7027.367536921702;7188.17336006366;6657.667116644246;6823.89764153548;6886.449084073162;6886.827829304308;6959.095317608679;6578.375054369827;6638.0374845648075;6691.966540167463;6750;6798.694058767268;6512.153420055362;6701.765438209639;6736.124303840469;6771.424428923597;6810.489213308922;6309.589876658002;6380.489560835029;6394.968025159845;6413.1021656969;6428.935710643021;6040.637561746309;6087.634741915499;6089.969550152221;6093.390660933871;6113.755449781959 05:58:59 INFO - PROCESS | 4636 | |4;prototype.html;325.26490132301;328.1222729199391;332.176203016519;335.34272825262485;339.7944243732542;6210.223722034746;6211.689415529222;6211.782587609423;6254.46837018854;6262.279837818653;6089.238845144357;6096.4513193812545;6106.48094911933;6117.38826117388;6140.478059364948;4500.324951257305;4560.657950653715;4617.676762626617;4627.352170696088;4665.1602711512;4546.8408605698805;4547.977260113711;4594.862154135365;4600.677952543323;4624.676272660899;4544.477385100723;4553.4991150973365;4568.657350698711;4572.291294849304;4581.908361832778;4596.701214421052;4599.2871104978785;4600.240960241556;4600.585947264745;4604.884877878047;3964.4846169998004;3965.6827453803626;3966.3058964681354;3968.3452230381954;3973.245083434167;5908.852278693024;5927.970360148215;5928;5934.940650593525;5935.406459354073;5218.705415065543;5252.474752524755;5313.149896016619;5325.707086110262;5332.493413125747;6409.294977552466;6464.74141034358;6484.351564843525;6504.1869766279215;6514.93485065148;4319.244132276839;4358.128374325148;4358.476982762058;4358.8038538265855;4371.475422949235;6734.93265067348;6792.49056320773;6800.251972283045;6802.489813264025;6808.489363297723;4425.468943726709;4446.64426845858;4448.5773851484055;4468.597826195658;4473.888152796141;4344.087741574304;4479.059397526491;4487.573680500347;4489.393931819162;4500.537325369268;5259.105951988171;5260.368755749258;5278.762455689503;5292.232626269247;5302.992431438014;6515.967420162963;6518.185226846645;6555.639439830855;6574.967125164344;6613.900791488131;1586.2227508520741;1627.5117464760524;1627.7558366245157;1628.5033064915315;1636.746304322832;1015.5836107196014;1017.9083882450615;1041.1358572385054;1049.58541376156;1053.757635743783;6314.052892066226;6324.494040476751;6343.397377249154;6357.11000459936;6360.618362898241;6670.96664516684;6719.160104986877;6722.226943901514;6727.360900714424;6729.596224226562;6222.81331560054;6290.937090629127;6295.6537390443045;6373.52198585108;6400.807975760735;3635.5092062571216;3669.889903302905;3682.760620559655;3687.4284485904727;3695.593484716679;7261.927380726125;7267.236940121317;7279.344858962719;7308.744193953186;7319.048523691886;6915.861682766316;6937.653117344113;6967.79096627102;6995.055667484824;7005.1593808742255;7077.858442831114;7226.74706385274;7243.492955493065;7251.129864416198;7286.48994570375;6794.76218332356;6829.31706829333;6831.248562658203;6845.212800527804;6872.793816185523;6693;6710.664466776544;6712.530122891546;6730.697118629576;6733.831654208684;7236.167840698387;7249.565026098451;7270.309320614533;7276.4542659299705;7279.672414741243;4390.121975604828;4448.332750087513;4494.685372023927;4496.100779843979;4512.774361281989;6801.251862295045;6804.693788779616;6813.182418109858;6842.1789385272095;6850.794476165723;6614.470842332698;6619.768308109193;6623.4038936495945;6633.900491492728;6635.535512514078;6531.640759758259;6580;6586.155876354628;6604.933950660432;6629.602223866584;6330.177076979963;6444.677766111769;6460.741570337322;6489.805305840832;6496.187976502937;6611.570247933869;6616.4045235929;6639.53523253387;6670.533062685566;6675.0654908313845;6406.967965160331;6417.326180750954;6437.485001199799;6437.742490300523;6446.709898054505 05:58:59 INFO - PROCESS | 4636 | |5;yui.html;653.964031978241;686.5983399711168;725.4595326481768;745.9705606263358;774.3688893551758;12670.936645316771;15542.300596473158;16054.357825686959;16071.437499687485;16103.758443623341;14618.780718289234;14736.705265894676;14741.778873316882;14750.704985900302;14786.112833229987;823.4729772945335;826.7850358906697;832.7210384521193;833.4374297349295;837.401258100458;689.5965859971898;827.9586020698971;832.3466079127886;832.6128350317101;832.646125396707;862.2326129744501;863.1756672377865;865.8831057807179;865.909079546648;875.6234819027816;859.0378775771114;859.5788063848701;861.8233262181237;862.3575436299934;862.5816479007676;630.8927482328015;631.5831551176202;633.183193680152;634.2674211285972;636.5734957578434;13200.14199077057;13317.067805253637;13415.060945733803;13462;13567.52513662017;12010.63968080959;12064.155509114365;12142.0893432992;12157.51369945201;12178.51285948561;9776.560054797552;10148.188144948386;10357.482125893675;10522.105621022223;10557.472126393726;3517.8416971236356;3587.820608969541;3600.225951420457;3642.3807952648112;3716.7955762433057;50207.748961255325;50412.495875041146;50619.74690126563;50758.238626420636;51393.486065139245;9198.770030749285;9358.344915855962;9629.662961796303;9648.421094734338;9730.562124704406;18094;18161.818381816276;18208.36270730518;18234.635307294044;18268.90865545664;7689.115751688516;7769.922300777033;7891.447598668038;8037.23646253605;8084.272415482635;3967.940480892789;4142.855000075043;4481.439820022497;4544.863654090383;4641.95358046422;2936.2365784896083;3059.8470076496087;3063.938721225563;3075.3234288456506;3078.3843231353817;552.1248820619284;568.85494198979;572.1018001737316;581.6917033972002;584.5557376393971;519.5376115257424;592.754007087054;613.6440864298696;621.8134559632183;628.7485005997637;7813.374930005586;7999.4400391972;8022.237887400687;8082.353411727166;8250.628721707537;583.9678817664984;590.5482306035886;610.8869859076085;637.2830565613684;650.0346984727676;3445.414279572479;3476.947845782315;3582.3193593217725;3595.3168897909313;3645.198056427582;54210.18684719732;54688.453115468335;55305.1704224437;55386.446135538936;55507;49106.50893491091;49436;49993.25010124851;50118.74940625273;50285.74857125764;44788.3281750774;45071.77464112658;45288.77355613201;45366.31950520745;45719.31421028687;7005.749580449448;7025.789226323219;7075.893861592183;7187.928120718726;7329.670164842488;32599.674003259664;33520.32959340848;33789.66210337865;34195.31609367749;34467.65532344745;39703.60296397115;43717.56282437135;44090.11819763651;44117.33823992707;44169.55830441783;10093.19254459656;10162.491875406053;10227.386356818615;10249.897501024894;10291.691249262534;11268.308257173658;11486.483108260316;11600.709982250512;11673.241239319417;11811.527538898348;10643.680689579016;11114.333140011626;11173.608923687632;11657.417129143678;11797.941010294893;9655.613775448903;9662.275329350467;9669.129778319704;10141.49292535385;10890.128789696964;11187.328760274084;11234.382108983757;11345.262557933707;11665.35840528779;11675.474603643026;8508.702195423131;8579.2707619853;8590.1839325264;8785.165409286108;8863.689770857989;8698.434601750865;8903;9107;9220.262379009797;9284.814303713752 05:58:59 INFO - PROCESS | 4636 | __end_tp_report 05:58:59 INFO - PROCESS | 4636 | __start_cc_report 05:58:59 INFO - PROCESS | 4636 | _x_x_mozilla_cycle_collect,313 05:58:59 INFO - PROCESS | 4636 | __end_cc_report 05:58:59 INFO - PROCESS | 4636 | __startTimestamp1456927139766__endTimestamp 05:58:59 INFO - PROCESS | 4636 | 05:58:59 INFO - PROCESS | 4636 | ------- Summary: start ------- 05:58:59 INFO - PROCESS | 4636 | Number of tests: 6 05:58:59 INFO - PROCESS | 4636 | 05:58:59 INFO - PROCESS | 4636 | [#0] dojo.html Cycles:165 Average:5210.36 Median:5432.59 stddev:703.93 (13.0%) stddev-sans-first:688.43 05:58:59 INFO - PROCESS | 4636 | Values: 3213.3 3229.0 3237.9 3258.8 3269.6 5128.3 5130.0 5143.4 5221.6 5229.1 5154.5 5164.9 5208.9 5254.8 5320.9 14.9 4754.7 4795.8 4857.2 4873.2 4701.3 4717.5 4766.4 4767.8 4801.7 4690.7 4713.8 4730.4 4780.4 4804.9 4756.9 4795.5 4798.1 4803.7 4832.3 4717.1 4719.3 4746.0 4804.9 4848.5 5053.8 5066.4 5088.6 5098.6 5141.3 5643.5 5644.2 5648.2 5651.0 5680.5 5653.0 5669.3 5673.6 5714.8 5789.6 5273.0 5284.9 5294.9 5301.5 5320.1 5731.3 5737.6 5738.3 5742.7 5781.6 5519.1 5555.9 5573.7 5625.1 5693.3 5641.3 5677.3 5685.5 5692.6 5716.8 5616.5 5655.7 5668.7 5675.5 5683.4 5539.5 5542.2 5589.5 5594.4 5639.2 4282.1 4282.9 4323.7 4326.2 4350.4 3822.0 3945.1 3952.4 3955.2 4003.5 5322.8 5327.3 5394.1 5430.2 5505.6 5628.0 5643.2 5655.6 5661.9 5686.2 5340.0 5370.5 5376.5 5377.6 5384.1 4808.6 4818.8 4843.8 4854.8 4885.0 5885.0 5887.2 5895.6 5904.8 5913.6 5654.9 5661.5 5679.0 5711.4 5712.6 5888.8 5893.7 5894.3 5916.2 5943.3 5515.3 5534.7 5543.7 5554.7 5563.2 5448.7 5574.2 5591.8 5639.7 5643.6 5432.6 5433.5 5458.0 5459.6 5496.1 5429.8 5439.2 5461.3 5465.3 5491.1 5381.2 5398.2 5404.7 5440.0 5503.3 5516.0 5521.6 5543.6 5557.4 5568.7 5350.6 5370.3 5384.3 5390.6 5436.3 05:58:59 INFO - PROCESS | 4636 | 05:58:59 INFO - PROCESS | 4636 | [#1] ext.html Cycles:180 Average:41387.53 Median:34626.81 stddev:66299.69 (191.5%) stddev-sans-first:66414.61 05:58:59 INFO - PROCESS | 4636 | Values: 501.4 516.7 563.3 579.9 584.7 35899.5 35939.5 36269.3 36311.3 36495.5 39266.8 39589.8 39738.0 39784.8 39822.6 8424.5 8606.6 8640.5 8672.3 8673.8 8255.3 8404.0 8437.1 8630.8 8652.9 8554.1 8625.7 8640.3 8643.5 8658.0 8543.3 8545.8 8609.4 8616.7 8637.4 8576.8 8661.4 8691.0 8697.7 8720.8 39305.0 40171.4 40273.8 40425.0 40591.2 2917.3 3108.8 3316.5 3340.7 3561.6 27297.9 27750.0 27810.2 27810.9 27885.6 2987.5 3020.8 3046.8 3057.7 3133.8 182374.1 183254.1 183889.0 184444.0 184530.1 40141.8 41189.2 41227.2 41383.4 55609.4 40265.4 40283.8 40427.8 40533.0 40540.8 14228.0 14235.9 14246.0 14325.6 14371.6 11174.1 11201.2 11281.4 11290.2 11390.8 14432.9 14444.9 14471.9 14482.8 14495.4 5788.6 5854.4 5919.5 5930.2 5959.6 912.7 965.6 966.7 1027.2 1071.6 28363.0 28539.3 29000.7 29095.0 29153.0 1035.8 1092.5 1094.2 1104.5 1147.8 14639.7 15111.0 15200.2 15368.6 15394.8 286745.0 290586.0 292514.0 292630.0 292842.0 51246.0 51722.2 51766.5 51967.7 52182.2 1269.4 1304.5 1347.7 1356.1 1368.0 27148.2 28257.9 28316.4 28408.4 28478.9 46717.0 47034.3 47426.8 47455.5 47615.3 270804.0 275033.0 275249.0 275567.0 275921.0 32333.0 32659.5 43784.8 44728.6 45150.0 40066.8 40688.8 40750.6 41176.6 41252.0 34184.3 34365.0 34526.0 34685.8 34857.8 34315.8 34333.5 34559.3 34568.3 34685.3 33504.8 36060.5 36501.8 38645.6 39235.8 30059.2 31174.4 31292.0 31308.8 31321.8 23890.3 24347.6 25597.6 25602.4 25864.0 05:58:59 INFO - PROCESS | 4636 | 05:58:59 INFO - PROCESS | 4636 | [#2] jquery.html Cycles:180 Average:23964.28 Median:31669.68 stddev:66012.11 (208.4%) stddev-sans-first:66173.47 05:58:59 INFO - PROCESS | 4636 | Values: 345.7 351.9 352.5 358.5 361.7 16349.8 16668.5 17591.3 17711.4 17716.6 15845.4 15858.8 15992.7 16036.9 16053.4 5294.2 5303.6 5582.6 5616.6 5618.4 5515.3 5555.3 5570.4 5595.2 5605.2 4971.2 5180.7 5539.1 5560.9 5565.1 5166.2 5171.4 5180.1 5183.2 5188.9 4916.7 5413.2 5430.9 5431.0 5432.1 12436.5 12626.1 12716.1 14536.5 20043.6 2206.7 2212.4 2242.2 2292.1 2790.6 8952.3 9243.0 12179.0 12386.8 12948.8 1873.6 1903.7 1924.3 1945.4 1947.8 59252.4 61234.0 62017.8 62711.0 63003.4 9401.1 9487.4 9679.7 9715.3 9889.4 12227.4 12369.2 12371.4 12384.3 12393.8 6884.2 6945.2 7225.8 7259.3 7300.0 6805.1 6812.9 6895.6 6916.3 6940.8 4081.1 4119.1 4144.4 4167.2 4180.6 1754.3 1755.3 1798.9 1800.2 1809.6 874.3 938.5 971.9 993.3 994.9 14480.2 15653.8 16319.5 16391.7 16985.5 928.8 950.3 965.8 967.8 1029.1 7675.3 9560.3 9657.0 9714.2 9715.5 391959.0 399691.0 403347.0 406351.0 414709.0 45168.8 66086.0 66149.3 67815.3 73665.6 1004.1 1041.8 1049.9 1052.7 1054.5 14447.3 14677.7 14757.6 14776.9 15081.5 30404.8 31622.7 31716.7 31988.5 34045.1 43067.8 43764.0 46328.8 48147.5 49888.5 10674.9 11148.2 11234.4 11266.2 11476.4 12054.1 12737.1 12855.4 12908.4 12920.9 10762.1 10874.2 11215.4 11292.7 11441.2 10950.2 11089.6 11624.9 11710.0 11872.2 10709.6 11497.2 11568.9 11755.9 12103.2 11168.7 11247.4 11313.7 11334.1 11365.2 11203.8 11274.4 11623.9 11625.5 11718.8 05:58:59 INFO - PROCESS | 4636 | 05:58:59 INFO - PROCESS | 4636 | [#3] mootools.html Cycles:180 Average:5300.72 Median:6211.67 stddev:2777.37 (44.7%) stddev-sans-first:2770.11 05:58:59 INFO - PROCESS | 4636 | Values: 1453.9 1455.5 1633.3 1803.5 1844.8 6757.5 7179.3 7422.8 7611.6 7660.6 7647.5 7685.9 7720.0 7735.7 7746.7 2214.5 2241.5 2243.5 2247.1 2250.7 2220.4 2223.3 2265.9 2269.8 2276.2 2232.9 2237.9 2241.6 2266.3 2291.1 2225.3 2247.6 2249.3 2250.1 2264.2 2204.6 2224.1 2224.5 2232.5 2236.1 7601.5 7602.0 7622.1 7633.5 7657.3 4442.5 4496.5 4552.3 4553.2 4573.3 2850.9 2975.3 2979.0 2995.0 3003.0 897.0 899.6 906.8 931.3 1000.4 10784.6 10789.5 10797.6 10808.2 10853.8 4113.7 4116.7 4156.1 4287.1 4288.7 9123.9 9128.3 9161.7 9171.3 9186.3 4438.7 4450.8 4456.4 4473.3 4477.1 3805.5 3997.3 4037.5 4070.6 4180.6 3522.5 3554.4 3607.2 3610.5 3634.2 1100.4 1146.0 1149.4 1150.7 1156.1 1357.6 1358.2 1359.6 1390.7 1393.7 7153.5 7209.8 7271.3 7287.9 7289.2 484.1 490.1 492.1 499.1 505.8 5342.1 5351.9 5355.4 5369.9 5409.2 8565.9 8795.3 9286.5 9313.2 9325.7 9010.3 9059.6 9070.9 9078.1 9126.0 6847.8 7023.1 7028.8 7038.3 7049.3 7046.0 7091.7 7103.9 7110.5 7132.3 7809.3 8050.6 8124.3 8131.9 8190.7 8091.5 8105.4 8114.6 8240.9 8266.8 6627.2 6690.9 6983.2 7013.3 7035.8 6988.6 7001.2 7019.4 7027.4 7188.2 6657.7 6823.9 6886.4 6886.8 6959.1 6578.4 6638.0 6692.0 6750.0 6798.7 6512.2 6701.8 6736.1 6771.4 6810.5 6309.6 6380.5 6395.0 6413.1 6428.9 6040.6 6087.6 6090.0 6093.4 6113.8 05:58:59 INFO - PROCESS | 4636 | 05:58:59 INFO - PROCESS | 4636 | [#4] prototype.html Cycles:180 Average:5460.09 Median:6276.61 stddev:1711.85 (27.3%) stddev-sans-first:1672.70 05:58:59 INFO - PROCESS | 4636 | Values: 325.3 328.1 332.2 335.3 339.8 6210.2 6211.7 6211.8 6254.5 6262.3 6089.2 6096.5 6106.5 6117.4 6140.5 4500.3 4560.7 4617.7 4627.4 4665.2 4546.8 4548.0 4594.9 4600.7 4624.7 4544.5 4553.5 4568.7 4572.3 4581.9 4596.7 4599.3 4600.2 4600.6 4604.9 3964.5 3965.7 3966.3 3968.3 3973.2 5908.9 5928.0 5928.0 5934.9 5935.4 5218.7 5252.5 5313.1 5325.7 5332.5 6409.3 6464.7 6484.4 6504.2 6514.9 4319.2 4358.1 4358.5 4358.8 4371.5 6734.9 6792.5 6800.3 6802.5 6808.5 4425.5 4446.6 4448.6 4468.6 4473.9 4344.1 4479.1 4487.6 4489.4 4500.5 5259.1 5260.4 5278.8 5292.2 5303.0 6516.0 6518.2 6555.6 6575.0 6613.9 1586.2 1627.5 1627.8 1628.5 1636.7 1015.6 1017.9 1041.1 1049.6 1053.8 6314.1 6324.5 6343.4 6357.1 6360.6 6671.0 6719.2 6722.2 6727.4 6729.6 6222.8 6290.9 6295.7 6373.5 6400.8 3635.5 3669.9 3682.8 3687.4 3695.6 7261.9 7267.2 7279.3 7308.7 7319.0 6915.9 6937.7 6967.8 6995.1 7005.2 7077.9 7226.7 7243.5 7251.1 7286.5 6794.8 6829.3 6831.2 6845.2 6872.8 6693.0 6710.7 6712.5 6730.7 6733.8 7236.2 7249.6 7270.3 7276.5 7279.7 4390.1 4448.3 4494.7 4496.1 4512.8 6801.3 6804.7 6813.2 6842.2 6850.8 6614.5 6619.8 6623.4 6633.9 6635.5 6531.6 6580.0 6586.2 6604.9 6629.6 6330.2 6444.7 6460.7 6489.8 6496.2 6611.6 6616.4 6639.5 6670.5 6675.1 6407.0 6417.3 6437.5 6437.7 6446.7 05:58:59 INFO - PROCESS | 4636 | 05:58:59 INFO - PROCESS | 4636 | [#5] yui.html Cycles:180 Average:13538.76 Median:50246.75 stddev:15697.46 (31.2%) stddev-sans-first:15711.68 05:58:59 INFO - PROCESS | 4636 | Values: 654.0 686.6 725.5 746.0 774.4 12670.9 15542.3 16054.4 16071.4 16103.8 14618.8 14736.7 14741.8 14750.7 14786.1 823.5 826.8 832.7 833.4 837.4 689.6 828.0 832.3 832.6 832.6 862.2 863.2 865.9 865.9 875.6 859.0 859.6 861.8 862.4 862.6 630.9 631.6 633.2 634.3 636.6 13200.1 13317.1 13415.1 13462.0 13567.5 12010.6 12064.2 12142.1 12157.5 12178.5 9776.6 10148.2 10357.5 10522.1 10557.5 3517.8 3587.8 3600.2 3642.4 3716.8 50207.7 50412.5 50619.7 50758.2 51393.5 9198.8 9358.3 9629.7 9648.4 9730.6 18094.0 18161.8 18208.4 18234.6 18268.9 7689.1 7769.9 7891.4 8037.2 8084.3 3967.9 4142.9 4481.4 4544.9 4642.0 2936.2 3059.8 3063.9 3075.3 3078.4 552.1 568.9 572.1 581.7 584.6 519.5 592.8 613.6 621.8 628.7 7813.4 7999.4 8022.2 8082.4 8250.6 584.0 590.5 610.9 637.3 650.0 3445.4 3476.9 3582.3 3595.3 3645.2 54210.2 54688.5 55305.2 55386.4 55507.0 49106.5 49436.0 49993.3 50118.7 50285.7 44788.3 45071.8 45288.8 45366.3 45719.3 7005.7 7025.8 7075.9 7187.9 7329.7 32599.7 33520.3 33789.7 34195.3 34467.7 39703.6 43717.6 44090.1 44117.3 44169.6 10093.2 10162.5 10227.4 10249.9 10291.7 11268.3 11486.5 11600.7 11673.2 11811.5 10643.7 11114.3 11173.6 11657.4 11797.9 9655.6 9662.3 9669.1 10141.5 10890.1 11187.3 11234.4 11345.3 11665.4 11675.5 8508.7 8579.3 8590.2 8785.2 8863.7 8698.4 8903.0 9107.0 9220.3 9284.8 05:58:59 INFO - PROCESS | 4636 | -------- Summary: end -------- 05:58:59 INFO - PROCESS | 4636 | 05:59:00 INFO - TEST-INFO | 4636: exit 0 05:59:00 INFO - TEST-OK | dromaeo_css | took 1109367ms 05:59:00 INFO - TEST-START | kraken 05:59:00 INFO - operating with platform_type : linux_ 05:59:00 INFO - Initialising browser for kraken test... 05:59:00 INFO - TEST-INFO | started process 4873 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLa0jdU/profile http://localhost:54258/getInfo.html) 05:59:04 INFO - PROCESS | 4873 | 05:59:04 INFO - PROCESS | 4873 | (process:4945): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:59:04 INFO - PROCESS | 4873 | __metrics Screen width/height:1600/1200 05:59:04 INFO - PROCESS | 4873 | colorDepth:24 05:59:04 INFO - PROCESS | 4873 | Browser inner width/height: 1024/697 05:59:04 INFO - PROCESS | 4873 | __metrics 05:59:05 ERROR - PROCESS | 4873 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 05:59:06 INFO - TEST-INFO | 4873: exit 0 05:59:06 INFO - Browser initialized. 05:59:06 INFO - Running cycle 1/1 for kraken test... 05:59:06 INFO - TEST-INFO | started process 4996 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLa0jdU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:07 INFO - PROCESS | 4996 | 05:59:07 INFO - PROCESS | 4996 | (process:5055): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:59:18 INFO - PROCESS | 4996 | RSS: Main: 160841728 05:59:18 INFO - PROCESS | 4996 | 05:59:20 INFO - PROCESS | 4996 | Cycle 1(1): loaded http://localhost:54258/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54258/tests/kraken/driver.html?testName=audio-beat-detection) 05:59:21 INFO - PROCESS | 4996 | RSS: Main: 167329792 05:59:21 INFO - PROCESS | 4996 | 05:59:23 INFO - PROCESS | 4996 | Cycle 1(1): loaded http://localhost:54258/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54258/tests/kraken/driver.html?testName=audio-dft) 05:59:24 INFO - PROCESS | 4996 | RSS: Main: 170434560 05:59:24 INFO - PROCESS | 4996 | 05:59:27 INFO - PROCESS | 4996 | Cycle 1(1): loaded http://localhost:54258/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54258/tests/kraken/driver.html?testName=audio-fft) 05:59:28 INFO - PROCESS | 4996 | RSS: Main: 164384768 05:59:28 INFO - PROCESS | 4996 | 05:59:30 INFO - PROCESS | 4996 | Cycle 1(1): loaded http://localhost:54258/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54258/tests/kraken/driver.html?testName=audio-oscillator) 05:59:30 INFO - PROCESS | 4996 | RSS: Main: 165642240 05:59:30 INFO - PROCESS | 4996 | 05:59:32 INFO - PROCESS | 4996 | Cycle 1(1): loaded http://localhost:54258/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54258/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:59:33 INFO - PROCESS | 4996 | RSS: Main: 165916672 05:59:33 INFO - PROCESS | 4996 | 05:59:36 INFO - PROCESS | 4996 | Cycle 1(1): loaded http://localhost:54258/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54258/tests/kraken/driver.html?testName=imaging-darkroom) 05:59:37 INFO - PROCESS | 4996 | RSS: Main: 165720064 05:59:37 INFO - PROCESS | 4996 | 05:59:40 INFO - PROCESS | 4996 | Cycle 1(1): loaded http://localhost:54258/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54258/tests/kraken/driver.html?testName=imaging-desaturate) 05:59:41 INFO - PROCESS | 4996 | RSS: Main: 164777984 05:59:41 INFO - PROCESS | 4996 | 05:59:43 INFO - PROCESS | 4996 | Cycle 1(1): loaded http://localhost:54258/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54258/tests/kraken/driver.html?testName=json-parse-financial) 05:59:44 INFO - PROCESS | 4996 | RSS: Main: 166809600 05:59:44 INFO - PROCESS | 4996 | 05:59:45 INFO - PROCESS | 4996 | Cycle 1(1): loaded http://localhost:54258/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54258/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:59:46 INFO - PROCESS | 4996 | RSS: Main: 166350848 05:59:46 INFO - PROCESS | 4996 | 05:59:48 INFO - PROCESS | 4996 | Cycle 1(1): loaded http://localhost:54258/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54258/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:59:49 INFO - PROCESS | 4996 | RSS: Main: 165253120 05:59:49 INFO - PROCESS | 4996 | 05:59:51 INFO - PROCESS | 4996 | Cycle 1(1): loaded http://localhost:54258/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54258/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:59:51 INFO - PROCESS | 4996 | RSS: Main: 166027264 05:59:51 INFO - PROCESS | 4996 | 05:59:54 INFO - PROCESS | 4996 | Cycle 1(1): loaded http://localhost:54258/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54258/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:59:54 INFO - PROCESS | 4996 | RSS: Main: 164876288 05:59:54 INFO - PROCESS | 4996 | 05:59:57 INFO - PROCESS | 4996 | Cycle 1(1): loaded http://localhost:54258/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54258/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:59:57 INFO - PROCESS | 4996 | RSS: Main: 166797312 05:59:57 INFO - PROCESS | 4996 | 05:59:59 INFO - PROCESS | 4996 | Cycle 1(1): loaded http://localhost:54258/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54258/tests/kraken/driver.html?testName=ai-astar) 05:59:59 INFO - PROCESS | 4996 | RSS: Main: 167186432 05:59:59 INFO - PROCESS | 4996 | 05:59:59 INFO - PROCESS | 4996 | __start_tp_report 05:59:59 INFO - PROCESS | 4996 | _x_x_mozilla_page_load 05:59:59 INFO - PROCESS | 4996 | _x_x_mozilla_page_load_details 05:59:59 INFO - PROCESS | 4996 | |i|pagename|runs| 05:59:59 INFO - PROCESS | 4996 | |0;ai-astar;112;106;109;109;112;126;110;110;110;109 05:59:59 INFO - PROCESS | 4996 | |1;audio-beat-detection;150;128;155;162;128;159;153;129;181;128 05:59:59 INFO - PROCESS | 4996 | |2;audio-dft;162;161;161;164;163;163;161;164;170;165 05:59:59 INFO - PROCESS | 4996 | |3;audio-fft;75;75;74;73;75;154;76;75;76;72 05:59:59 INFO - PROCESS | 4996 | |4;audio-oscillator;96;94;147;94;92;94;135;93;94;135 05:59:59 INFO - PROCESS | 4996 | |5;imaging-gaussian-blur;119;119;117;119;117;117;117;117;118;119 05:59:59 INFO - PROCESS | 4996 | |6;imaging-darkroom;147;148;146;147;147;146;147;146;147;147 05:59:59 INFO - PROCESS | 4996 | |7;imaging-desaturate;96;96;96;97;96;96;96;96;97;96 05:59:59 INFO - PROCESS | 4996 | |8;json-parse-financial;67;58;60;57;60;60;57;63;59;55 05:59:59 INFO - PROCESS | 4996 | |9;json-stringify-tinderbox;67;68;67;67;69;69;68;67;67;69 05:59:59 INFO - PROCESS | 4996 | |10;stanford-crypto-aes;83;83;83;84;85;84;84;84;84;82 05:59:59 INFO - PROCESS | 4996 | |11;stanford-crypto-ccm;119;125;122;128;121;128;124;118;118;122 05:59:59 INFO - PROCESS | 4996 | |12;stanford-crypto-pbkdf2;167;160;153;153;152;154;154;162;152;139 05:59:59 INFO - PROCESS | 4996 | |13;stanford-crypto-sha256-iterative;70;71;71;69;70;67;69;71;68;68 05:59:59 INFO - PROCESS | 4996 | __end_tp_report 05:59:59 INFO - PROCESS | 4996 | __start_cc_report 05:59:59 INFO - PROCESS | 4996 | _x_x_mozilla_cycle_collect,808 05:59:59 INFO - PROCESS | 4996 | __end_cc_report 05:59:59 INFO - PROCESS | 4996 | __startTimestamp1456927199943__endTimestamp 05:59:59 INFO - PROCESS | 4996 | 05:59:59 INFO - PROCESS | 4996 | ------- Summary: start ------- 05:59:59 INFO - PROCESS | 4996 | Number of tests: 14 05:59:59 INFO - PROCESS | 4996 | 05:59:59 INFO - PROCESS | 4996 | [#0] ai-astar Cycles:10 Average:111.30 Median:110.00 stddev:5.44 (4.9%) stddev-sans-first:5.76 05:59:59 INFO - PROCESS | 4996 | Values: 112.0 106.0 109.0 109.0 112.0 126.0 110.0 110.0 110.0 109.0 05:59:59 INFO - PROCESS | 4996 | 05:59:59 INFO - PROCESS | 4996 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:154.00 stddev:18.38 (11.9%) stddev-sans-first:19.47 05:59:59 INFO - PROCESS | 4996 | Values: 150.0 128.0 155.0 162.0 128.0 159.0 153.0 129.0 181.0 128.0 05:59:59 INFO - PROCESS | 4996 | 05:59:59 INFO - PROCESS | 4996 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.50 stddev:2.72 (1.7%) stddev-sans-first:2.83 05:59:59 INFO - PROCESS | 4996 | Values: 162.0 161.0 161.0 164.0 163.0 163.0 161.0 164.0 170.0 165.0 05:59:59 INFO - PROCESS | 4996 | 05:59:59 INFO - PROCESS | 4996 | [#3] audio-fft Cycles:10 Average:82.50 Median:75.00 stddev:25.15 (33.5%) stddev-sans-first:26.53 05:59:59 INFO - PROCESS | 4996 | Values: 75.0 75.0 74.0 73.0 75.0 154.0 76.0 75.0 76.0 72.0 05:59:59 INFO - PROCESS | 4996 | 05:59:59 INFO - PROCESS | 4996 | [#4] audio-oscillator Cycles:10 Average:107.40 Median:94.00 stddev:22.07 (23.5%) stddev-sans-first:23.02 05:59:59 INFO - PROCESS | 4996 | Values: 96.0 94.0 147.0 94.0 92.0 94.0 135.0 93.0 94.0 135.0 05:59:59 INFO - PROCESS | 4996 | 05:59:59 INFO - PROCESS | 4996 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.50 stddev:0.99 (0.8%) stddev-sans-first:0.97 05:59:59 INFO - PROCESS | 4996 | Values: 119.0 119.0 117.0 119.0 117.0 117.0 117.0 117.0 118.0 119.0 05:59:59 INFO - PROCESS | 4996 | 05:59:59 INFO - PROCESS | 4996 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 05:59:59 INFO - PROCESS | 4996 | Values: 147.0 148.0 146.0 147.0 147.0 146.0 147.0 146.0 147.0 147.0 05:59:59 INFO - PROCESS | 4996 | 05:59:59 INFO - PROCESS | 4996 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:59:59 INFO - PROCESS | 4996 | Values: 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 97.0 96.0 05:59:59 INFO - PROCESS | 4996 | 05:59:59 INFO - PROCESS | 4996 | [#8] json-parse-financial Cycles:10 Average:59.60 Median:60.00 stddev:3.41 (5.7%) stddev-sans-first:2.33 05:59:59 INFO - PROCESS | 4996 | Values: 67.0 58.0 60.0 57.0 60.0 60.0 57.0 63.0 59.0 55.0 05:59:59 INFO - PROCESS | 4996 | 05:59:59 INFO - PROCESS | 4996 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 05:59:59 INFO - PROCESS | 4996 | Values: 67.0 68.0 67.0 67.0 69.0 69.0 68.0 67.0 67.0 69.0 05:59:59 INFO - PROCESS | 4996 | 05:59:59 INFO - PROCESS | 4996 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:84.00 stddev:0.84 (1.0%) stddev-sans-first:0.87 05:59:59 INFO - PROCESS | 4996 | Values: 83.0 83.0 83.0 84.0 85.0 84.0 84.0 84.0 84.0 82.0 05:59:59 INFO - PROCESS | 4996 | 05:59:59 INFO - PROCESS | 4996 | [#11] stanford-crypto-ccm Cycles:10 Average:122.50 Median:123.00 stddev:3.72 (3.0%) stddev-sans-first:3.72 05:59:59 INFO - PROCESS | 4996 | Values: 119.0 125.0 122.0 128.0 121.0 128.0 124.0 118.0 118.0 122.0 05:59:59 INFO - PROCESS | 4996 | 05:59:59 INFO - PROCESS | 4996 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.60 Median:154.00 stddev:7.46 (4.8%) stddev-sans-first:6.42 05:59:59 INFO - PROCESS | 4996 | Values: 167.0 160.0 153.0 153.0 152.0 154.0 154.0 162.0 152.0 139.0 05:59:59 INFO - PROCESS | 4996 | 05:59:59 INFO - PROCESS | 4996 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:70.00 stddev:1.43 (2.0%) stddev-sans-first:1.50 05:59:59 INFO - PROCESS | 4996 | Values: 70.0 71.0 71.0 69.0 70.0 67.0 69.0 71.0 68.0 68.0 05:59:59 INFO - PROCESS | 4996 | -------- Summary: end -------- 05:59:59 INFO - PROCESS | 4996 | 06:00:00 INFO - TEST-INFO | 4996: exit 0 06:00:00 INFO - TEST-OK | kraken | took 60503ms 06:00:00 INFO - SUITE-END | took 1169s 06:00:01 INFO - Completed test suite (00:19:30) 06:00:01 INFO - Working with test: dromaeo_css 06:00:01 INFO - Generating results file: dromaeo_css 06:00:01 INFO - Working with test: kraken 06:00:01 INFO - Generating results file: kraken 06:00:01 INFO - javascript benchmark 06:00:01 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:00:01 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 06:00:01 INFO - process_Request line: dromaeo_css 6778.44 graph.html#tests=[[72,1,43]] 06:00:01 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:00:01 INFO - process_Request line: kraken 1530.30 graph.html#tests=[[232,1,43]] 06:00:01 INFO - RETURN: dromaeo_css: 6778.44 06:00:01 INFO - RETURN: kraken: 1530.30 06:00:01 INFO - javascript benchmark 06:00:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3213.2609499815044, 3229.047431007853, 3237.8866739664118, 3258.804471731696, 3269.591301087363, 5128.333316668837, 5130.0, 5143.408508021578, 5221.556167725738, 5229.1371923632605, 5154.458781827911, 5164.9483505164935, 5208.921866172001, 5254.7635356408955, 5320.9467905320935, 14.911745408329473, 4754.690945088567, 4795.832145874895, 4857.222844344906, 4873.24464707969, 4701.318308845215, 4717.528247175289, 4766.38037055184, 4767.809287628508, 4801.663883528155, 4690.671652984292, 4713.7643117844145, 4730.432348118231, 4780.354652121954, 4804.903901921977, 4756.857294281177, 4795.472498025214, 4798.136335459616, 4803.663743537953, 4832.347633069526, 4717.103750287434, 4719.315699223627, 4746.0, 4804.903901921977, 4848.466668666444, 5053.823116190915, 5066.36670416198, 5088.618353623493, 5098.566621837148, 5141.2545180948555, 5643.520300774439, 5644.153376993443, 5648.227555062028, 5651.0, 5680.545556355523, 5652.971735141339, 5669.26299581056, 5673.602847800656, 5714.828555143311, 5789.594728369016, 5273.0, 5284.947150528484, 5294.894102117936, 5301.522862942354, 5320.14877619579, 5731.283589551306, 5737.5983681141915, 5738.340090889517, 5742.712864356766, 5781.566382521328, 5519.144532597454, 5555.861103472364, 5573.665580065209, 5625.09998400254, 5693.345265294544, 5641.323041235078, 5677.290338707661, 5685.5167310778215, 5692.6299790513485, 5716.79991200306, 5616.466435688603, 5655.717214139277, 5668.744906479218, 5675.489205971482, 5683.431656834367, 5539.501444869981, 5542.168674698827, 5589.469000445032, 5594.356648985337, 5639.182318563785, 4282.057947251599, 4282.935755963663, 4323.697341186087, 4326.156399502067, 4350.434443522385, 3822.0, 3945.072907866649, 3952.3873799561115, 3955.169414422946, 4003.4795476587856, 5322.787088516493, 5327.3074500314715, 5394.136938089887, 5430.239766432703, 5505.614606977553, 5628.0, 5643.209950606918, 5655.604107712421, 5661.943380566224, 5686.2039314496005, 5340.038793017294, 5370.516653501204, 5376.542993845489, 5377.623566350318, 5384.138537833927, 4808.567228949411, 4818.807247710122, 4843.75781210938, 4854.805807767721, 4884.975575122173, 5885.0, 5887.234659494238, 5895.587308888336, 5904.76380944766, 5913.58604897653, 5654.915176272277, 5661.547076233974, 5678.971605141948, 5711.428857114422, 5712.6286791358425, 5888.764449421975, 5893.705314734332, 5894.322152952465, 5916.171735956884, 5943.257092863392, 5515.338159420735, 5534.695591742493, 5543.722813859372, 5554.666719996813, 5563.193336966036, 5448.727563621882, 5574.247476590608, 5591.776328946797, 5639.746211420414, 5643.633163844337, 5432.59255555827, 5433.483819037185, 5457.99027179973, 5459.5632349412745, 5496.0931446310915, 5429.7556609953435, 5439.238506609157, 5461.262729531462, 5465.262189604353, 5491.066518691912, 5381.246625472515, 5398.1902714593125, 5404.675719456845, 5439.972800135974, 5503.3395992481155, 5516.0, 5521.641093328921, 5543.556515478833, 5557.41647127062, 5568.749406276808, 5350.598705097055, 5370.275012873369, 5384.273123128484, 5390.62265641417, 5436.320459942507], "unit": "score", "name": "dojo.html", "value": 5168.175610491098}, {"lowerIsBetter": false, "replicates": [501.35325430195076, 516.6564234783868, 563.2733773432273, 579.904315787895, 584.7281014328337, 35899.4615080774, 35939.46090808637, 36269.274614507696, 36311.273774524496, 36495.45256821146, 39266.8036659817, 39589.802050989776, 39738.0, 39784.80107599458, 39822.60177398225, 8424.536650484237, 8606.56967151643, 8640.524771137585, 8672.34957378196, 8673.826523469526, 8255.25702686758, 8403.95798021009, 8437.071922088597, 8630.827383452328, 8652.8702069469, 8554.05905350411, 8625.698100566482, 8640.265577425926, 8643.481391116553, 8658.004329502124, 8543.316534677242, 8545.786355341135, 8609.354298427581, 8616.698415555456, 8637.39538232324, 8576.828463430697, 8661.393702440831, 8691.04398516169, 8697.695580654647, 8720.781980450476, 39305.0, 40171.39742903859, 40273.798631006954, 40425.0, 40591.18817623631, 2917.3435976905025, 3108.844557772125, 3316.4527852904243, 3340.699337059652, 3561.554805649294, 27297.863510682517, 27750.02874899369, 27810.16569502918, 27810.860945695345, 27885.58171627427, 2987.4622567937763, 3020.8489575521135, 3046.8324242166673, 3057.6636569977286, 3133.7649676274373, 182374.08812955982, 183254.08372958182, 183889.0, 184444.0, 184530.07734961374, 40141.79929100336, 41189.176216475505, 41227.1754564913, 41383.379249311285, 55609.44390556042, 40265.396019059735, 40283.79858100691, 40427.797861011095, 40533.0, 40540.79729601392, 14228.0, 14235.857641423454, 14246.0, 14325.57023289303, 14371.64070898215, 11174.10607151426, 11201.21591488588, 11281.379524126252, 11290.209685321948, 11390.772184556263, 14432.927835360755, 14444.855551444562, 14471.85528144726, 14482.782758258634, 14495.420183192766, 5788.623739456922, 5854.443827836434, 5919.467247947706, 5930.169776231331, 5959.612625179436, 912.7124955638952, 965.560669895196, 966.7438128895848, 1027.2039169643438, 1071.6035067025095, 28363.0, 28539.28651783722, 29000.7099928998, 29095.0, 29153.0, 1035.808375450544, 1092.5192915117323, 1094.2067001423904, 1104.5416152296707, 1147.7933971884975, 14639.707205855822, 15111.0, 15200.163990980602, 15368.615784605474, 15394.846051539342, 286745.0, 290586.0, 292514.0, 292630.0, 292842.0, 51246.0, 51722.224166637534, 51766.48233517692, 51967.74016129895, 52182.21726674103, 1269.428757059327, 1304.4716889659703, 1347.6765576261625, 1356.1049707193206, 1368.0423703407655, 27148.1855544334, 28257.858710706314, 28316.43367132687, 28408.43183136367, 28478.857605712667, 46717.0, 47034.29448558343, 47426.76286618545, 47455.52544474649, 47615.28577071278, 270804.0, 275033.0, 275249.0, 275567.0, 275921.0, 32333.0, 32659.510107348884, 43784.78107609441, 44728.55271447244, 45150.0, 40066.79966600265, 40688.79655601703, 40750.59249407468, 41176.58823411848, 41252.0, 34184.31631367309, 34365.0, 34526.0, 34685.82657086799, 34857.8257108723, 34315.828420858736, 34333.48499772555, 34559.30881382308, 34568.30863382668, 34685.306293874484, 33504.83247583844, 36060.4590931131, 36501.81749091238, 38645.61354386533, 39235.80382098071, 30059.248518787204, 31174.37651246917, 31292.0, 31308.843455782575, 31321.8433907829, 23890.283291501284, 24347.634785477876, 25597.61603575985, 25602.359941001625, 25864.0], "unit": "score", "name": "ext.html", "value": 17269.19305499351}, {"lowerIsBetter": false, "replicates": [345.70787684406685, 351.8856371679203, 352.5223322398151, 358.4998926497536, 361.7359327690787, 16349.836501634994, 16668.499945001655, 17591.296348146076, 17711.380101696443, 17716.557086072855, 15845.445409410673, 15858.762118568202, 15992.680146397066, 16036.919815400906, 16053.357865685359, 5294.1529355303155, 5303.575713942885, 5582.609217354787, 5616.63491873029, 5618.353889302721, 5515.255440515519, 5555.2778138841895, 5570.442955704438, 5595.21666966625, 5605.1872478490595, 4971.179755340365, 5180.740962951856, 5539.14143307788, 5560.86097847553, 5565.109582466806, 5166.225066240057, 5171.379434467869, 5180.067587834188, 5183.196604526304, 5188.92216616751, 4916.729579873106, 5413.2150838128255, 5430.891382172374, 5431.0, 5432.130859062531, 12436.502539898393, 12626.116171867972, 12716.109872308942, 14536.491222807257, 20043.59912801736, 2206.702095217141, 2212.369474699703, 2242.248846636379, 2292.1404473322505, 2790.6093146959442, 8952.328575356874, 9243.02948190437, 12179.0, 12386.75226495465, 12948.842367946767, 1873.5503479164902, 1903.6954087345957, 1924.3264857299973, 1945.4455480188078, 1947.805219478041, 59252.40747592512, 61234.0, 62017.7596448073, 62711.0, 63003.36996630067, 9401.106894845116, 9487.383320084173, 9679.70960871161, 9715.27135464843, 9889.406635601887, 12227.449764760608, 12369.196002259825, 12371.443285052193, 12384.256944583354, 12393.752124957631, 6884.208316043619, 6945.166580010431, 7225.783226503213, 7259.274072592699, 7300.014498042802, 6805.115335006517, 6812.897806532906, 6895.55178913369, 6916.273791251947, 6940.7917762467205, 4081.1225586499045, 4119.134981653886, 4144.3990621360335, 4167.187398457332, 4180.581941805856, 1754.2982806877096, 1755.3066538717135, 1798.9460316190534, 1800.2267766250234, 1809.5837957269903, 874.3136637739344, 938.5025936253796, 971.8542218667116, 993.3146129170849, 994.9204063674889, 14480.203588802506, 15653.843461565239, 16319.510414687578, 16391.672166556604, 16985.49043528696, 928.8281667891462, 950.296780382512, 965.8020105878278, 967.8209531236603, 1029.1355261580309, 7675.270849269311, 9560.28297877648, 9657.0, 9714.174295184988, 9715.514224288758, 391959.0, 399691.0, 403347.0, 406351.0, 414709.0, 45168.774156129664, 66086.0, 66149.33850661432, 67815.32184678188, 73665.63167184238, 1004.0963133180051, 1041.8385150301565, 1049.9422531760827, 1052.6947185316326, 1054.530733823441, 14447.349869255699, 14677.70644587081, 14757.557273281818, 14776.852231477978, 15081.472148474752, 30404.847975759978, 31622.67961864063, 31716.682833171373, 31988.520172197903, 34045.14887127842, 43067.7846610765, 43764.0, 46328.768356158005, 48147.51852481571, 49888.50111498839, 10674.89325106739, 11148.163887708291, 11234.382108984084, 11266.155038371991, 11476.368799716096, 12054.09594280415, 12737.108402412114, 12855.421506032439, 12908.419121139383, 12920.935395323339, 10762.08522275584, 10874.238803283693, 11215.383153926286, 11292.717682058013, 11441.199116061796, 10950.178736594627, 11089.611863584736, 11624.883751162719, 11710.0, 11872.168948173545, 10709.625163119254, 11497.195196336175, 11568.88431115678, 11755.88244117548, 12103.152779305365, 11168.72078198019, 11247.381394023407, 11313.71715707114, 11334.14993875446, 11365.204435689753, 11203.831942520706, 11274.436278185894, 11623.941880290544, 11625.476853541442, 11718.765624687629], "unit": "score", "name": "jquery.html", "value": 8393.56145514865}, {"lowerIsBetter": false, "replicates": [1453.8982271241011, 1455.5415044261058, 1633.2976819967416, 1803.4769916724151, 1844.7786265648124, 6757.526973111884, 7179.317964793349, 7422.814429639262, 7611.619419029047, 7660.578668173248, 7647.502912310696, 7685.884711729329, 7719.961400192991, 7735.651895664694, 7746.690132394711, 2214.546018066301, 2241.4620491082105, 2243.4839986803045, 2247.1236217875044, 2250.718660167479, 2220.367195349326, 2223.299660606912, 2265.864048157116, 2269.7616750241236, 2276.203328834911, 2232.899519521617, 2237.8881055947218, 2241.618924782783, 2266.2634643740766, 2291.0606651272983, 2225.332400279926, 2247.550489902026, 2249.257744944173, 2250.1224522436264, 2264.218844498662, 2204.647256438962, 2224.1103558576697, 2224.4661281292533, 2232.475368288451, 2236.1279101150562, 7601.543907365576, 7601.961990190069, 7622.123455802598, 7633.5419874807685, 7657.272559106876, 4442.489113751928, 4496.505384407713, 4552.271636538171, 4553.203189441868, 4573.314002899559, 2850.914472565826, 2975.2561859535117, 2979.0, 2995.0415866922594, 3003.039027511197, 896.9596368163449, 899.5727029660859, 906.8231694819513, 931.2922179143832, 1000.3847633705292, 10784.5686172553, 10789.514471848706, 10797.5680972761, 10808.189385796019, 10853.837192442119, 4113.691473139526, 4116.650084742831, 4156.106437116035, 4287.056847493546, 4288.656907447396, 9123.863142052875, 9128.3153763468, 9161.725148245563, 9171.266298696088, 9186.26509879208, 4438.667099967515, 4450.777461126931, 4456.376107344974, 4473.261911784584, 4477.104579084196, 3805.46723458716, 3997.320455522568, 4037.4751282333696, 4070.6132917373393, 4180.6446452051305, 3522.5244591980268, 3554.3779838528153, 3607.22444674391, 3610.530631017951, 3634.200475895299, 1100.4167791070745, 1145.954161833534, 1149.431031639327, 1150.6950658075616, 1156.0693641618577, 1357.5520078374113, 1358.151155527795, 1359.5513480551394, 1390.6662401023682, 1393.7491251574813, 7153.463490238253, 7209.783706488814, 7271.272872712686, 7287.854242915112, 7289.2346303638415, 484.0730002046042, 490.1226804020763, 492.1141944499886, 499.1389852504401, 505.7774579185147, 5342.118550439134, 5351.892962140735, 5355.357357117171, 5369.892602147936, 5409.188621706776, 8565.871511927326, 8795.252403545643, 9286.489243091559, 9313.20837728787, 9325.720228393024, 9010.27917766577, 9059.59231834569, 9070.86393704095, 9078.092190781, 9126.0, 6847.794566163023, 7023.122109736283, 7028.753993610301, 7038.331358520933, 7049.259827718119, 7046.048783414379, 7091.716331346688, 7103.857922841617, 7110.537815042006, 7132.322429369202, 7809.297163255334, 8050.557219352758, 8124.309433698202, 8131.918680813353, 8190.672373105009, 8091.474054186459, 8105.432619716563, 8114.594270286344, 8240.876386854083, 8266.83466330658, 6627.204735431586, 6690.866182676416, 6983.231844497, 7013.263607321362, 7035.7537486189785, 6988.580685158907, 7001.159860816734, 7019.438444924496, 7027.367536921702, 7188.17336006366, 6657.667116644246, 6823.89764153548, 6886.449084073162, 6886.827829304308, 6959.095317608679, 6578.375054369827, 6638.0374845648075, 6691.966540167463, 6750.0, 6798.694058767268, 6512.153420055362, 6701.765438209639, 6736.124303840469, 6771.424428923597, 6810.489213308922, 6309.589876658002, 6380.489560835029, 6394.968025159845, 6413.1021656969, 6428.935710643021, 6040.637561746309, 6087.634741915499, 6089.969550152221, 6093.390660933871, 6113.755449781959], "unit": "score", "name": "mootools.html", "value": 4296.473520205793}, {"lowerIsBetter": false, "replicates": [325.26490132301, 328.1222729199391, 332.176203016519, 335.34272825262485, 339.7944243732542, 6210.223722034746, 6211.689415529222, 6211.782587609423, 6254.46837018854, 6262.279837818653, 6089.238845144357, 6096.4513193812545, 6106.48094911933, 6117.38826117388, 6140.478059364948, 4500.324951257305, 4560.657950653715, 4617.676762626617, 4627.352170696088, 4665.1602711512, 4546.8408605698805, 4547.977260113711, 4594.862154135365, 4600.677952543323, 4624.676272660899, 4544.477385100723, 4553.4991150973365, 4568.657350698711, 4572.291294849304, 4581.908361832778, 4596.701214421052, 4599.2871104978785, 4600.240960241556, 4600.585947264745, 4604.884877878047, 3964.4846169998004, 3965.6827453803626, 3966.3058964681354, 3968.3452230381954, 3973.245083434167, 5908.852278693024, 5927.970360148215, 5928.0, 5934.940650593525, 5935.406459354073, 5218.705415065543, 5252.474752524755, 5313.149896016619, 5325.707086110262, 5332.493413125747, 6409.294977552466, 6464.74141034358, 6484.351564843525, 6504.1869766279215, 6514.93485065148, 4319.244132276839, 4358.128374325148, 4358.476982762058, 4358.8038538265855, 4371.475422949235, 6734.93265067348, 6792.49056320773, 6800.251972283045, 6802.489813264025, 6808.489363297723, 4425.468943726709, 4446.64426845858, 4448.5773851484055, 4468.597826195658, 4473.888152796141, 4344.087741574304, 4479.059397526491, 4487.573680500347, 4489.393931819162, 4500.537325369268, 5259.105951988171, 5260.368755749258, 5278.762455689503, 5292.232626269247, 5302.992431438014, 6515.967420162963, 6518.185226846645, 6555.639439830855, 6574.967125164344, 6613.900791488131, 1586.2227508520741, 1627.5117464760524, 1627.7558366245157, 1628.5033064915315, 1636.746304322832, 1015.5836107196014, 1017.9083882450615, 1041.1358572385054, 1049.58541376156, 1053.757635743783, 6314.052892066226, 6324.494040476751, 6343.397377249154, 6357.11000459936, 6360.618362898241, 6670.96664516684, 6719.160104986877, 6722.226943901514, 6727.360900714424, 6729.596224226562, 6222.81331560054, 6290.937090629127, 6295.6537390443045, 6373.52198585108, 6400.807975760735, 3635.5092062571216, 3669.889903302905, 3682.760620559655, 3687.4284485904727, 3695.593484716679, 7261.927380726125, 7267.236940121317, 7279.344858962719, 7308.744193953186, 7319.048523691886, 6915.861682766316, 6937.653117344113, 6967.79096627102, 6995.055667484824, 7005.1593808742255, 7077.858442831114, 7226.74706385274, 7243.492955493065, 7251.129864416198, 7286.48994570375, 6794.76218332356, 6829.31706829333, 6831.248562658203, 6845.212800527804, 6872.793816185523, 6693.0, 6710.664466776544, 6712.530122891546, 6730.697118629576, 6733.831654208684, 7236.167840698387, 7249.565026098451, 7270.309320614533, 7276.4542659299705, 7279.672414741243, 4390.121975604828, 4448.332750087513, 4494.685372023927, 4496.100779843979, 4512.774361281989, 6801.251862295045, 6804.693788779616, 6813.182418109858, 6842.1789385272095, 6850.794476165723, 6614.470842332698, 6619.768308109193, 6623.4038936495945, 6633.900491492728, 6635.535512514078, 6531.640759758259, 6580.0, 6586.155876354628, 6604.933950660432, 6629.602223866584, 6330.177076979963, 6444.677766111769, 6460.741570337322, 6489.805305840832, 6496.187976502937, 6611.570247933869, 6616.4045235929, 6639.53523253387, 6670.533062685566, 6675.0654908313845, 6406.967965160331, 6417.326180750954, 6437.485001199799, 6437.742490300523, 6446.709898054505], "unit": "score", "name": "prototype.html", "value": 4895.432275327709}, {"lowerIsBetter": false, "replicates": [653.964031978241, 686.5983399711168, 725.4595326481768, 745.9705606263358, 774.3688893551758, 12670.936645316771, 15542.300596473158, 16054.357825686959, 16071.437499687485, 16103.758443623341, 14618.780718289234, 14736.705265894676, 14741.778873316882, 14750.704985900302, 14786.112833229987, 823.4729772945335, 826.7850358906697, 832.7210384521193, 833.4374297349295, 837.401258100458, 689.5965859971898, 827.9586020698971, 832.3466079127886, 832.6128350317101, 832.646125396707, 862.2326129744501, 863.1756672377865, 865.8831057807179, 865.909079546648, 875.6234819027816, 859.0378775771114, 859.5788063848701, 861.8233262181237, 862.3575436299934, 862.5816479007676, 630.8927482328015, 631.5831551176202, 633.183193680152, 634.2674211285972, 636.5734957578434, 13200.14199077057, 13317.067805253637, 13415.060945733803, 13462.0, 13567.52513662017, 12010.63968080959, 12064.155509114365, 12142.0893432992, 12157.51369945201, 12178.51285948561, 9776.560054797552, 10148.188144948386, 10357.482125893675, 10522.105621022223, 10557.472126393726, 3517.8416971236356, 3587.820608969541, 3600.225951420457, 3642.3807952648112, 3716.7955762433057, 50207.748961255325, 50412.495875041146, 50619.74690126563, 50758.238626420636, 51393.486065139245, 9198.770030749285, 9358.344915855962, 9629.662961796303, 9648.421094734338, 9730.562124704406, 18094.0, 18161.818381816276, 18208.36270730518, 18234.635307294044, 18268.90865545664, 7689.115751688516, 7769.922300777033, 7891.447598668038, 8037.23646253605, 8084.272415482635, 3967.940480892789, 4142.855000075043, 4481.439820022497, 4544.863654090383, 4641.95358046422, 2936.2365784896083, 3059.8470076496087, 3063.938721225563, 3075.3234288456506, 3078.3843231353817, 552.1248820619284, 568.85494198979, 572.1018001737316, 581.6917033972002, 584.5557376393971, 519.5376115257424, 592.754007087054, 613.6440864298696, 621.8134559632183, 628.7485005997637, 7813.374930005586, 7999.4400391972, 8022.237887400687, 8082.353411727166, 8250.628721707537, 583.9678817664984, 590.5482306035886, 610.8869859076085, 637.2830565613684, 650.0346984727676, 3445.414279572479, 3476.947845782315, 3582.3193593217725, 3595.3168897909313, 3645.198056427582, 54210.18684719732, 54688.453115468335, 55305.1704224437, 55386.446135538936, 55507.0, 49106.50893491091, 49436.0, 49993.25010124851, 50118.74940625273, 50285.74857125764, 44788.3281750774, 45071.77464112658, 45288.77355613201, 45366.31950520745, 45719.31421028687, 7005.749580449448, 7025.789226323219, 7075.893861592183, 7187.928120718726, 7329.670164842488, 32599.674003259664, 33520.32959340848, 33789.66210337865, 34195.31609367749, 34467.65532344745, 39703.60296397115, 43717.56282437135, 44090.11819763651, 44117.33823992707, 44169.55830441783, 10093.19254459656, 10162.491875406053, 10227.386356818615, 10249.897501024894, 10291.691249262534, 11268.308257173658, 11486.483108260316, 11600.709982250512, 11673.241239319417, 11811.527538898348, 10643.680689579016, 11114.333140011626, 11173.608923687632, 11657.417129143678, 11797.941010294893, 9655.613775448903, 9662.275329350467, 9669.129778319704, 10141.49292535385, 10890.128789696964, 11187.328760274084, 11234.382108983757, 11345.262557933707, 11665.35840528779, 11675.474603643026, 8508.702195423131, 8579.2707619853, 8590.1839325264, 8785.165409286108, 8863.689770857989, 8698.434601750865, 8903.0, 9107.0, 9220.262379009797, 9284.814303713752], "unit": "score", "name": "yui.html", "value": 6155.756228174319}], "name": "dromaeo_css", "value": 6778.43605257474}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 109.0, 109.0, 112.0, 126.0, 110.0, 110.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [150.0, 128.0, 155.0, 162.0, 128.0, 159.0, 153.0, 129.0, 181.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 147.3}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 161.0, 164.0, 163.0, 163.0, 161.0, 164.0, 170.0, 165.0], "unit": "score", "name": "audio-dft", "value": 163.4}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 74.0, 73.0, 75.0, 154.0, 76.0, 75.0, 76.0, 72.0], "unit": "score", "name": "audio-fft", "value": 82.5}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 147.0, 94.0, 92.0, 94.0, 135.0, 93.0, 94.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 107.4}, {"lowerIsBetter": true, "replicates": [119.0, 119.0, 117.0, 119.0, 117.0, 117.0, 117.0, 117.0, 118.0, 119.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.9}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [67.0, 58.0, 60.0, 57.0, 60.0, 60.0, 57.0, 63.0, 59.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 59.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 69.0, 69.0, 68.0, 67.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 83.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [119.0, 125.0, 122.0, 128.0, 121.0, 128.0, 124.0, 118.0, 118.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.5}, {"lowerIsBetter": true, "replicates": [167.0, 160.0, 153.0, 153.0, 152.0, 154.0, 154.0, 162.0, 152.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 154.6}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 71.0, 69.0, 70.0, 67.0, 69.0, 71.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1530.2999999999997}]} 06:00:01 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1530.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6778.44"}}} 06:00:01 INFO - Return code: 0 06:00:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:00:01 ERROR - # TBPL SUCCESS # 06:00:01 INFO - Running post-action listener: _resource_record_post_action 06:00:01 INFO - Running post-run listener: _resource_record_post_run 06:00:02 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 20480; Write bytes: 544841728; Read time: 268; Write time: 566768 06:00:02 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 250064896; Read time: 0; Write time: 327788 06:00:02 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 20480; Write bytes: 294776832; Read time: 268; Write time: 238980 06:00:02 INFO - Running post-run listener: _upload_blobber_files 06:00:02 INFO - Blob upload gear active. 06:00:02 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:00:02 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:00:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 06:00:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 06:00:02 INFO - (blobuploader) - INFO - Open directory for files ... 06:00:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:00:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:00:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:04 INFO - (blobuploader) - INFO - Done attempting. 06:00:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:00:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:00:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:05 INFO - (blobuploader) - INFO - Done attempting. 06:00:05 INFO - (blobuploader) - INFO - Iteration through files over. 06:00:05 INFO - Return code: 0 06:00:05 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:00:05 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:00:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b42f8d155e8ae976f039486188bbfbd1dede88cdbff1137ff0a30b649b7098c0a672b63eae55863b8a92f234d29411dd5b47a07bf0c7be5fe6cb872c555c1c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba6136e04c8f8900c08e917db63620b514c44d1ef779e073cd836b0a2e1d3362a0b00a4517449fe8b42748bc8b4f3937e1ec9048e1b80c64283ba0979160bae5"} 06:00:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:00:05 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:00:05 INFO - Contents: 06:00:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b42f8d155e8ae976f039486188bbfbd1dede88cdbff1137ff0a30b649b7098c0a672b63eae55863b8a92f234d29411dd5b47a07bf0c7be5fe6cb872c555c1c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba6136e04c8f8900c08e917db63620b514c44d1ef779e073cd836b0a2e1d3362a0b00a4517449fe8b42748bc8b4f3937e1ec9048e1b80c64283ba0979160bae5"} 06:00:05 INFO - Running post-run listener: copy_logs_to_upload_dir 06:00:05 INFO - Copying logs to upload dir... 06:00:05 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 06:00:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.629533 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-03-02 06:00:05.307659) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 06:00:05.314905) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1456925464.581094-1940740797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b42f8d155e8ae976f039486188bbfbd1dede88cdbff1137ff0a30b649b7098c0a672b63eae55863b8a92f234d29411dd5b47a07bf0c7be5fe6cb872c555c1c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba6136e04c8f8900c08e917db63620b514c44d1ef779e073cd836b0a2e1d3362a0b00a4517449fe8b42748bc8b4f3937e1ec9048e1b80c64283ba0979160bae5"} build_url:https://queue.taskcluster.net/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011248 build_url: 'https://queue.taskcluster.net/v1/task/ATlRVXB2RI2SKsixDLb-YQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b42f8d155e8ae976f039486188bbfbd1dede88cdbff1137ff0a30b649b7098c0a672b63eae55863b8a92f234d29411dd5b47a07bf0c7be5fe6cb872c555c1c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba6136e04c8f8900c08e917db63620b514c44d1ef779e073cd836b0a2e1d3362a0b00a4517449fe8b42748bc8b4f3937e1ec9048e1b80c64283ba0979160bae5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 06:00:05.344160) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 06:00:05.348587) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1456925464.581094-1940740797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 06:00:05.428420) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 06:00:05.428806) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 06:00:05.429176) ========= ========= Total master_lag: 0.33 =========