builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1460251123.22 results: success (0) buildid: 20160409133023 builduid: 5c0582ba3e6f42d2bdf5499272c6d2f6 revision: d62963756d9a9d19cbbb5d8f3dd3c7cfa8fdef88 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-09 18:18:43.220860) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-09 18:18:43.221314) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-09 18:18:43.221604) ========= 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=14ef55db36f7623abb31b9cf000001d5-1460248374.820157-664867496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004363 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-09 18:18:43.254787) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-09 18:18:43.255100) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-09 18:18:43.283391) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:18:43.283780) ========= 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=14ef55db36f7623abb31b9cf000001d5-1460248374.820157-664867496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.064199 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:18:43.357567) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-09 18:18:43.357872) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-09 18:18:43.358235) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:18:43.358511) ========= 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=14ef55db36f7623abb31b9cf000001d5-1460248374.820157-664867496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-09 18:18:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 97.5M=0s 2016-04-09 18:18:43 (97.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.207817 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:18:43.579205) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:18:43.579524) ========= 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=14ef55db36f7623abb31b9cf000001d5-1460248374.820157-664867496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.202274 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:18:43.792913) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:18:43.793275) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d62963756d9a9d19cbbb5d8f3dd3c7cfa8fdef88 --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 d62963756d9a9d19cbbb5d8f3dd3c7cfa8fdef88 --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=14ef55db36f7623abb31b9cf000001d5-1460248374.820157-664867496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-09 18:18:43,924 truncating revision to first 12 chars 2016-04-09 18:18:43,924 Setting DEBUG logging. 2016-04-09 18:18:43,924 attempt 1/10 2016-04-09 18:18:43,924 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d62963756d9a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-09 18:18:44,189 unpacking tar archive at: mozilla-central-d62963756d9a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.562246 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:18:44.367957) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-09 18:18:44.368361) ========= echo d62963756d9a9d19cbbb5d8f3dd3c7cfa8fdef88 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd62963756d9a9d19cbbb5d8f3dd3c7cfa8fdef88'] 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=14ef55db36f7623abb31b9cf000001d5-1460248374.820157-664867496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d62963756d9a9d19cbbb5d8f3dd3c7cfa8fdef88 program finished with exit code 0 elapsedTime=0.003326 script_repo_revision: 'd62963756d9a9d19cbbb5d8f3dd3c7cfa8fdef88' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-09 18:18:44.416981) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-09 18:18:44.417308) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-09 18:18:44.427092) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-09 18:18:44.427412) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1460248374.820157-664867496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:18:44 INFO - MultiFileLogger online at 20160409 18:18:44 in /builds/slave/test-pgo 18:18:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:18:44 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:18:44 INFO - {'append_to_log': False, 18:18:44 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:18:44 INFO - 'blob_upload_branch': 'Firefox', 18:18:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:18:44 INFO - 'branch': 'Firefox', 18:18:44 INFO - 'buildbot_json_path': 'buildprops.json', 18:18:44 INFO - 'config_files': ('talos/linux_config.py',), 18:18:44 INFO - 'default_actions': ('clobber', 18:18:44 INFO - 'read-buildbot-config', 18:18:44 INFO - 'download-and-extract', 18:18:44 INFO - 'populate-webroot', 18:18:44 INFO - 'create-virtualenv', 18:18:44 INFO - 'install', 18:18:44 INFO - 'run-tests'), 18:18:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:18:44 INFO - 'download_minidump_stackwalk': True, 18:18:44 INFO - 'download_symbols': 'ondemand', 18:18:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:18:44 INFO - 'tooltool.py': '/tools/tooltool.py', 18:18:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:18:44 INFO - '/tools/misc-python/virtualenv.py')}, 18:18:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:18:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:18:44 INFO - 'installer_path': 'installer.exe', 18:18:44 INFO - 'log_level': 'info', 18:18:44 INFO - 'log_name': 'talos', 18:18:44 INFO - 'log_to_console': True, 18:18:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:18:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:18:44 INFO - 'opt_config_files': (), 18:18:44 INFO - 'pip_index': False, 18:18:44 INFO - 'sps_profile': False, 18:18:44 INFO - 'sps_profile_interval': 0, 18:18:44 INFO - 'suite': 'dromaeojs', 18:18:44 INFO - 'system_bits': '32', 18:18:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:18:44 INFO - 'title': 'talos-linux64-ix-036', 18:18:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:18:44 INFO - 'use_talos_json': True, 18:18:44 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:18:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:18:44 INFO - 'work_dir': 'build'} 18:18:44 INFO - ##### 18:18:44 INFO - ##### Running clobber step. 18:18:44 INFO - ##### 18:18:44 INFO - Running pre-action listener: _resource_record_pre_action 18:18:44 INFO - Running main action method: clobber 18:18:44 INFO - rmtree: /builds/slave/test-pgo/build 18:18:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:18:45 INFO - Running post-action listener: _resource_record_post_action 18:18:45 INFO - ##### 18:18:45 INFO - ##### Running read-buildbot-config step. 18:18:45 INFO - ##### 18:18:45 INFO - Running pre-action listener: _resource_record_pre_action 18:18:45 INFO - Running main action method: read_buildbot_config 18:18:45 INFO - Using buildbot properties: 18:18:45 INFO - { 18:18:45 INFO - "project": "", 18:18:45 INFO - "product": "firefox", 18:18:45 INFO - "script_repo_revision": "production", 18:18:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 18:18:45 INFO - "repository": "", 18:18:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 18:18:45 INFO - "buildid": "20160409133023", 18:18:45 INFO - "pgo_build": "True", 18:18:45 INFO - "basedir": "/builds/slave/test-pgo", 18:18:45 INFO - "buildnumber": 256, 18:18:45 INFO - "slavename": "talos-linux64-ix-036", 18:18:45 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:18:45 INFO - "platform": "ubuntu64_hw", 18:18:45 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 18:18:45 INFO - "branch": "mozilla-central", 18:18:45 INFO - "repo_path": "mozilla-central", 18:18:45 INFO - "revision": "d62963756d9a9d19cbbb5d8f3dd3c7cfa8fdef88", 18:18:45 INFO - "stage_platform": "linux64-pgo", 18:18:45 INFO - "builduid": "5c0582ba3e6f42d2bdf5499272c6d2f6", 18:18:45 INFO - "slavebuilddir": "test" 18:18:45 INFO - } 18:18:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 18:18:45 INFO - Running post-action listener: _resource_record_post_action 18:18:45 INFO - ##### 18:18:45 INFO - ##### Running download-and-extract step. 18:18:45 INFO - ##### 18:18:45 INFO - Running pre-action listener: _resource_record_pre_action 18:18:45 INFO - Running main action method: download_and_extract 18:18:45 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:18: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')]} 18:18:45 INFO - https://queue.taskcluster.net/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:18:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:18:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:18:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:18:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:18:46 INFO - Downloaded 1361 bytes. 18:18:46 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:18:46 INFO - Using the following test package requirements: 18:18:46 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:18:46 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:18:46 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:18:46 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:46 INFO - u'jsshell-linux-x86_64.zip'], 18:18:46 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:18:46 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:18:46 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:18:46 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:18:46 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:18:46 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:18:46 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:46 INFO - https://queue.taskcluster.net/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:18:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:18:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:18:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:18:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:18:47 INFO - Downloaded 23758381 bytes. 18:18:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:18:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:18:49 INFO - Return code: 0 18:18:49 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:49 INFO - https://queue.taskcluster.net/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:18:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:18:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:18:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:18:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:18:51 INFO - Downloaded 23758381 bytes. 18:18:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:18:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:18:52 INFO - Return code: 0 18:18: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')]} 18:18:52 INFO - https://queue.taskcluster.net/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:18:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:18:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:18:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:18:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:18:53 INFO - Downloaded 10841097 bytes. 18:18:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:18:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 18:18:53 INFO - Return code: 0 18:18:53 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')]} 18:18:53 INFO - https://queue.taskcluster.net/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:18:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:18:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:18:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:18:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:18:55 INFO - Downloaded 57767448 bytes. 18:18:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:18:55 INFO - mkdir: /builds/slave/test-pgo/properties 18:18:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:18:55 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:18:55 INFO - Contents: 18:18:55 INFO - build_url:https://queue.taskcluster.net/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:18:56 INFO - Running post-action listener: _resource_record_post_action 18:18:56 INFO - Running post-action listener: set_extra_try_arguments 18:18:56 INFO - ##### 18:18:56 INFO - ##### Running populate-webroot step. 18:18:56 INFO - ##### 18:18:56 INFO - Running pre-action listener: _resource_record_pre_action 18:18:56 INFO - Running main action method: populate_webroot 18:18:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:18:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:18:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:18:56 INFO - '--tppagecycles', 18:18:56 INFO - '7'], 18:18:56 INFO - 'tests': ['tsvgm']}}, 18:18:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:18:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:18:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:18:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:18:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:18:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:18:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:56 INFO - 'talos_options': ['--disable-e10s'], 18:18:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:18:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:18:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:56 INFO - 'talos_options': ['--disable-e10s'], 18:18:56 INFO - 'tests': ['damp', 'tps']}, 18:18:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:56 INFO - 'tests': ['damp', 'tps']}, 18:18:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:18:56 INFO - 'tests': ['dromaeo_dom']}, 18:18:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:18:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:18:56 INFO - 'tests': ['a11yr', 18:18:56 INFO - 'ts_paint', 18:18:56 INFO - 'tpaint', 18:18:56 INFO - 'sessionrestore', 18:18:56 INFO - 'sessionrestore_no_auto_restore', 18:18:56 INFO - 'tabpaint']}, 18:18:56 INFO - 'other-e10s': {'tests': ['a11yr', 18:18:56 INFO - 'ts_paint', 18:18:56 INFO - 'tpaint', 18:18:56 INFO - 'sessionrestore', 18:18:56 INFO - 'sessionrestore_no_auto_restore', 18:18:56 INFO - 'tabpaint']}, 18:18:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:18:56 INFO - 'ts_paint', 18:18:56 INFO - 'tpaint', 18:18:56 INFO - 'sessionrestore', 18:18:56 INFO - 'sessionrestore_no_auto_restore', 18:18:56 INFO - 'tabpaint']}, 18:18:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:18:56 INFO - 'ts_paint', 18:18:56 INFO - 'tpaint', 18:18:56 INFO - 'sessionrestore', 18:18:56 INFO - 'sessionrestore_no_auto_restore', 18:18:56 INFO - 'tabpaint']}, 18:18:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:18:56 INFO - 'tests': ['a11yr', 18:18:56 INFO - 'ts_paint', 18:18:56 INFO - 'tpaint', 18:18:56 INFO - 'sessionrestore', 18:18:56 INFO - 'sessionrestore_no_auto_restore', 18:18:56 INFO - 'tabpaint']}, 18:18:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:18:56 INFO - 'tests': ['a11yr', 18:18:56 INFO - 'ts_paint', 18:18:56 INFO - 'tpaint', 18:18:56 INFO - 'sessionrestore', 18:18:56 INFO - 'sessionrestore_no_auto_restore', 18:18:56 INFO - 'tabpaint']}, 18:18:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:18:56 INFO - 'tests': ['tsvgx', 18:18:56 INFO - 'tsvgr_opacity', 18:18:56 INFO - 'tart', 18:18:56 INFO - 'tscrollx', 18:18:56 INFO - 'cart']}, 18:18:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:18:56 INFO - 'tsvgr_opacity', 18:18:56 INFO - 'tart', 18:18:56 INFO - 'tscrollx', 18:18:56 INFO - 'cart']}, 18:18:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:56 INFO - 'talos_options': ['--disable-e10s'], 18:18:56 INFO - 'tests': ['tp5o']}, 18:18:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:56 INFO - 'tests': ['tp5o']}, 18:18:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:56 INFO - 'talos_options': ['--disable-e10s', 18:18:56 INFO - '--xperf_path', 18:18:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:18:56 INFO - 'tests': ['tp5n']}, 18:18:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:56 INFO - 'talos_options': ['--xperf_path', 18:18:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:18:56 INFO - 'tests': ['tp5n']}}, 18:18:56 INFO - 'talos.zip': {'path': '', 18:18:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:18:56 INFO - Running post-action listener: _resource_record_post_action 18:18:56 INFO - ##### 18:18:56 INFO - ##### Running create-virtualenv step. 18:18:56 INFO - ##### 18:18:56 INFO - Running pre-action listener: _resource_record_pre_action 18:18:56 INFO - Running main action method: create_virtualenv 18:18:56 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:18:56 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 18:18:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:18:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:18:56 INFO - Using real prefix '/usr' 18:18:56 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:18:56 INFO - Installing distribute.............................................................................................................................................................................................done. 18:18:58 INFO - Installing pip.................done. 18:18:58 INFO - Return code: 0 18:18:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdda70cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeaa6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea51d0>, '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 0xea8750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea8be0>, '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': '14ef55db36f7623abb31b9cf000001d5-1460248374.820157-664867496', '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 18:18:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 18:18:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:18:58 INFO - Using env: {'DISPLAY': ':0', 18:18:58 INFO - 'HOME': '/home/cltbld', 18:18:58 INFO - 'LANG': 'en_US.UTF-8', 18:18:58 INFO - 'LANGUAGE': 'en_US:en', 18:18:58 INFO - 'LOGNAME': 'cltbld', 18:18:58 INFO - 'MAIL': '/var/mail/cltbld', 18:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:58 INFO - 'MOZ_NO_REMOTE': '1', 18:18:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:58 INFO - 'NO_EM_RESTART': '1', 18:18:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:18:58 INFO - 'PWD': '/builds/slave/test-pgo', 18:18:58 INFO - 'SHELL': '/bin/bash', 18:18:58 INFO - 'SHLVL': '1', 18:18:58 INFO - 'TERM': 'linux', 18:18:58 INFO - 'TMOUT': '86400', 18:18:58 INFO - 'USER': 'cltbld', 18:18:58 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1460248374.820157-664867496', 18:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:58 INFO - '_': '/tools/buildbot/bin/python'} 18:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:59 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 18:18:59 INFO - Cleaning up... 18:18:59 INFO - Return code: 0 18:18:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:18:59 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')]} 18:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:59 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')]} 18:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:59 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 0x7fdda70cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeaa6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea51d0>, '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 0xea8750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea8be0>, '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': '14ef55db36f7623abb31b9cf000001d5-1460248374.820157-664867496', '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 18:18:59 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 18:18:59 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 18:18:59 INFO - Using env: {'DISPLAY': ':0', 18:18:59 INFO - 'HOME': '/home/cltbld', 18:18:59 INFO - 'LANG': 'en_US.UTF-8', 18:18:59 INFO - 'LANGUAGE': 'en_US:en', 18:18:59 INFO - 'LOGNAME': 'cltbld', 18:18:59 INFO - 'MAIL': '/var/mail/cltbld', 18:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:59 INFO - 'MOZ_NO_REMOTE': '1', 18:18:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:59 INFO - 'NO_EM_RESTART': '1', 18:18:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:18:59 INFO - 'PWD': '/builds/slave/test-pgo', 18:18:59 INFO - 'SHELL': '/bin/bash', 18:18:59 INFO - 'SHLVL': '1', 18:18:59 INFO - 'TERM': 'linux', 18:18:59 INFO - 'TMOUT': '86400', 18:18:59 INFO - 'USER': 'cltbld', 18:18:59 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1460248374.820157-664867496', 18:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:59 INFO - '_': '/tools/buildbot/bin/python'} 18:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:59 INFO - Downloading/unpacking psutil>=0.7.1 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:19:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:19:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:19:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:19:01 INFO - Installing collected packages: psutil 18:19:01 INFO - Running setup.py install for psutil 18:19:01 INFO - building 'psutil._psutil_linux' extension 18:19:01 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 18:19:02 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 18:19:03 INFO - building 'psutil._psutil_posix' extension 18:19:03 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 18:19:03 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 18:19:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:19:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:19:03 INFO - Successfully installed psutil 18:19:03 INFO - Cleaning up... 18:19:03 INFO - Return code: 0 18:19:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:19: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')]} 18:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19: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')]} 18:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:03 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 0x7fdda70cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeaa6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea51d0>, '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 0xea8750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea8be0>, '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': '14ef55db36f7623abb31b9cf000001d5-1460248374.820157-664867496', '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 18:19:03 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 18:19:03 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 18:19:03 INFO - Using env: {'DISPLAY': ':0', 18:19:03 INFO - 'HOME': '/home/cltbld', 18:19:03 INFO - 'LANG': 'en_US.UTF-8', 18:19:03 INFO - 'LANGUAGE': 'en_US:en', 18:19:03 INFO - 'LOGNAME': 'cltbld', 18:19:03 INFO - 'MAIL': '/var/mail/cltbld', 18:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:03 INFO - 'MOZ_NO_REMOTE': '1', 18:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:03 INFO - 'NO_EM_RESTART': '1', 18:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:19:03 INFO - 'PWD': '/builds/slave/test-pgo', 18:19:03 INFO - 'SHELL': '/bin/bash', 18:19:03 INFO - 'SHLVL': '1', 18:19:03 INFO - 'TERM': 'linux', 18:19:03 INFO - 'TMOUT': '86400', 18:19:03 INFO - 'USER': 'cltbld', 18:19:03 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1460248374.820157-664867496', 18:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:03 INFO - '_': '/tools/buildbot/bin/python'} 18:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:19:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:19:05 INFO - Installing collected packages: mozsystemmonitor 18:19:05 INFO - Running setup.py install for mozsystemmonitor 18:19:05 INFO - Successfully installed mozsystemmonitor 18:19:05 INFO - Cleaning up... 18:19:05 INFO - Return code: 0 18:19:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:19:05 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')]} 18:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:05 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')]} 18:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:05 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 0x7fdda70cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeaa6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea51d0>, '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 0xea8750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea8be0>, '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': '14ef55db36f7623abb31b9cf000001d5-1460248374.820157-664867496', '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 18:19:05 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 18:19:05 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 18:19:05 INFO - Using env: {'DISPLAY': ':0', 18:19:05 INFO - 'HOME': '/home/cltbld', 18:19:05 INFO - 'LANG': 'en_US.UTF-8', 18:19:05 INFO - 'LANGUAGE': 'en_US:en', 18:19:05 INFO - 'LOGNAME': 'cltbld', 18:19:05 INFO - 'MAIL': '/var/mail/cltbld', 18:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:05 INFO - 'MOZ_NO_REMOTE': '1', 18:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:05 INFO - 'NO_EM_RESTART': '1', 18:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:19:05 INFO - 'PWD': '/builds/slave/test-pgo', 18:19:05 INFO - 'SHELL': '/bin/bash', 18:19:05 INFO - 'SHLVL': '1', 18:19:05 INFO - 'TERM': 'linux', 18:19:05 INFO - 'TMOUT': '86400', 18:19:05 INFO - 'USER': 'cltbld', 18:19:05 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1460248374.820157-664867496', 18:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:05 INFO - '_': '/tools/buildbot/bin/python'} 18:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:05 INFO - Downloading/unpacking blobuploader==1.2.4 18:19: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 18:19: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 18:19: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 18:19: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 18:19: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 18:19: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 18:19:07 INFO - Downloading blobuploader-1.2.4.tar.gz 18:19:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:19:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:19:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:19: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 18:19: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 18:19: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 18:19: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 18:19: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 18:19: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 18:19:08 INFO - Downloading docopt-0.6.1.tar.gz 18:19:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:19:08 INFO - Installing collected packages: blobuploader, requests, docopt 18:19:08 INFO - Running setup.py install for blobuploader 18:19:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:19:08 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:19:08 INFO - Running setup.py install for requests 18:19:08 INFO - Running setup.py install for docopt 18:19:09 INFO - Successfully installed blobuploader requests docopt 18:19:09 INFO - Cleaning up... 18:19:09 INFO - Return code: 0 18:19:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:19:09 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')]} 18:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:09 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')]} 18:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:09 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 0x7fdda70cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeaa6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea51d0>, '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 0xea8750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea8be0>, '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': '14ef55db36f7623abb31b9cf000001d5-1460248374.820157-664867496', '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 18:19:09 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 18:19:09 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 18:19:09 INFO - Using env: {'DISPLAY': ':0', 18:19:09 INFO - 'HOME': '/home/cltbld', 18:19:09 INFO - 'LANG': 'en_US.UTF-8', 18:19:09 INFO - 'LANGUAGE': 'en_US:en', 18:19:09 INFO - 'LOGNAME': 'cltbld', 18:19:09 INFO - 'MAIL': '/var/mail/cltbld', 18:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:09 INFO - 'MOZ_NO_REMOTE': '1', 18:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:09 INFO - 'NO_EM_RESTART': '1', 18:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:19:09 INFO - 'PWD': '/builds/slave/test-pgo', 18:19:09 INFO - 'SHELL': '/bin/bash', 18:19:09 INFO - 'SHLVL': '1', 18:19:09 INFO - 'TERM': 'linux', 18:19:09 INFO - 'TMOUT': '86400', 18:19:09 INFO - 'USER': 'cltbld', 18:19:09 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1460248374.820157-664867496', 18:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:09 INFO - '_': '/tools/buildbot/bin/python'} 18:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:19:09 INFO - Running setup.py (path:/tmp/pip-gXJgaJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:19:09 INFO - Running setup.py (path:/tmp/pip-4E6stB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:19:09 INFO - Running setup.py (path:/tmp/pip-on2fdD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:19:09 INFO - Running setup.py (path:/tmp/pip-et3jI4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:19:09 INFO - Running setup.py (path:/tmp/pip-_sRkrM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:19:09 INFO - Running setup.py (path:/tmp/pip-3PkddQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:19:09 INFO - Running setup.py (path:/tmp/pip-sUYRNM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:19:09 INFO - Running setup.py (path:/tmp/pip-1fAV7M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:19:09 INFO - Running setup.py (path:/tmp/pip-tPjYNT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:19:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:19:09 INFO - Running setup.py (path:/tmp/pip-oArIFF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:19:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:19:10 INFO - Running setup.py (path:/tmp/pip-z9cnod-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:19:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:19:10 INFO - Running setup.py (path:/tmp/pip-3y7jxT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:19:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:19:10 INFO - Running setup.py (path:/tmp/pip-5JdI69-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:19:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:19:10 INFO - Running setup.py (path:/tmp/pip-HFH_Qs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:19:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:19:10 INFO - Running setup.py (path:/tmp/pip-iL8ECP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:19:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:19:10 INFO - Running setup.py (path:/tmp/pip-loLgEx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:19:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:19:10 INFO - Running setup.py (path:/tmp/pip-txjAkZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:19:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:19:10 INFO - Running setup.py install for manifestparser 18:19:10 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:19:10 INFO - Running setup.py install for mozcrash 18:19:10 INFO - Running setup.py install for mozdebug 18:19:10 INFO - Running setup.py install for mozdevice 18:19:10 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:19:10 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:19:10 INFO - Running setup.py install for mozfile 18:19:11 INFO - Running setup.py install for mozhttpd 18:19:11 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:19:11 INFO - Running setup.py install for mozinfo 18:19:11 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:19:11 INFO - Running setup.py install for mozInstall 18:19:11 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:19:11 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:19:11 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:19:11 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:19:11 INFO - Running setup.py install for mozleak 18:19:11 INFO - Running setup.py install for mozlog 18:19:11 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:19:11 INFO - Running setup.py install for moznetwork 18:19:11 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:19:11 INFO - Running setup.py install for mozprocess 18:19:11 INFO - Running setup.py install for mozprofile 18:19:11 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:19:11 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:19:11 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:19:11 INFO - Running setup.py install for mozrunner 18:19:11 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:19:11 INFO - Running setup.py install for mozscreenshot 18:19:12 INFO - Running setup.py install for moztest 18:19:12 INFO - Running setup.py install for mozversion 18:19:12 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:19:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:19:12 INFO - Cleaning up... 18:19:12 INFO - Return code: 0 18:19:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:19:12 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')]} 18:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:12 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')]} 18:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:12 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 0x7fdda70cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeaa6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea51d0>, '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 0xea8750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea8be0>, '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': '14ef55db36f7623abb31b9cf000001d5-1460248374.820157-664867496', '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 18:19:12 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 18:19:12 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 18:19:12 INFO - Using env: {'DISPLAY': ':0', 18:19:12 INFO - 'HOME': '/home/cltbld', 18:19:12 INFO - 'LANG': 'en_US.UTF-8', 18:19:12 INFO - 'LANGUAGE': 'en_US:en', 18:19:12 INFO - 'LOGNAME': 'cltbld', 18:19:12 INFO - 'MAIL': '/var/mail/cltbld', 18:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:12 INFO - 'MOZ_NO_REMOTE': '1', 18:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:12 INFO - 'NO_EM_RESTART': '1', 18:19:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:19:12 INFO - 'PWD': '/builds/slave/test-pgo', 18:19:12 INFO - 'SHELL': '/bin/bash', 18:19:12 INFO - 'SHLVL': '1', 18:19:12 INFO - 'TERM': 'linux', 18:19:12 INFO - 'TMOUT': '86400', 18:19:12 INFO - 'USER': 'cltbld', 18:19:12 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1460248374.820157-664867496', 18:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:12 INFO - '_': '/tools/buildbot/bin/python'} 18:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:19:12 INFO - Running setup.py (path:/tmp/pip-OxA0kq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:19:12 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)) 18:19:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:19:12 INFO - Running setup.py (path:/tmp/pip-QcTxcz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:19:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:19:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:19:12 INFO - Running setup.py (path:/tmp/pip-z6nRA0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:19:12 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)) 18:19:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:19:12 INFO - Running setup.py (path:/tmp/pip-x9ffwG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:19:12 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)) 18:19:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:19:12 INFO - Running setup.py (path:/tmp/pip-E9q4Lf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:19:12 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)) 18:19:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:19:12 INFO - Running setup.py (path:/tmp/pip-oO22gu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:19:12 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)) 18:19:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:19:12 INFO - Running setup.py (path:/tmp/pip-PYKAFw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:19:13 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)) 18:19:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:19:13 INFO - Running setup.py (path:/tmp/pip-GKeDux-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:19:13 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)) 18:19:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:19:13 INFO - Running setup.py (path:/tmp/pip-glcEQA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:19:13 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)) 18:19:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:19:13 INFO - Running setup.py (path:/tmp/pip-e0Tv6t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:19:13 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)) 18:19:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:19:13 INFO - Running setup.py (path:/tmp/pip-xuffdy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:19:13 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)) 18:19:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:19:13 INFO - Running setup.py (path:/tmp/pip-KCvRwg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:19:13 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)) 18:19:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:19:13 INFO - Running setup.py (path:/tmp/pip-xSr81R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:19:13 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)) 18:19:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:19:13 INFO - Running setup.py (path:/tmp/pip-yunAMB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:19:13 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)) 18:19:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:19:13 INFO - Running setup.py (path:/tmp/pip-E7a9Ku-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:19:13 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)) 18:19:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:19:13 INFO - Running setup.py (path:/tmp/pip-YMR3DX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:19:13 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)) 18:19:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:19:13 INFO - Running setup.py (path:/tmp/pip-hsww4L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:19:13 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)) 18:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:19:13 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)) 18:19:13 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)) 18:19:13 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)) 18:19:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:15 INFO - Downloading blessings-1.6.tar.gz 18:19:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:19:15 INFO - Installing collected packages: blessings 18:19:15 INFO - Running setup.py install for blessings 18:19:15 INFO - Successfully installed blessings 18:19:15 INFO - Cleaning up... 18:19:15 INFO - Return code: 0 18:19:15 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:19:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:19:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:19:16 INFO - Reading from file tmpfile_stdout 18:19:16 INFO - Current package versions: 18:19:16 INFO - argparse == 1.2.1 18:19:16 INFO - blessings == 1.6 18:19:16 INFO - blobuploader == 1.2.4 18:19:16 INFO - docopt == 0.6.1 18:19:16 INFO - manifestparser == 1.1 18:19:16 INFO - mozInstall == 1.12 18:19:16 INFO - mozcrash == 0.17 18:19:16 INFO - mozdebug == 0.1 18:19:16 INFO - mozdevice == 0.48 18:19:16 INFO - mozfile == 1.2 18:19:16 INFO - mozhttpd == 0.7 18:19:16 INFO - mozinfo == 0.9 18:19:16 INFO - mozleak == 0.1 18:19:16 INFO - mozlog == 3.1 18:19:16 INFO - moznetwork == 0.27 18:19:16 INFO - mozprocess == 0.22 18:19:16 INFO - mozprofile == 0.28 18:19:16 INFO - mozrunner == 6.11 18:19:16 INFO - mozscreenshot == 0.1 18:19:16 INFO - mozsystemmonitor == 0.0 18:19:16 INFO - moztest == 0.7 18:19:16 INFO - mozversion == 1.4 18:19:16 INFO - psutil == 3.1.1 18:19:16 INFO - requests == 1.2.3 18:19:16 INFO - wsgiref == 0.1.2 18:19:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:19:16 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')]} 18:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:16 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')]} 18:19:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:16 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 0x7fdda70cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeaa6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea51d0>, '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 0xea8750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea8be0>, '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': '14ef55db36f7623abb31b9cf000001d5-1460248374.820157-664867496', '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 18:19:16 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 18:19:16 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 18:19:16 INFO - Using env: {'DISPLAY': ':0', 18:19:16 INFO - 'HOME': '/home/cltbld', 18:19:16 INFO - 'LANG': 'en_US.UTF-8', 18:19:16 INFO - 'LANGUAGE': 'en_US:en', 18:19:16 INFO - 'LOGNAME': 'cltbld', 18:19:16 INFO - 'MAIL': '/var/mail/cltbld', 18:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:16 INFO - 'MOZ_NO_REMOTE': '1', 18:19:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:16 INFO - 'NO_EM_RESTART': '1', 18:19:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:19:16 INFO - 'PWD': '/builds/slave/test-pgo', 18:19:16 INFO - 'SHELL': '/bin/bash', 18:19:16 INFO - 'SHLVL': '1', 18:19:16 INFO - 'TERM': 'linux', 18:19:16 INFO - 'TMOUT': '86400', 18:19:16 INFO - 'USER': 'cltbld', 18:19:16 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1460248374.820157-664867496', 18:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:16 INFO - '_': '/tools/buildbot/bin/python'} 18:19:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:16 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)) 18:19:16 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)) 18:19:16 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)) 18:19:16 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)) 18:19:16 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)) 18:19:16 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)) 18:19:16 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)) 18:19:16 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)) 18:19:16 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)) 18:19:16 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)) 18:19:16 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)) 18:19:16 INFO - Cleaning up... 18:19:16 INFO - Return code: 0 18:19:16 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:19:16 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')]} 18:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:16 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')]} 18:19:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:16 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 0x7fdda70cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeaa6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea51d0>, '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 0xea8750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea8be0>, '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': '14ef55db36f7623abb31b9cf000001d5-1460248374.820157-664867496', '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 18:19:16 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 18:19:16 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 18:19:16 INFO - Using env: {'DISPLAY': ':0', 18:19:16 INFO - 'HOME': '/home/cltbld', 18:19:16 INFO - 'LANG': 'en_US.UTF-8', 18:19:16 INFO - 'LANGUAGE': 'en_US:en', 18:19:16 INFO - 'LOGNAME': 'cltbld', 18:19:16 INFO - 'MAIL': '/var/mail/cltbld', 18:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:16 INFO - 'MOZ_NO_REMOTE': '1', 18:19:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:16 INFO - 'NO_EM_RESTART': '1', 18:19:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:19:16 INFO - 'PWD': '/builds/slave/test-pgo', 18:19:16 INFO - 'SHELL': '/bin/bash', 18:19:16 INFO - 'SHLVL': '1', 18:19:16 INFO - 'TERM': 'linux', 18:19:16 INFO - 'TMOUT': '86400', 18:19:16 INFO - 'USER': 'cltbld', 18:19:16 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1460248374.820157-664867496', 18:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:16 INFO - '_': '/tools/buildbot/bin/python'} 18:19:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:16 INFO - Downloading/unpacking jsonschema 18:19:16 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 18:19:16 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 18:19:16 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 18:19:16 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 18:19:16 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 18:19:16 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 18:19:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:19:18 INFO - Downloading/unpacking functools32 (from jsonschema) 18:19:18 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 18:19:18 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 18:19:18 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 18:19:18 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 18:19:18 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 18:19:18 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 18:19:18 INFO - Downloading functools32-3.2.3-2.tar.gz 18:19:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:19:18 INFO - warning: no files found matching '*.txt' 18:19:18 INFO - no previously-included directories found matching 'build' 18:19:18 INFO - no previously-included directories found matching 'dist' 18:19:18 INFO - no previously-included directories found matching '.git*' 18:19:18 INFO - Installing collected packages: jsonschema, functools32 18:19:18 INFO - Running setup.py install for functools32 18:19:18 INFO - warning: no files found matching '*.txt' 18:19:18 INFO - no previously-included directories found matching 'build' 18:19:18 INFO - no previously-included directories found matching 'dist' 18:19:18 INFO - no previously-included directories found matching '.git*' 18:19:18 INFO - Successfully installed jsonschema functools32 18:19:18 INFO - Cleaning up... 18:19:18 INFO - Return code: 0 18:19:18 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:19:18 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')]} 18:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:18 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')]} 18:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:18 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 0x7fdda70cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeaa6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea51d0>, '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 0xea8750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea8be0>, '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': '14ef55db36f7623abb31b9cf000001d5-1460248374.820157-664867496', '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 18:19:18 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 18:19:18 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 18:19:18 INFO - Using env: {'DISPLAY': ':0', 18:19:18 INFO - 'HOME': '/home/cltbld', 18:19:18 INFO - 'LANG': 'en_US.UTF-8', 18:19:18 INFO - 'LANGUAGE': 'en_US:en', 18:19:18 INFO - 'LOGNAME': 'cltbld', 18:19:18 INFO - 'MAIL': '/var/mail/cltbld', 18:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:18 INFO - 'MOZ_NO_REMOTE': '1', 18:19:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:18 INFO - 'NO_EM_RESTART': '1', 18:19:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:19:18 INFO - 'PWD': '/builds/slave/test-pgo', 18:19:18 INFO - 'SHELL': '/bin/bash', 18:19:18 INFO - 'SHLVL': '1', 18:19:18 INFO - 'TERM': 'linux', 18:19:18 INFO - 'TMOUT': '86400', 18:19:18 INFO - 'USER': 'cltbld', 18:19:18 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1460248374.820157-664867496', 18:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:18 INFO - '_': '/tools/buildbot/bin/python'} 18:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:19 INFO - Downloading/unpacking flake8 18:19:19 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 18:19:19 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 18:19:19 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 18:19:19 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 18:19:19 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 18:19:19 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 18:19:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:19:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:19:21 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 18:19:21 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 18:19:21 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 18:19:21 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 18:19:21 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 18:19:21 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 18:19:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:19:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:19:21 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 18:19:21 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 18:19:21 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 18:19:21 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 18:19:21 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 18:19:21 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 18:19:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:19:21 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 18:19:21 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 18:19:21 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 18:19:21 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 18:19:21 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 18:19:21 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 18:19:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:19:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:19:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:19:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:19:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:19:21 INFO - no previously-included directories found matching 'docs/_build' 18:19:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:19:21 INFO - Running setup.py install for pep8 18:19:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:19:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:19:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:19:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:19:21 INFO - no previously-included directories found matching 'docs/_build' 18:19:21 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:19:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:19:21 INFO - Cleaning up... 18:19:21 INFO - Return code: 0 18:19:21 INFO - Running post-action listener: _resource_record_post_action 18:19:21 INFO - Running post-action listener: _start_resource_monitoring 18:19:22 INFO - Starting resource monitoring. 18:19:22 INFO - ##### 18:19:22 INFO - ##### Running install step. 18:19:22 INFO - ##### 18:19:22 INFO - Running pre-action listener: _resource_record_pre_action 18:19:22 INFO - Running main action method: install 18:19:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:19:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:19:22 INFO - Reading from file tmpfile_stdout 18:19:22 INFO - Detecting whether we're running mozinstall >=1.0... 18:19:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:19:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:19:22 INFO - Reading from file tmpfile_stdout 18:19:22 INFO - Output received: 18:19:22 INFO - Usage: mozinstall [options] installer 18:19:22 INFO - Options: 18:19:22 INFO - -h, --help show this help message and exit 18:19:22 INFO - -d DEST, --destination=DEST 18:19:22 INFO - Directory to install application into. [default: 18:19:22 INFO - "/builds/slave/test-pgo"] 18:19:22 INFO - --app=APP Application being installed. [default: firefox] 18:19:22 INFO - mkdir: /builds/slave/test-pgo/build/application 18:19:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 18:19:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 18:19:38 INFO - Reading from file tmpfile_stdout 18:19:38 INFO - Output received: 18:19:38 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:19:38 INFO - Running post-action listener: _resource_record_post_action 18:19:38 INFO - ##### 18:19:38 INFO - ##### Running run-tests step. 18:19:38 INFO - ##### 18:19:38 INFO - Running pre-action listener: _resource_record_pre_action 18:19:38 INFO - Running main action method: run_tests 18:19:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:19:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:19:38 INFO - Python 2.7.3 18:19:38 INFO - Return code: 0 18:19:38 INFO - grabbing minidump binary from tooltool 18:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:38 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 0xea51d0>, '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 0xea8750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea8be0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:19:38 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 18:19:38 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 18:19:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:19:38 INFO - Return code: 0 18:19:38 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:19:38 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:19:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:19:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:19:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:19:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:19:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:19:39 INFO - Return code: 0 18:19:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 18:19:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 18:19:39 INFO - Using env: {'DISPLAY': ':0', 18:19:39 INFO - 'HOME': '/home/cltbld', 18:19:39 INFO - 'LANG': 'en_US.UTF-8', 18:19:39 INFO - 'LANGUAGE': 'en_US:en', 18:19:39 INFO - 'LOGNAME': 'cltbld', 18:19:39 INFO - 'MAIL': '/var/mail/cltbld', 18:19:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:19:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:19:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:39 INFO - 'MOZ_NO_REMOTE': '1', 18:19:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:19:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:39 INFO - 'NO_EM_RESTART': '1', 18:19:39 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:19:39 INFO - 'PWD': '/builds/slave/test-pgo', 18:19:39 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:19:39 INFO - 'SHELL': '/bin/bash', 18:19:39 INFO - 'SHLVL': '1', 18:19:39 INFO - 'TERM': 'linux', 18:19:39 INFO - 'TMOUT': '86400', 18:19:39 INFO - 'USER': 'cltbld', 18:19:39 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1460248374.820157-664867496', 18:19:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:39 INFO - '_': '/tools/buildbot/bin/python'} 18:19:39 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:19:40 INFO - mozversion application_buildid: 20160409133023 18:19:40 INFO - mozversion application_changeset: d62963756d9a9d19cbbb5d8f3dd3c7cfa8fdef88 18:19:40 INFO - mozversion application_display_name: Nightly 18:19:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:19:40 INFO - mozversion application_name: Firefox 18:19:40 INFO - mozversion application_remotingname: firefox 18:19:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:19:40 INFO - mozversion application_vendor: Mozilla 18:19:40 INFO - mozversion application_version: 48.0a1 18:19:40 INFO - mozversion platform_buildid: 20160409133023 18:19:40 INFO - mozversion platform_changeset: d62963756d9a9d19cbbb5d8f3dd3c7cfa8fdef88 18:19:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:19:40 INFO - mozversion platform_version: 48.0a1 18:19:40 INFO - using testdate: 1460251180 18:19:40 INFO - actual date: 1460251180 18:19:40 INFO - starting webserver on 'localhost:54596' 18:19:40 INFO - SUITE-START | Running 2 tests 18:19:40 INFO - TEST-START | dromaeo_css 18:19:40 INFO - operating with platform_type : linux_ 18:19:40 INFO - Initialising browser for dromaeo_css test... 18:19:40 INFO - TEST-INFO | started process 3289 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpr4qBAo/profile http://localhost:54596/getInfo.html) 18:19:45 INFO - PROCESS | 3289 | __metrics Screen width/height:1600/1200 18:19:45 INFO - PROCESS | 3289 | colorDepth:24 18:19:45 INFO - PROCESS | 3289 | Browser inner width/height: 1024/697 18:19:45 INFO - PROCESS | 3289 | __metrics 18:19:46 ERROR - PROCESS | 3289 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:19:47 INFO - TEST-INFO | 3289: exit 0 18:19:47 INFO - Browser initialized. 18:19:47 INFO - Running cycle 1/1 for dromaeo_css test... 18:19:47 INFO - TEST-INFO | started process 3370 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpr4qBAo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:19:59 INFO - PROCESS | 3370 | RSS: Main: 152494080 18:19:59 INFO - PROCESS | 3370 | 18:20:50 INFO - PROCESS | 3370 | 1460251250349 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] 18:22:58 INFO - PROCESS | 3370 | Cycle 1(1): loaded http://localhost:54596/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54596/tests/dromaeo/cssquery-ext.html) 18:22:59 INFO - PROCESS | 3370 | RSS: Main: 258277376 18:22:59 INFO - PROCESS | 3370 | 18:26:01 INFO - PROCESS | 3370 | Cycle 1(1): loaded http://localhost:54596/tests/dromaeo/cssquery-ext.html (next: http://localhost:54596/tests/dromaeo/cssquery-jquery.html) 18:26:02 INFO - PROCESS | 3370 | RSS: Main: 229646336 18:26:02 INFO - PROCESS | 3370 | 18:29:04 INFO - PROCESS | 3370 | Cycle 1(1): loaded http://localhost:54596/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54596/tests/dromaeo/cssquery-mootools.html) 18:29:04 INFO - PROCESS | 3370 | RSS: Main: 234225664 18:29:04 INFO - PROCESS | 3370 | 18:32:06 INFO - PROCESS | 3370 | Cycle 1(1): loaded http://localhost:54596/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54596/tests/dromaeo/cssquery-prototype.html) 18:32:07 INFO - PROCESS | 3370 | RSS: Main: 219938816 18:32:07 INFO - PROCESS | 3370 | 18:35:09 INFO - PROCESS | 3370 | Cycle 1(1): loaded http://localhost:54596/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54596/tests/dromaeo/cssquery-yui.html) 18:35:10 INFO - PROCESS | 3370 | RSS: Main: 217710592 18:35:10 INFO - PROCESS | 3370 | 18:38:12 INFO - PROCESS | 3370 | Cycle 1(1): loaded http://localhost:54596/tests/dromaeo/cssquery-yui.html (next: http://localhost:54596/tests/dromaeo/cssquery-dojo.html) 18:38:13 INFO - PROCESS | 3370 | RSS: Main: 291373056 18:38:13 INFO - PROCESS | 3370 | 18:38:13 INFO - PROCESS | 3370 | __start_tp_report 18:38:13 INFO - PROCESS | 3370 | _x_x_mozilla_page_load 18:38:13 INFO - PROCESS | 3370 | _x_x_mozilla_page_load_details 18:38:13 INFO - PROCESS | 3370 | |i|pagename|runs| 18:38:13 INFO - PROCESS | 3370 | |0;dojo.html;3097.9535306970383;3115.688431156884;3123.5470856725774;3125.031240315501;3161.509965955277;5272.472752724735;5350.678959262447;5351.491608297215;5422.783088676453;5456.045192091378;5350.3312085989255;5362.597805164609;5367.409584945663;5398.6220964532495;5445.992491389095;4818.927716084261;4861.562459378664;4909.140900342426;4954.355933728611;4962.1812400953795;4880.926786098212;4899.534544218293;4921.532454416824;4939.43196532398;4960.950390496085;4814.109389762905;4860.635452341071;4894.4371397289415;4894.681845680019;4954.950450495503;4862.100511405401;4865.148598995162;4869.732164730938;4872.78072486739;4914.066327397819;4664.813407463697;4813.181759100926;4834.178189707758;4834.323194752737;4852.4662287148385;5208.66143700662;5210.244514545408;5220.973895130538;5230.450802665703;5247.947520524822;5639.68981706006;5646.971765141189;5653.123765816264;5654.038813401731;5655.4910058094965;5685.971570142165;5686.800961966312;5687.573431992617;5804.738786754606;5882.941170588282;5326.840194794162;5349.277847490578;5358.410574836765;5358.65168764033;5358.892822143535;5805.506531944748;5819.6508209507565;5829.154772557956;5831.62094463867;5832.300123985149;5562.721863906789;5589.189567512769;5606.439356064442;5629.521490673339;5654.830355089354;5673.914891276634;5688.601797874192;5689.6586204827845;5702.344230413472;5708.65748055118;5628.802991895346;5636.60543761941;5645.745941432645;5645.802396916089;5646.689432081275;5546.69493177871;5627.184058311522;5647.802326918538;5648.491635752802;5699.031164702011;4347.760873151944;4363.563643635611;4370.453693288339;4381.452318460192;4411.691181617256;3823.4647149399107;3883.0874744435037;3917.05990562263;3932.4494570760116;3961.485006949078;5388.568914486832;5389.218563308376;5400.054990376669;5419.376771671229;5460;5610.438956104357;5630.5214056805635;5631.549476041907;5634.802781902696;5646.661200327993;5291.497307755757;5325.041492531304;5341.86645333862;5354.9196762048605;5394.78420863161;4762.666613337033;4799.328094066834;4806.735629540409;4814.927776083362;4845.370101886732;5870.765169393177;5871.735771890275;5872.706364681834;5885.676287804212;5913.9112913306335;5489.39616642177;5656.123300888369;5665.405132461197;5667.291588551431;5743.253377061123;5988.580799344179;6000;6007.459328660441;6014.188084608697;6021.7591296347655;5695.715214239354;5702.714864256687;5711.914321285101;5723.313202415737;5726.828195154152;5685.829425117087;5767.884642307215;5780.710964451845;5857.677827719346;5873.3832947539895;5610.943890561042;5619.943800561942;5621.269234999424;5624.268845050117;5624.521915637053;5549.1676248563035;5563.082091454865;5594.748236329294;5604.019296623156;5604.159376093618;5272.947270527399;5494;5530.778768849201;5537.9169312459535;5583.916241256303;5601.579881508985;5606.074997625346;5613.719314034363;5639.8590035249445;5649.4633009864;5346.278252435872;5502.642328248651;5516.972415137899;5521.641093328921;5521.806736764194 18:38:13 INFO - PROCESS | 3370 | |1;ext.html;600.8738164985352;636.5321488705804;649.3441623959799;649.6297110646933;661.738613247767;28783.85608071962;35855.64144358559;36488.81755591218;36559.63440365595;36655.26689466209;39533.80233098831;40032.199356012934;40064.59935400645;40106.7994660027;40133;8433.3674974377;8616.612252448624;8622;8623.094575069621;8624.913750862504;8390.706325278616;8506.532140732257;8512.829743405127;8514.318854491657;8516.489010659381;8501.19238672325;8702.30381569473;8710.259627931633;8714.477131372138;8739.431936924111;8637.179467950535;8680.34897382699;8685.565721713952;8687.435316704426;8687.56562171892;8513.446625969354;8616.827663446697;8620.65517379304;8622.698205562838;8632;39587.60412395868;39733.205335893406;39967;39996.40005399921;40067.59932400697;3320.3857286402094;3443.3974054540354;3460.809655468948;3689.4650275709873;3939.645431911113;30053;30770.53844192339;31068;31148.844255778575;31180.220494487592;4152.501699796014;4261.382099595541;4304.096139810644;4341.327094300357;4341.327094300388;193249;193673;195598;196167;196344;49820.750896245285;50148.24777628339;50314;50407.74796126069;50510;54147;54504.727476362365;55509;62495.375046248955;64179.35820641827;15680.843191568167;15857.444989425545;15927.124008179662;15942.202889855693;15949.362025519082;12523.060770442253;12668.80996785049;12689.111762176744;12696.555620553421;12702.745945081047;17061.914690426718;18213.089345532935;18929;19354.32259870926;19572.314968976018;7126.821829454305;7375.926240737631;7411.370033547209;7412.369948554326;7480.438967077491;982.219135787051;1074.355386767933;1086.8642268829092;1097.9066779323687;1114.788190243851;30612.693873060984;31851.20371990719;31965.20086997844;32390.514142287884;32550.186245344055;1077.5312738958578;1102.7132945434084;1129.4860838318546;1180.6103985684704;1206.3124019309084;17559.561010974827;18141.63716725658;18199.909000455176;18371.81628183701;18452.90773546124;543894;554568;556963;559380;559675;53944.190837137474;55041.72479137579;55495.16757248645;55505.44494555084;55554.16668749972;1264.2414551269164;1297.4291311822956;1298.6169080121576;1338.631876234024;1405.1849927042495;21043.89478052661;29453.263668407602;29621.407571848013;29857.402851942406;29884.252893677833;48154.51845481501;48582.75708621434;48596;48774;48818.75590622024;270318;276858;277337;278208;279012;33563.66436335605;39109.608903910594;39219.41170882382;39940;40920.795396022826;43061.56938430575;43279.78360108179;43502.78248608863;43523;44396.77801610971;33845.83077084697;35635.46546801852;37184.6281537192;37410.064748381505;37484.81257593694;39449.40825887556;40470.392944106454;40661.98345041398;40701.38947915843;41211;40234.195316092926;40652.39021414622;41603.58396416118;41763.582364177186;41902.79048604737;33416.66583334136;35551.11122221965;35632;35706.821465892506;35765.82117089398;27237.86381068082;27889.16332510028;28219;28219.15342539727;28269.858650706614 18:38:13 INFO - PROCESS | 3370 | |2;jquery.html;394.8104909643372;399.93201155803513;400.0678419283071;406.21600311399;411.53291014698306;14039.578812635611;15401.614959626015;17463.912680436595;18103.366382176628;18119.18463669135;13720.862791372083;16948.237329320178;17219.397321093766;17224.741628875578;17327.22027508762;5412.702301373423;5512.80705175319;5633.830985070434;5634.521065709419;5639.15412688096;4067.9186416271805;5395.568354531648;5588.189712491686;5615.66306021638;6000.399960003986;6220.409061139208;6245.437910588046;6262.185915830935;6264.59280146789;6271.216097987752;6070.57505974582;6166.383361663842;6219.440250377443;6220.626762394271;6240.157578726859;5455.890882182373;5462.317210348707;5464.398916119224;5468.425815289417;5471.945280547184;20081.497962551053;20512.179512819468;21639.134434622596;21690.783092169033;21888.562228755334;2281.9885900570557;2536.8351057181226;3031.8484075796123;3074.2775447769754;3093.8453077346044;8853.955730221373;9111.635534578609;9474.952625236898;9564.234861211156;13436.19382837033;1870.9719354209699;1969.8673262873906;1986.652335841222;2009.889456079915;2023.3929821053625;74993.62503187504;78244;78403;78406.6079669598;78445.99999999943;9753.414795112316;9797.461139637246;9896.950515247378;9908.653197138066;10254.43600601959;13249.536266230829;13250.602481925558;13283.535076272285;13288.3355832208;13300;7143.1428228612895;7209.279072092749;7359.889601655979;7542.680030994664;7625;7464.552126872405;7530.209328020588;7587.544747315179;7631.465797394129;7631.580263085472;4506.3465797459185;4541.500434952152;4561.312314443677;4626.699264547794;4663.533646635377;1884.8680592358678;1894.1192345559105;1899.6729006966355;1910.4334445754625;1949.9805001950083;851.5742128935532;938.2306508662831;1010.7169992402139;1075.887031861659;1092.404639471474;16938.547039302666;17180.828191718174;17560.38538651141;18071.457856264333;18199.27202911895;898.6899519665704;944.6693657220055;950.6862735297335;1035.53400969564;1037.227265687068;9494.905050949403;9606.903930960741;10085.394876307446;10127.64553240633;10273.332233404804;460609;465726;471692;479502;480511;86361;87453;87906;88175.55912220526;88207.55896220478;983.3165949664914;984.9556769945369;986.2110311750571;1000.5297510170209;1020.3877673395903;15651.686966260839;15754.842451575796;15757;15769.526914192593;16233.837661623233;35938.64061359457;36425.45361819522;36587.26825463529;38043;38230.42654360131;46523.83690407767;53874.767513949286;54255;54417.45582544124;54560.454395455534;7981.3614910808155;8090.190980902098;8100.918990810016;8464.703735369232;8497.277731392654;12080.75838483208;12263;12369.204424399994;12676.936615316865;12847.421866015864;10754.892451075702;11138.832917506083;11154.386508742096;11248.550057997916;11348.602798901999;10832.945835270773;11084.944575277395;11098;11101.722456938642;11107.833382499108;11046.226764126433;11131.387773672202;11476.713082173012;11506.252093614223;11558.30650160993;7985.960070199611;8081.272685458337;8150.55794591937;8421.115782842713;8457.365697572584;9599.280053996117;10630.946845265724;10791.730206744895;10927.945360273148;10956.890431095588 18:38:13 INFO - PROCESS | 3370 | |3;mootools.html;1215.1068964311223;1486.4574430332927;1529.9082055076697;1655.1310561954979;1835.6787562176623;7340.339369456748;8161.3062889654375;8358.289545388649;8377.078521362646;8379.874301885477;8046.557439340834;8186.836263274731;8191.344692424606;8201.097879233295;8211.425200235972;2011.115109351888;2060.979390206101;2286.6455699366625;2359.304005318435;2384.415818124562;2333.311673056444;2354.3290162303747;2356.7761062699014;2357.281029286067;2360.1503458754833;2304.827137964651;2325.8604483730946;2329.0218108394515;2353.411647088228;2357.917472888449;2288.7139107611547;2305.4697419593504;2310.9422264443438;2313.7570555091643;2338.4621537046405;2295.827812914038;2310.1106074161403;2311.711036120485;2312.456572705413;2316.328264803205;8234.505929644241;8287.171282871725;8288.875666865002;8289.917100829036;8290.336773058141;4986.376702912136;5169.612279079047;5169.844904652867;5181.974090129525;5208.479152084799;3325.201951531639;3358.1436733633013;3366.848491817874;3377.662233776627;3436.0722604896787;1123.662901129666;1125.5779082843933;1135.9943200284029;1142.029275116153;1153.8846115388394;11373.147013973985;11374.090072794157;11374.886251137465;11403.486843092081;11411;4356.237658409766;4471.821127154877;4495.2582823834355;4664.043871006435;4752.714837109785;9569.3779904306;9601.423914565148;9619.893712223184;9632.422054676741;9636.71089867305;5072.264521644341;5086.9745651271505;5088.211327244283;5105.183170692746;5109.463506331856;4301;4648.907021859543;4687.95312046882;4773.0453909218295;4780.760961951958;3915.588863169326;3991.560928297885;3999.460072890181;4050.1697152084344;4073.5315438724333;1301.622529466463;1314.493919840868;1315.7631626307166;1325.1982550556775;1331.2345401394043;1351.7026254224054;1382.377929931535;1385.5427708856053;1428.0931608428723;1442.2428225181654;7888.2506161914525;7943.880841787378;7959.164287749819;7976.242256985577;7979.68081276754;491.11599121581014;501.29567957020447;501.8218532420938;502.54017573920186;507.3556583139392;6168;6273.12176295319;6314.747410103636;6321.146645202931;6340.175777149033;9392.671256506126;10018.849717254247;10034.498275086216;10110.898891011142;10210.336328138796;9929.950350248202;10053.849192262122;10098.899011009942;10105.696829094992;10160.390376577428;7647.617619119022;7728.729494467667;7732.729354472679;7743.457957943003;7819.726309579138;7578.621068946641;7724.111727151225;7781.610919453891;7796.10344810354;7830.530168189927;9154.130357616015;9292.58183381736;9329.207017403596;9370.34407591462;9398.154166125081;9353.766155846159;9516.095970882756;9668.75828104303;9724.27067969891;9738.853917191389;6720.798376048726;7201.891971620325;7206.315400036988;7293.890591641236;7403.851922961403;8148.511089334659;8172.877406838783;8174.386920980831;8185.672573097009;8222.547759873025;6897.7585784497305;6970.128733908262;7034.929650703632;7080.929190708027;7167.1757747859665;7315.30504602062;7318.524295920748;7375.188729239887;7409.555426674417;7410.147832999059;7667;7744.380449564134;7745.186755390603;7752.7674169775;7754.728584499516;6783.864322713617;6813.080234168324;6822.795316140524;6860.108185935796;6861.485388595976;6984.79045628632;7051.612161331176;7066.646667666493;7075.150981882207;7077.115360579927 18:38:13 INFO - PROCESS | 3370 | |4;prototype.html;329.39720311829353;332.5477350802909;334.74559334905473;338.5311343788853;341.0892915914508;5575.275214222151;5597.496225339719;5603.4956853883095;5617.325920889494;5636.15457681348;5529.944700552994;5531.751071201796;5535.612507124503;5546.975353995793;5551.77792888284;3945.60543945606;4107.589241075899;4249.787510624456;4315.848945286915;4318.4817821861425;4261.829526818923;4299.505556860954;4311.935320970188;4326.113146804897;4339.218940590692;4304.784760761965;4313.309870420733;4316;4324.07032488015;4338.305871060631;4074.449949256857;4175.45508161982;4302.311630139163;4307.095509942916;4313.741175529447;3789.5263092113487;3791.241751649681;3794.354959656865;3802.7147963902817;3812.4853144825647;5348.304720386363;5351.625386222966;5356.54469370104;5377.569794416477;5393.301110150329;4846.927296090562;4950.2822090796635;4962.87592810179;4968.30443737877;4982.60139188864;5806.65160090396;5813.651180929158;5813.912791308134;5828.591998560102;5843.328017277982;4181.351890456984;4183.435236243099;4194.622483976426;4198.6221240088535;4208.915821683579;5785.971070144622;5879.735411906475;5929.377415371367;6062.393760623946;6105.664188469633;4281.507626622916;4284.3145096784365;4284.8500302489265;4286.314189729628;4296.849610263625;4293.549177336397;4335.1329734053315;4353.542877997828;4359.149965756647;4365.759883206454;4850.369451971221;4864.257314458578;4931.457539670633;4934.605231581537;4962.751862406865;5850.765969361263;5874.882502350015;5881.147233651097;5890.204822348928;5890.617109887844;1485.90341627796;1502.241368109098;1505.427937383809;1511.3199060422853;1514.4245186829155;995.2535598301274;1032.5714828346302;1035.5495359518634;1041.890601486848;1050.5902697947806;5615.6630602164005;5670.262865827499;5672.205891175238;5675.177099320658;5692.544596432275;6026.5178785697035;6034.24571928509;6037.849053773691;6060.121282414026;6062.333143354227;5487;5668;5675.801346952837;5695.800646977336;5718;3208.7646256191533;3213.839308034589;3214.694604012615;3227.2093337132083;3238.5304130900886;6045.6070355426755;6221.906671399933;6230.501559875199;6244.531660125509;6253.812385628438;6150.077488376779;6151.108089327112;6156.29202641693;6173.629582225081;6175.320714721377;6191.288001879751;6195.19462469885;6222.439980401695;6236.18929539157;6238.500919926486;5818.301803783404;6029.306629737461;6032.426919442646;6035.879282414415;6041.848953776191;5938.465538101592;5950.702464876652;5960.225170727777;5961.523078153824;5991.820245392645;5964.493018093511;6040.879182416415;6259.092431597484;6278.497720182466;6306.1801965746;4295.806688698954;4308.46144231971;4326.545712700247;4334.349847522897;4335.3063509838275;5908.438698323653;6084.421979911901;6088.726007329769;6088.969555152196;6103.145559621746;5852.94147058524;5902.144189092472;5910.202122713551;5915.615484993462;5925.851853703692;5892.616979896465;5893.823185304448;5898.380670029756;5929.436703513159;5953.166556681981;5707.315122185364;5843.912341314799;5850.561207909509;5851.531877449709;5854.619449735754;5870.471657550841;5875.206847075761;5883.382244864228;5904.793332233351;5914.172015917689;5576.749046292845;5813.098969659541;5826.184334193132;5832.9708351457975;5876.08920617305 18:38:13 INFO - PROCESS | 3370 | |5;yui.html;796.0884786918978;821.7781199076253;826.4586695714305;832.2717622080679;843.5149788871397;15381.692366152683;15872.920635396837;15961.99999999997;15994.040357578539;16000.679986400264;14879.40482380706;14928;14969.625759356022;15007.624809379771;15063.246837658127;664.8570557330173;792.8136887831383;803.3252068262673;814.3485211830541;819.635262308273;817.3257062923083;817.4441379861692;821.6097353756977;822.235321151329;823.2960818500186;844.5734903873536;848;849.732334314692;851.216880469966;851.3529717414748;676.905233267343;816.102287483769;832.1096426823301;832.7626626411444;845.4124383553433;604.0787798607115;606.2543072021439;606.2876120558326;606.3572613030158;606.5481216493696;14190.716185676332;14247.145171289756;14254.714905701932;14303.141811491343;14311.35598898052;13315.600531984055;13478.595642130751;13616.727665446735;13631.18212907219;13632.113912595749;11354.26197297173;11371.829422558669;11522.481488333045;11585.304881707125;11628.418579071013;3786.848526058954;3812.7521711088966;3853.402722577977;3857.961420385788;3898.5126859142606;51160.74419627915;51234.48765512335;53202;53245.73377133128;53443.73278133584;10379.221558383151;10403.32378395417;10543.31468454548;10684.839727404094;10865.45672716361;18479.260829566665;18703.34538291153;18704.438866834018;18717.625647486973;18738.906305468387;8196.262336389753;8314.127016663284;8543.658253669908;8600.698975535952;8725.432846864933;4597.770111494412;4609.124266389443;4681.204195286809;4728.40894888139;4794.256890182028;3243.0757234188613;3243.221626809596;3281.6554261802166;3285.4743241081314;3306.5205545195813;607.1166452811149;609.9237595300588;615.6183166436748;625.3652542669195;625.43710660406;723.616483263871;734.1630541183056;739.8557281330196;755.3277582951177;760.3347071312602;8569.614367353359;8767.868481972775;8917.680644420694;9076.954615226881;9190;560.6131769079403;631.9368063193643;690.1890278922247;707.738136889344;739.4988174006775;4104.610062044101;4238.660907127422;4241.427407299975;4275.273203555403;4305.289627211475;57144.71427642835;57372.71313643405;57495.712521437126;57791.422085778606;58210.126848097316;47316;47954.520454795704;49813.25280120801;50160.498395016315;51791.7410412953;46929.29606055912;46963.29555056677;47429.5257047432;47452;47511.04977900423;7879.684812607661;8284.46151000183;8424.452410593292;8475.830483390175;8615.138486151334;32607.836960815042;32767.836160819043;32936.176595585304;33189.50215746718;33613.495797562566;39951.80024099861;41006.79496602498;42552.57447425486;42917.78541107274;43642.78178609087;10561.41912194806;10622.946885265525;10647.30792498485;10707.0898973585;10934.507947142238;11075.778484430428;11398.715032124263;11536.82694759596;11586.594469193538;13416.463341466622;12617.179883307555;12775.80836287475;12813;13079.149855259378;13533.390997405337;12600.810987835006;13108;13115.08194426381;13126.40931158081;13153.21080735159;10553.63062292816;10561.260711750103;10577.682669519927;10706.732331691459;11073.390963497084;10111.898881011095;10318.638847640297;10405.323653962469;10599.47002649849;10630.8936910633;10607.363558186225;10716.249862509549;10736.141108711128;10893.782124357627;10899.673009809718 18:38:13 INFO - PROCESS | 3370 | __end_tp_report 18:38:13 INFO - PROCESS | 3370 | __start_cc_report 18:38:13 INFO - PROCESS | 3370 | _x_x_mozilla_cycle_collect,881 18:38:13 INFO - PROCESS | 3370 | __end_cc_report 18:38:13 INFO - PROCESS | 3370 | __startTimestamp1460252293146__endTimestamp 18:38:13 INFO - PROCESS | 3370 | 18:38:13 INFO - PROCESS | 3370 | ------- Summary: start ------- 18:38:13 INFO - PROCESS | 3370 | Number of tests: 6 18:38:13 INFO - PROCESS | 3370 | 18:38:13 INFO - PROCESS | 3370 | [#0] dojo.html Cycles:165 Average:5301.02 Median:5521.81 stddev:597.08 (10.8%) stddev-sans-first:573.35 18:38:13 INFO - PROCESS | 3370 | Values: 3098.0 3115.7 3123.5 3125.0 3161.5 5272.5 5350.7 5351.5 5422.8 5456.0 5350.3 5362.6 5367.4 5398.6 5446.0 4818.9 4861.6 4909.1 4954.4 4962.2 4880.9 4899.5 4921.5 4939.4 4961.0 4814.1 4860.6 4894.4 4894.7 4955.0 4862.1 4865.1 4869.7 4872.8 4914.1 4664.8 4813.2 4834.2 4834.3 4852.5 5208.7 5210.2 5221.0 5230.5 5247.9 5639.7 5647.0 5653.1 5654.0 5655.5 5686.0 5686.8 5687.6 5804.7 5882.9 5326.8 5349.3 5358.4 5358.7 5358.9 5805.5 5819.7 5829.2 5831.6 5832.3 5562.7 5589.2 5606.4 5629.5 5654.8 5673.9 5688.6 5689.7 5702.3 5708.7 5628.8 5636.6 5645.7 5645.8 5646.7 5546.7 5627.2 5647.8 5648.5 5699.0 4347.8 4363.6 4370.5 4381.5 4411.7 3823.5 3883.1 3917.1 3932.4 3961.5 5388.6 5389.2 5400.1 5419.4 5460.0 5610.4 5630.5 5631.5 5634.8 5646.7 5291.5 5325.0 5341.9 5354.9 5394.8 4762.7 4799.3 4806.7 4814.9 4845.4 5870.8 5871.7 5872.7 5885.7 5913.9 5489.4 5656.1 5665.4 5667.3 5743.3 5988.6 6000.0 6007.5 6014.2 6021.8 5695.7 5702.7 5711.9 5723.3 5726.8 5685.8 5767.9 5780.7 5857.7 5873.4 5610.9 5619.9 5621.3 5624.3 5624.5 5549.2 5563.1 5594.7 5604.0 5604.2 5272.9 5494.0 5530.8 5537.9 5583.9 5601.6 5606.1 5613.7 5639.9 5649.5 5346.3 5502.6 5517.0 5521.6 5521.8 18:38:13 INFO - PROCESS | 3370 | 18:38:13 INFO - PROCESS | 3370 | [#1] ext.html Cycles:180 Average:50966.23 Median:39836.60 stddev:100134.01 (251.4%) stddev-sans-first:100343.51 18:38:13 INFO - PROCESS | 3370 | Values: 600.9 636.5 649.3 649.6 661.7 28783.9 35855.6 36488.8 36559.6 36655.3 39533.8 40032.2 40064.6 40106.8 40133.0 8433.4 8616.6 8622.0 8623.1 8624.9 8390.7 8506.5 8512.8 8514.3 8516.5 8501.2 8702.3 8710.3 8714.5 8739.4 8637.2 8680.3 8685.6 8687.4 8687.6 8513.4 8616.8 8620.7 8622.7 8632.0 39587.6 39733.2 39967.0 39996.4 40067.6 3320.4 3443.4 3460.8 3689.5 3939.6 30053.0 30770.5 31068.0 31148.8 31180.2 4152.5 4261.4 4304.1 4341.3 4341.3 193249.0 193673.0 195598.0 196167.0 196344.0 49820.8 50148.2 50314.0 50407.7 50510.0 54147.0 54504.7 55509.0 62495.4 64179.4 15680.8 15857.4 15927.1 15942.2 15949.4 12523.1 12668.8 12689.1 12696.6 12702.7 17061.9 18213.1 18929.0 19354.3 19572.3 7126.8 7375.9 7411.4 7412.4 7480.4 982.2 1074.4 1086.9 1097.9 1114.8 30612.7 31851.2 31965.2 32390.5 32550.2 1077.5 1102.7 1129.5 1180.6 1206.3 17559.6 18141.6 18199.9 18371.8 18452.9 543894.0 554568.0 556963.0 559380.0 559675.0 53944.2 55041.7 55495.2 55505.4 55554.2 1264.2 1297.4 1298.6 1338.6 1405.2 21043.9 29453.3 29621.4 29857.4 29884.3 48154.5 48582.8 48596.0 48774.0 48818.8 270318.0 276858.0 277337.0 278208.0 279012.0 33563.7 39109.6 39219.4 39940.0 40920.8 43061.6 43279.8 43502.8 43523.0 44396.8 33845.8 35635.5 37184.6 37410.1 37484.8 39449.4 40470.4 40662.0 40701.4 41211.0 40234.2 40652.4 41603.6 41763.6 41902.8 33416.7 35551.1 35632.0 35706.8 35765.8 27237.9 27889.2 28219.0 28219.2 28269.9 18:38:13 INFO - PROCESS | 3370 | 18:38:13 INFO - PROCESS | 3370 | [#2] jquery.html Cycles:180 Average:27471.33 Median:2239.73 stddev:77733.24 (3470.7%) stddev-sans-first:77924.71 18:38:13 INFO - PROCESS | 3370 | Values: 394.8 399.9 400.1 406.2 411.5 14039.6 15401.6 17463.9 18103.4 18119.2 13720.9 16948.2 17219.4 17224.7 17327.2 5412.7 5512.8 5633.8 5634.5 5639.2 4067.9 5395.6 5588.2 5615.7 6000.4 6220.4 6245.4 6262.2 6264.6 6271.2 6070.6 6166.4 6219.4 6220.6 6240.2 5455.9 5462.3 5464.4 5468.4 5471.9 20081.5 20512.2 21639.1 21690.8 21888.6 2282.0 2536.8 3031.8 3074.3 3093.8 8854.0 9111.6 9475.0 9564.2 13436.2 1871.0 1969.9 1986.7 2009.9 2023.4 74993.6 78244.0 78403.0 78406.6 78446.0 9753.4 9797.5 9897.0 9908.7 10254.4 13249.5 13250.6 13283.5 13288.3 13300.0 7143.1 7209.3 7359.9 7542.7 7625.0 7464.6 7530.2 7587.5 7631.5 7631.6 4506.3 4541.5 4561.3 4626.7 4663.5 1884.9 1894.1 1899.7 1910.4 1950.0 851.6 938.2 1010.7 1075.9 1092.4 16938.5 17180.8 17560.4 18071.5 18199.3 898.7 944.7 950.7 1035.5 1037.2 9494.9 9606.9 10085.4 10127.6 10273.3 460609.0 465726.0 471692.0 479502.0 480511.0 86361.0 87453.0 87906.0 88175.6 88207.6 983.3 985.0 986.2 1000.5 1020.4 15651.7 15754.8 15757.0 15769.5 16233.8 35938.6 36425.5 36587.3 38043.0 38230.4 46523.8 53874.8 54255.0 54417.5 54560.5 7981.4 8090.2 8100.9 8464.7 8497.3 12080.8 12263.0 12369.2 12676.9 12847.4 10754.9 11138.8 11154.4 11248.6 11348.6 10832.9 11084.9 11098.0 11101.7 11107.8 11046.2 11131.4 11476.7 11506.3 11558.3 7986.0 8081.3 8150.6 8421.1 8457.4 9599.3 10630.9 10791.7 10927.9 10956.9 18:38:13 INFO - PROCESS | 3370 | 18:38:13 INFO - PROCESS | 3370 | [#3] mootools.html Cycles:180 Average:5827.51 Median:5175.91 stddev:3069.31 (59.3%) stddev-sans-first:3058.33 18:38:13 INFO - PROCESS | 3370 | Values: 1215.1 1486.5 1529.9 1655.1 1835.7 7340.3 8161.3 8358.3 8377.1 8379.9 8046.6 8186.8 8191.3 8201.1 8211.4 2011.1 2061.0 2286.6 2359.3 2384.4 2333.3 2354.3 2356.8 2357.3 2360.2 2304.8 2325.9 2329.0 2353.4 2357.9 2288.7 2305.5 2310.9 2313.8 2338.5 2295.8 2310.1 2311.7 2312.5 2316.3 8234.5 8287.2 8288.9 8289.9 8290.3 4986.4 5169.6 5169.8 5182.0 5208.5 3325.2 3358.1 3366.8 3377.7 3436.1 1123.7 1125.6 1136.0 1142.0 1153.9 11373.1 11374.1 11374.9 11403.5 11411.0 4356.2 4471.8 4495.3 4664.0 4752.7 9569.4 9601.4 9619.9 9632.4 9636.7 5072.3 5087.0 5088.2 5105.2 5109.5 4301.0 4648.9 4688.0 4773.0 4780.8 3915.6 3991.6 3999.5 4050.2 4073.5 1301.6 1314.5 1315.8 1325.2 1331.2 1351.7 1382.4 1385.5 1428.1 1442.2 7888.3 7943.9 7959.2 7976.2 7979.7 491.1 501.3 501.8 502.5 507.4 6168.0 6273.1 6314.7 6321.1 6340.2 9392.7 10018.8 10034.5 10110.9 10210.3 9930.0 10053.8 10098.9 10105.7 10160.4 7647.6 7728.7 7732.7 7743.5 7819.7 7578.6 7724.1 7781.6 7796.1 7830.5 9154.1 9292.6 9329.2 9370.3 9398.2 9353.8 9516.1 9668.8 9724.3 9738.9 6720.8 7201.9 7206.3 7293.9 7403.9 8148.5 8172.9 8174.4 8185.7 8222.5 6897.8 6970.1 7034.9 7080.9 7167.2 7315.3 7318.5 7375.2 7409.6 7410.1 7667.0 7744.4 7745.2 7752.8 7754.7 6783.9 6813.1 6822.8 6860.1 6861.5 6984.8 7051.6 7066.6 7075.2 7077.1 18:38:13 INFO - PROCESS | 3370 | 18:38:13 INFO - PROCESS | 3370 | [#4] prototype.html Cycles:180 Average:4931.00 Median:5626.74 stddev:1457.26 (25.9%) stddev-sans-first:1419.83 18:38:13 INFO - PROCESS | 3370 | Values: 329.4 332.5 334.7 338.5 341.1 5575.3 5597.5 5603.5 5617.3 5636.2 5529.9 5531.8 5535.6 5547.0 5551.8 3945.6 4107.6 4249.8 4315.8 4318.5 4261.8 4299.5 4311.9 4326.1 4339.2 4304.8 4313.3 4316.0 4324.1 4338.3 4074.4 4175.5 4302.3 4307.1 4313.7 3789.5 3791.2 3794.4 3802.7 3812.5 5348.3 5351.6 5356.5 5377.6 5393.3 4846.9 4950.3 4962.9 4968.3 4982.6 5806.7 5813.7 5813.9 5828.6 5843.3 4181.4 4183.4 4194.6 4198.6 4208.9 5786.0 5879.7 5929.4 6062.4 6105.7 4281.5 4284.3 4284.9 4286.3 4296.8 4293.5 4335.1 4353.5 4359.1 4365.8 4850.4 4864.3 4931.5 4934.6 4962.8 5850.8 5874.9 5881.1 5890.2 5890.6 1485.9 1502.2 1505.4 1511.3 1514.4 995.3 1032.6 1035.5 1041.9 1050.6 5615.7 5670.3 5672.2 5675.2 5692.5 6026.5 6034.2 6037.8 6060.1 6062.3 5487.0 5668.0 5675.8 5695.8 5718.0 3208.8 3213.8 3214.7 3227.2 3238.5 6045.6 6221.9 6230.5 6244.5 6253.8 6150.1 6151.1 6156.3 6173.6 6175.3 6191.3 6195.2 6222.4 6236.2 6238.5 5818.3 6029.3 6032.4 6035.9 6041.8 5938.5 5950.7 5960.2 5961.5 5991.8 5964.5 6040.9 6259.1 6278.5 6306.2 4295.8 4308.5 4326.5 4334.3 4335.3 5908.4 6084.4 6088.7 6089.0 6103.1 5852.9 5902.1 5910.2 5915.6 5925.9 5892.6 5893.8 5898.4 5929.4 5953.2 5707.3 5843.9 5850.6 5851.5 5854.6 5870.5 5875.2 5883.4 5904.8 5914.2 5576.7 5813.1 5826.2 5833.0 5876.1 18:38:13 INFO - PROCESS | 3370 | 18:38:13 INFO - PROCESS | 3370 | [#5] yui.html Cycles:180 Average:14164.35 Median:23413.92 stddev:15907.76 (67.9%) stddev-sans-first:15920.71 18:38:13 INFO - PROCESS | 3370 | Values: 796.1 821.8 826.5 832.3 843.5 15381.7 15872.9 15962.0 15994.0 16000.7 14879.4 14928.0 14969.6 15007.6 15063.2 664.9 792.8 803.3 814.3 819.6 817.3 817.4 821.6 822.2 823.3 844.6 848.0 849.7 851.2 851.4 676.9 816.1 832.1 832.8 845.4 604.1 606.3 606.3 606.4 606.5 14190.7 14247.1 14254.7 14303.1 14311.4 13315.6 13478.6 13616.7 13631.2 13632.1 11354.3 11371.8 11522.5 11585.3 11628.4 3786.8 3812.8 3853.4 3858.0 3898.5 51160.7 51234.5 53202.0 53245.7 53443.7 10379.2 10403.3 10543.3 10684.8 10865.5 18479.3 18703.3 18704.4 18717.6 18738.9 8196.3 8314.1 8543.7 8600.7 8725.4 4597.8 4609.1 4681.2 4728.4 4794.3 3243.1 3243.2 3281.7 3285.5 3306.5 607.1 609.9 615.6 625.4 625.4 723.6 734.2 739.9 755.3 760.3 8569.6 8767.9 8917.7 9077.0 9190.0 560.6 631.9 690.2 707.7 739.5 4104.6 4238.7 4241.4 4275.3 4305.3 57144.7 57372.7 57495.7 57791.4 58210.1 47316.0 47954.5 49813.3 50160.5 51791.7 46929.3 46963.3 47429.5 47452.0 47511.0 7879.7 8284.5 8424.5 8475.8 8615.1 32607.8 32767.8 32936.2 33189.5 33613.5 39951.8 41006.8 42552.6 42917.8 43642.8 10561.4 10622.9 10647.3 10707.1 10934.5 11075.8 11398.7 11536.8 11586.6 13416.5 12617.2 12775.8 12813.0 13079.1 13533.4 12600.8 13108.0 13115.1 13126.4 13153.2 10553.6 10561.3 10577.7 10706.7 11073.4 10111.9 10318.6 10405.3 10599.5 10630.9 10607.4 10716.2 10736.1 10893.8 10899.7 18:38:13 INFO - PROCESS | 3370 | -------- Summary: end -------- 18:38:13 INFO - PROCESS | 3370 | 18:38:13 INFO - TEST-INFO | 3370: exit 0 18:38:13 INFO - TEST-OK | dromaeo_css | took 1113467ms 18:38:13 INFO - TEST-START | kraken 18:38:13 INFO - operating with platform_type : linux_ 18:38:13 INFO - Initialising browser for kraken test... 18:38:13 INFO - TEST-INFO | started process 3558 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxDdNcM/profile http://localhost:54596/getInfo.html) 18:38:18 INFO - PROCESS | 3558 | __metrics Screen width/height:1600/1200 18:38:18 INFO - PROCESS | 3558 | colorDepth:24 18:38:18 INFO - PROCESS | 3558 | Browser inner width/height: 1024/697 18:38:18 INFO - PROCESS | 3558 | __metrics 18:38:19 ERROR - PROCESS | 3558 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:38:20 INFO - TEST-INFO | 3558: exit 0 18:38:20 INFO - Browser initialized. 18:38:20 INFO - Running cycle 1/1 for kraken test... 18:38:20 INFO - TEST-INFO | started process 3640 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxDdNcM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:38:32 INFO - PROCESS | 3640 | RSS: Main: 153128960 18:38:32 INFO - PROCESS | 3640 | 18:38:34 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:54596/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54596/tests/kraken/driver.html?testName=audio-beat-detection) 18:38:35 INFO - PROCESS | 3640 | RSS: Main: 195309568 18:38:35 INFO - PROCESS | 3640 | 18:38:37 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:54596/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54596/tests/kraken/driver.html?testName=audio-dft) 18:38:38 INFO - PROCESS | 3640 | RSS: Main: 185901056 18:38:38 INFO - PROCESS | 3640 | 18:38:41 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:54596/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54596/tests/kraken/driver.html?testName=audio-fft) 18:38:42 INFO - PROCESS | 3640 | RSS: Main: 169136128 18:38:42 INFO - PROCESS | 3640 | 18:38:44 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:54596/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54596/tests/kraken/driver.html?testName=audio-oscillator) 18:38:44 INFO - PROCESS | 3640 | RSS: Main: 170127360 18:38:44 INFO - PROCESS | 3640 | 18:38:46 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:54596/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54596/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:38:47 INFO - PROCESS | 3640 | RSS: Main: 172457984 18:38:47 INFO - PROCESS | 3640 | 18:38:50 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:54596/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54596/tests/kraken/driver.html?testName=imaging-darkroom) 18:38:51 INFO - PROCESS | 3640 | RSS: Main: 172867584 18:38:51 INFO - PROCESS | 3640 | 18:38:54 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:54596/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54596/tests/kraken/driver.html?testName=imaging-desaturate) 18:38:54 INFO - PROCESS | 3640 | RSS: Main: 173568000 18:38:54 INFO - PROCESS | 3640 | 18:38:57 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:54596/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54596/tests/kraken/driver.html?testName=json-parse-financial) 18:38:58 INFO - PROCESS | 3640 | RSS: Main: 173219840 18:38:58 INFO - PROCESS | 3640 | 18:38:59 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:54596/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54596/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:39:00 INFO - PROCESS | 3640 | RSS: Main: 182157312 18:39:00 INFO - PROCESS | 3640 | 18:39:02 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:54596/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54596/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:39:02 INFO - PROCESS | 3640 | RSS: Main: 180490240 18:39:02 INFO - PROCESS | 3640 | 18:39:05 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:54596/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54596/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:39:06 INFO - PROCESS | 3640 | RSS: Main: 193839104 18:39:06 INFO - PROCESS | 3640 | 18:39:08 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:54596/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54596/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:39:09 INFO - PROCESS | 3640 | RSS: Main: 200704000 18:39:09 INFO - PROCESS | 3640 | 18:39:12 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:54596/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54596/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:39:12 INFO - PROCESS | 3640 | RSS: Main: 199151616 18:39:12 INFO - PROCESS | 3640 | 18:39:14 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:54596/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54596/tests/kraken/driver.html?testName=ai-astar) 18:39:14 INFO - PROCESS | 3640 | RSS: Main: 262660096 18:39:14 INFO - PROCESS | 3640 | 18:39:14 INFO - PROCESS | 3640 | __start_tp_report 18:39:14 INFO - PROCESS | 3640 | _x_x_mozilla_page_load 18:39:14 INFO - PROCESS | 3640 | _x_x_mozilla_page_load_details 18:39:14 INFO - PROCESS | 3640 | |i|pagename|runs| 18:39:14 INFO - PROCESS | 3640 | |0;ai-astar;109;111;105;111;111;112;100;111;110;109 18:39:14 INFO - PROCESS | 3640 | |1;audio-beat-detection;160;129;152;173;135;149;153;128;172;127 18:39:14 INFO - PROCESS | 3640 | |2;audio-dft;161;161;161;161;160;160;162;164;161;162 18:39:14 INFO - PROCESS | 3640 | |3;audio-fft;76;76;100;105;72;76;75;123;107;75 18:39:14 INFO - PROCESS | 3640 | |4;audio-oscillator;93;93;143;92;92;92;136;92;92;149 18:39:14 INFO - PROCESS | 3640 | |5;imaging-gaussian-blur;117;117;118;118;118;117;117;116;117;116 18:39:14 INFO - PROCESS | 3640 | |6;imaging-darkroom;145;144;145;145;147;145;146;145;146;146 18:39:14 INFO - PROCESS | 3640 | |7;imaging-desaturate;95;95;94;95;96;96;95;95;95;94 18:39:14 INFO - PROCESS | 3640 | |8;json-parse-financial;57;60;56;56;59;64;55;66;54;54 18:39:14 INFO - PROCESS | 3640 | |9;json-stringify-tinderbox;63;62;62;62;62;68;63;63;63;63 18:39:14 INFO - PROCESS | 3640 | |10;stanford-crypto-aes;88;81;80;88;88;82;81;82;89;81 18:39:14 INFO - PROCESS | 3640 | |11;stanford-crypto-ccm;129;136;128;131;126;129;131;128;134;132 18:39:14 INFO - PROCESS | 3640 | |12;stanford-crypto-pbkdf2;172;166;180;167;171;165;163;163;164;165 18:39:14 INFO - PROCESS | 3640 | |13;stanford-crypto-sha256-iterative;70;67;69;69;66;67;68;67;72;68 18:39:14 INFO - PROCESS | 3640 | __end_tp_report 18:39:14 INFO - PROCESS | 3640 | __start_cc_report 18:39:14 INFO - PROCESS | 3640 | _x_x_mozilla_cycle_collect,1084 18:39:14 INFO - PROCESS | 3640 | __end_cc_report 18:39:14 INFO - PROCESS | 3640 | __startTimestamp1460252354687__endTimestamp 18:39:14 INFO - PROCESS | 3640 | 18:39:14 INFO - PROCESS | 3640 | ------- Summary: start ------- 18:39:14 INFO - PROCESS | 3640 | Number of tests: 14 18:39:14 INFO - PROCESS | 3640 | 18:39:14 INFO - PROCESS | 3640 | [#0] ai-astar Cycles:10 Average:108.90 Median:111.00 stddev:3.70 (3.3%) stddev-sans-first:3.92 18:39:14 INFO - PROCESS | 3640 | Values: 109.0 111.0 105.0 111.0 111.0 112.0 100.0 111.0 110.0 109.0 18:39:14 INFO - PROCESS | 3640 | 18:39:14 INFO - PROCESS | 3640 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:152.50 stddev:17.50 (11.5%) stddev-sans-first:18.00 18:39:14 INFO - PROCESS | 3640 | Values: 160.0 129.0 152.0 173.0 135.0 149.0 153.0 128.0 172.0 127.0 18:39:14 INFO - PROCESS | 3640 | 18:39:14 INFO - PROCESS | 3640 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 18:39:14 INFO - PROCESS | 3640 | Values: 161.0 161.0 161.0 161.0 160.0 160.0 162.0 164.0 161.0 162.0 18:39:14 INFO - PROCESS | 3640 | 18:39:14 INFO - PROCESS | 3640 | [#3] audio-fft Cycles:10 Average:88.50 Median:75.00 stddev:18.39 (24.5%) stddev-sans-first:18.94 18:39:14 INFO - PROCESS | 3640 | Values: 76.0 76.0 100.0 105.0 72.0 76.0 75.0 123.0 107.0 75.0 18:39:14 INFO - PROCESS | 3640 | 18:39:14 INFO - PROCESS | 3640 | [#4] audio-oscillator Cycles:10 Average:107.40 Median:92.00 stddev:24.53 (26.7%) stddev-sans-first:25.46 18:39:14 INFO - PROCESS | 3640 | Values: 93.0 93.0 143.0 92.0 92.0 92.0 136.0 92.0 92.0 149.0 18:39:14 INFO - PROCESS | 3640 | 18:39:14 INFO - PROCESS | 3640 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 18:39:14 INFO - PROCESS | 3640 | Values: 117.0 117.0 118.0 118.0 118.0 117.0 117.0 116.0 117.0 116.0 18:39:14 INFO - PROCESS | 3640 | 18:39:14 INFO - PROCESS | 3640 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 18:39:14 INFO - PROCESS | 3640 | Values: 145.0 144.0 145.0 145.0 147.0 145.0 146.0 145.0 146.0 146.0 18:39:14 INFO - PROCESS | 3640 | 18:39:14 INFO - PROCESS | 3640 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 18:39:14 INFO - PROCESS | 3640 | Values: 95.0 95.0 94.0 95.0 96.0 96.0 95.0 95.0 95.0 94.0 18:39:14 INFO - PROCESS | 3640 | 18:39:14 INFO - PROCESS | 3640 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.00 stddev:4.15 (7.2%) stddev-sans-first:4.38 18:39:14 INFO - PROCESS | 3640 | Values: 57.0 60.0 56.0 56.0 59.0 64.0 55.0 66.0 54.0 54.0 18:39:14 INFO - PROCESS | 3640 | 18:39:14 INFO - PROCESS | 3640 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:1.79 (2.8%) stddev-sans-first:1.90 18:39:14 INFO - PROCESS | 3640 | Values: 63.0 62.0 62.0 62.0 62.0 68.0 63.0 63.0 63.0 63.0 18:39:14 INFO - PROCESS | 3640 | 18:39:14 INFO - PROCESS | 3640 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:85.00 stddev:3.71 (4.4%) stddev-sans-first:3.64 18:39:14 INFO - PROCESS | 3640 | Values: 88.0 81.0 80.0 88.0 88.0 82.0 81.0 82.0 89.0 81.0 18:39:14 INFO - PROCESS | 3640 | 18:39:14 INFO - PROCESS | 3640 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:131.00 stddev:3.03 (2.3%) stddev-sans-first:3.17 18:39:14 INFO - PROCESS | 3640 | Values: 129.0 136.0 128.0 131.0 126.0 129.0 131.0 128.0 134.0 132.0 18:39:14 INFO - PROCESS | 3640 | 18:39:14 INFO - PROCESS | 3640 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.60 Median:166.50 stddev:5.34 (3.2%) stddev-sans-first:5.42 18:39:14 INFO - PROCESS | 3640 | Values: 172.0 166.0 180.0 167.0 171.0 165.0 163.0 163.0 164.0 165.0 18:39:14 INFO - PROCESS | 3640 | 18:39:14 INFO - PROCESS | 3640 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:1.77 (2.6%) stddev-sans-first:1.76 18:39:14 INFO - PROCESS | 3640 | Values: 70.0 67.0 69.0 69.0 66.0 67.0 68.0 67.0 72.0 68.0 18:39:14 INFO - PROCESS | 3640 | -------- Summary: end -------- 18:39:14 INFO - PROCESS | 3640 | 18:39:15 INFO - TEST-INFO | 3640: exit 0 18:39:15 INFO - TEST-OK | kraken | took 61700ms 18:39:15 INFO - SUITE-END | took 1175s 18:39:15 INFO - Completed test suite (00:19:35) 18:39:15 INFO - javascript benchmark 18:39:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3097.9535306970383, 3115.688431156884, 3123.5470856725774, 3125.031240315501, 3161.509965955277, 5272.472752724735, 5350.678959262447, 5351.491608297215, 5422.783088676453, 5456.045192091378, 5350.3312085989255, 5362.597805164609, 5367.409584945663, 5398.6220964532495, 5445.992491389095, 4818.927716084261, 4861.562459378664, 4909.140900342426, 4954.355933728611, 4962.1812400953795, 4880.926786098212, 4899.534544218293, 4921.532454416824, 4939.43196532398, 4960.950390496085, 4814.109389762905, 4860.635452341071, 4894.4371397289415, 4894.681845680019, 4954.950450495503, 4862.100511405401, 4865.148598995162, 4869.732164730938, 4872.78072486739, 4914.066327397819, 4664.813407463697, 4813.181759100926, 4834.178189707758, 4834.323194752737, 4852.4662287148385, 5208.66143700662, 5210.244514545408, 5220.973895130538, 5230.450802665703, 5247.947520524822, 5639.68981706006, 5646.971765141189, 5653.123765816264, 5654.038813401731, 5655.4910058094965, 5685.971570142165, 5686.800961966312, 5687.573431992617, 5804.738786754606, 5882.941170588282, 5326.840194794162, 5349.277847490578, 5358.410574836765, 5358.65168764033, 5358.892822143535, 5805.506531944748, 5819.6508209507565, 5829.154772557956, 5831.62094463867, 5832.300123985149, 5562.721863906789, 5589.189567512769, 5606.439356064442, 5629.521490673339, 5654.830355089354, 5673.914891276634, 5688.601797874192, 5689.6586204827845, 5702.344230413472, 5708.65748055118, 5628.802991895346, 5636.60543761941, 5645.745941432645, 5645.802396916089, 5646.689432081275, 5546.69493177871, 5627.184058311522, 5647.802326918538, 5648.491635752802, 5699.031164702011, 4347.760873151944, 4363.563643635611, 4370.453693288339, 4381.452318460192, 4411.691181617256, 3823.4647149399107, 3883.0874744435037, 3917.05990562263, 3932.4494570760116, 3961.485006949078, 5388.568914486832, 5389.218563308376, 5400.054990376669, 5419.376771671229, 5460.0, 5610.438956104357, 5630.5214056805635, 5631.549476041907, 5634.802781902696, 5646.661200327993, 5291.497307755757, 5325.041492531304, 5341.86645333862, 5354.9196762048605, 5394.78420863161, 4762.666613337033, 4799.328094066834, 4806.735629540409, 4814.927776083362, 4845.370101886732, 5870.765169393177, 5871.735771890275, 5872.706364681834, 5885.676287804212, 5913.9112913306335, 5489.39616642177, 5656.123300888369, 5665.405132461197, 5667.291588551431, 5743.253377061123, 5988.580799344179, 6000.0, 6007.459328660441, 6014.188084608697, 6021.7591296347655, 5695.715214239354, 5702.714864256687, 5711.914321285101, 5723.313202415737, 5726.828195154152, 5685.829425117087, 5767.884642307215, 5780.710964451845, 5857.677827719346, 5873.3832947539895, 5610.943890561042, 5619.943800561942, 5621.269234999424, 5624.268845050117, 5624.521915637053, 5549.1676248563035, 5563.082091454865, 5594.748236329294, 5604.019296623156, 5604.159376093618, 5272.947270527399, 5494.0, 5530.778768849201, 5537.9169312459535, 5583.916241256303, 5601.579881508985, 5606.074997625346, 5613.719314034363, 5639.8590035249445, 5649.4633009864, 5346.278252435872, 5502.642328248651, 5516.972415137899, 5521.641093328921, 5521.806736764194], "value": 5261.21313871017, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.8738164985352, 636.5321488705804, 649.3441623959799, 649.6297110646933, 661.738613247767, 28783.85608071962, 35855.64144358559, 36488.81755591218, 36559.63440365595, 36655.26689466209, 39533.80233098831, 40032.199356012934, 40064.59935400645, 40106.7994660027, 40133.0, 8433.3674974377, 8616.612252448624, 8622.0, 8623.094575069621, 8624.913750862504, 8390.706325278616, 8506.532140732257, 8512.829743405127, 8514.318854491657, 8516.489010659381, 8501.19238672325, 8702.30381569473, 8710.259627931633, 8714.477131372138, 8739.431936924111, 8637.179467950535, 8680.34897382699, 8685.565721713952, 8687.435316704426, 8687.56562171892, 8513.446625969354, 8616.827663446697, 8620.65517379304, 8622.698205562838, 8632.0, 39587.60412395868, 39733.205335893406, 39967.0, 39996.40005399921, 40067.59932400697, 3320.3857286402094, 3443.3974054540354, 3460.809655468948, 3689.4650275709873, 3939.645431911113, 30053.0, 30770.53844192339, 31068.0, 31148.844255778575, 31180.220494487592, 4152.501699796014, 4261.382099595541, 4304.096139810644, 4341.327094300357, 4341.327094300388, 193249.0, 193673.0, 195598.0, 196167.0, 196344.0, 49820.750896245285, 50148.24777628339, 50314.0, 50407.74796126069, 50510.0, 54147.0, 54504.727476362365, 55509.0, 62495.375046248955, 64179.35820641827, 15680.843191568167, 15857.444989425545, 15927.124008179662, 15942.202889855693, 15949.362025519082, 12523.060770442253, 12668.80996785049, 12689.111762176744, 12696.555620553421, 12702.745945081047, 17061.914690426718, 18213.089345532935, 18929.0, 19354.32259870926, 19572.314968976018, 7126.821829454305, 7375.926240737631, 7411.370033547209, 7412.369948554326, 7480.438967077491, 982.219135787051, 1074.355386767933, 1086.8642268829092, 1097.9066779323687, 1114.788190243851, 30612.693873060984, 31851.20371990719, 31965.20086997844, 32390.514142287884, 32550.186245344055, 1077.5312738958578, 1102.7132945434084, 1129.4860838318546, 1180.6103985684704, 1206.3124019309084, 17559.561010974827, 18141.63716725658, 18199.909000455176, 18371.81628183701, 18452.90773546124, 543894.0, 554568.0, 556963.0, 559380.0, 559675.0, 53944.190837137474, 55041.72479137579, 55495.16757248645, 55505.44494555084, 55554.16668749972, 1264.2414551269164, 1297.4291311822956, 1298.6169080121576, 1338.631876234024, 1405.1849927042495, 21043.89478052661, 29453.263668407602, 29621.407571848013, 29857.402851942406, 29884.252893677833, 48154.51845481501, 48582.75708621434, 48596.0, 48774.0, 48818.75590622024, 270318.0, 276858.0, 277337.0, 278208.0, 279012.0, 33563.66436335605, 39109.608903910594, 39219.41170882382, 39940.0, 40920.795396022826, 43061.56938430575, 43279.78360108179, 43502.78248608863, 43523.0, 44396.77801610971, 33845.83077084697, 35635.46546801852, 37184.6281537192, 37410.064748381505, 37484.81257593694, 39449.40825887556, 40470.392944106454, 40661.98345041398, 40701.38947915843, 41211.0, 40234.195316092926, 40652.39021414622, 41603.58396416118, 41763.582364177186, 41902.79048604737, 33416.66583334136, 35551.11122221965, 35632.0, 35706.821465892506, 35765.82117089398, 27237.86381068082, 27889.16332510028, 28219.0, 28219.15342539727, 28269.858650706614], "value": 19110.921468848504, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.8104909643372, 399.93201155803513, 400.0678419283071, 406.21600311399, 411.53291014698306, 14039.578812635611, 15401.614959626015, 17463.912680436595, 18103.366382176628, 18119.18463669135, 13720.862791372083, 16948.237329320178, 17219.397321093766, 17224.741628875578, 17327.22027508762, 5412.702301373423, 5512.80705175319, 5633.830985070434, 5634.521065709419, 5639.15412688096, 4067.9186416271805, 5395.568354531648, 5588.189712491686, 5615.66306021638, 6000.399960003986, 6220.409061139208, 6245.437910588046, 6262.185915830935, 6264.59280146789, 6271.216097987752, 6070.57505974582, 6166.383361663842, 6219.440250377443, 6220.626762394271, 6240.157578726859, 5455.890882182373, 5462.317210348707, 5464.398916119224, 5468.425815289417, 5471.945280547184, 20081.497962551053, 20512.179512819468, 21639.134434622596, 21690.783092169033, 21888.562228755334, 2281.9885900570557, 2536.8351057181226, 3031.8484075796123, 3074.2775447769754, 3093.8453077346044, 8853.955730221373, 9111.635534578609, 9474.952625236898, 9564.234861211156, 13436.19382837033, 1870.9719354209699, 1969.8673262873906, 1986.652335841222, 2009.889456079915, 2023.3929821053625, 74993.62503187504, 78244.0, 78403.0, 78406.6079669598, 78445.99999999943, 9753.414795112316, 9797.461139637246, 9896.950515247378, 9908.653197138066, 10254.43600601959, 13249.536266230829, 13250.602481925558, 13283.535076272285, 13288.3355832208, 13300.0, 7143.1428228612895, 7209.279072092749, 7359.889601655979, 7542.680030994664, 7625.0, 7464.552126872405, 7530.209328020588, 7587.544747315179, 7631.465797394129, 7631.580263085472, 4506.3465797459185, 4541.500434952152, 4561.312314443677, 4626.699264547794, 4663.533646635377, 1884.8680592358678, 1894.1192345559105, 1899.6729006966355, 1910.4334445754625, 1949.9805001950083, 851.5742128935532, 938.2306508662831, 1010.7169992402139, 1075.887031861659, 1092.404639471474, 16938.547039302666, 17180.828191718174, 17560.38538651141, 18071.457856264333, 18199.27202911895, 898.6899519665704, 944.6693657220055, 950.6862735297335, 1035.53400969564, 1037.227265687068, 9494.905050949403, 9606.903930960741, 10085.394876307446, 10127.64553240633, 10273.332233404804, 460609.0, 465726.0, 471692.0, 479502.0, 480511.0, 86361.0, 87453.0, 87906.0, 88175.55912220526, 88207.55896220478, 983.3165949664914, 984.9556769945369, 986.2110311750571, 1000.5297510170209, 1020.3877673395903, 15651.686966260839, 15754.842451575796, 15757.0, 15769.526914192593, 16233.837661623233, 35938.64061359457, 36425.45361819522, 36587.26825463529, 38043.0, 38230.42654360131, 46523.83690407767, 53874.767513949286, 54255.0, 54417.45582544124, 54560.454395455534, 7981.3614910808155, 8090.190980902098, 8100.918990810016, 8464.703735369232, 8497.277731392654, 12080.75838483208, 12263.0, 12369.204424399994, 12676.936615316865, 12847.421866015864, 10754.892451075702, 11138.832917506083, 11154.386508742096, 11248.550057997916, 11348.602798901999, 10832.945835270773, 11084.944575277395, 11098.0, 11101.722456938642, 11107.833382499108, 11046.226764126433, 11131.387773672202, 11476.713082173012, 11506.252093614223, 11558.30650160993, 7985.960070199611, 8081.272685458337, 8150.55794591937, 8421.115782842713, 8457.365697572584, 9599.280053996117, 10630.946845265724, 10791.730206744895, 10927.945360273148, 10956.890431095588], "value": 8821.010499053195, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1215.1068964311223, 1486.4574430332927, 1529.9082055076697, 1655.1310561954979, 1835.6787562176623, 7340.339369456748, 8161.3062889654375, 8358.289545388649, 8377.078521362646, 8379.874301885477, 8046.557439340834, 8186.836263274731, 8191.344692424606, 8201.097879233295, 8211.425200235972, 2011.115109351888, 2060.979390206101, 2286.6455699366625, 2359.304005318435, 2384.415818124562, 2333.311673056444, 2354.3290162303747, 2356.7761062699014, 2357.281029286067, 2360.1503458754833, 2304.827137964651, 2325.8604483730946, 2329.0218108394515, 2353.411647088228, 2357.917472888449, 2288.7139107611547, 2305.4697419593504, 2310.9422264443438, 2313.7570555091643, 2338.4621537046405, 2295.827812914038, 2310.1106074161403, 2311.711036120485, 2312.456572705413, 2316.328264803205, 8234.505929644241, 8287.171282871725, 8288.875666865002, 8289.917100829036, 8290.336773058141, 4986.376702912136, 5169.612279079047, 5169.844904652867, 5181.974090129525, 5208.479152084799, 3325.201951531639, 3358.1436733633013, 3366.848491817874, 3377.662233776627, 3436.0722604896787, 1123.662901129666, 1125.5779082843933, 1135.9943200284029, 1142.029275116153, 1153.8846115388394, 11373.147013973985, 11374.090072794157, 11374.886251137465, 11403.486843092081, 11411.0, 4356.237658409766, 4471.821127154877, 4495.2582823834355, 4664.043871006435, 4752.714837109785, 9569.3779904306, 9601.423914565148, 9619.893712223184, 9632.422054676741, 9636.71089867305, 5072.264521644341, 5086.9745651271505, 5088.211327244283, 5105.183170692746, 5109.463506331856, 4301.0, 4648.907021859543, 4687.95312046882, 4773.0453909218295, 4780.760961951958, 3915.588863169326, 3991.560928297885, 3999.460072890181, 4050.1697152084344, 4073.5315438724333, 1301.622529466463, 1314.493919840868, 1315.7631626307166, 1325.1982550556775, 1331.2345401394043, 1351.7026254224054, 1382.377929931535, 1385.5427708856053, 1428.0931608428723, 1442.2428225181654, 7888.2506161914525, 7943.880841787378, 7959.164287749819, 7976.242256985577, 7979.68081276754, 491.11599121581014, 501.29567957020447, 501.8218532420938, 502.54017573920186, 507.3556583139392, 6168.0, 6273.12176295319, 6314.747410103636, 6321.146645202931, 6340.175777149033, 9392.671256506126, 10018.849717254247, 10034.498275086216, 10110.898891011142, 10210.336328138796, 9929.950350248202, 10053.849192262122, 10098.899011009942, 10105.696829094992, 10160.390376577428, 7647.617619119022, 7728.729494467667, 7732.729354472679, 7743.457957943003, 7819.726309579138, 7578.621068946641, 7724.111727151225, 7781.610919453891, 7796.10344810354, 7830.530168189927, 9154.130357616015, 9292.58183381736, 9329.207017403596, 9370.34407591462, 9398.154166125081, 9353.766155846159, 9516.095970882756, 9668.75828104303, 9724.27067969891, 9738.853917191389, 6720.798376048726, 7201.891971620325, 7206.315400036988, 7293.890591641236, 7403.851922961403, 8148.511089334659, 8172.877406838783, 8174.386920980831, 8185.672573097009, 8222.547759873025, 6897.7585784497305, 6970.128733908262, 7034.929650703632, 7080.929190708027, 7167.1757747859665, 7315.30504602062, 7318.524295920748, 7375.188729239887, 7409.555426674417, 7410.147832999059, 7667.0, 7744.380449564134, 7745.186755390603, 7752.7674169775, 7754.728584499516, 6783.864322713617, 6813.080234168324, 6822.795316140524, 6860.108185935796, 6861.485388595976, 6984.79045628632, 7051.612161331176, 7066.646667666493, 7075.150981882207, 7077.115360579927], "value": 4688.527060005217, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.39720311829353, 332.5477350802909, 334.74559334905473, 338.5311343788853, 341.0892915914508, 5575.275214222151, 5597.496225339719, 5603.4956853883095, 5617.325920889494, 5636.15457681348, 5529.944700552994, 5531.751071201796, 5535.612507124503, 5546.975353995793, 5551.77792888284, 3945.60543945606, 4107.589241075899, 4249.787510624456, 4315.848945286915, 4318.4817821861425, 4261.829526818923, 4299.505556860954, 4311.935320970188, 4326.113146804897, 4339.218940590692, 4304.784760761965, 4313.309870420733, 4316.0, 4324.07032488015, 4338.305871060631, 4074.449949256857, 4175.45508161982, 4302.311630139163, 4307.095509942916, 4313.741175529447, 3789.5263092113487, 3791.241751649681, 3794.354959656865, 3802.7147963902817, 3812.4853144825647, 5348.304720386363, 5351.625386222966, 5356.54469370104, 5377.569794416477, 5393.301110150329, 4846.927296090562, 4950.2822090796635, 4962.87592810179, 4968.30443737877, 4982.60139188864, 5806.65160090396, 5813.651180929158, 5813.912791308134, 5828.591998560102, 5843.328017277982, 4181.351890456984, 4183.435236243099, 4194.622483976426, 4198.6221240088535, 4208.915821683579, 5785.971070144622, 5879.735411906475, 5929.377415371367, 6062.393760623946, 6105.664188469633, 4281.507626622916, 4284.3145096784365, 4284.8500302489265, 4286.314189729628, 4296.849610263625, 4293.549177336397, 4335.1329734053315, 4353.542877997828, 4359.149965756647, 4365.759883206454, 4850.369451971221, 4864.257314458578, 4931.457539670633, 4934.605231581537, 4962.751862406865, 5850.765969361263, 5874.882502350015, 5881.147233651097, 5890.204822348928, 5890.617109887844, 1485.90341627796, 1502.241368109098, 1505.427937383809, 1511.3199060422853, 1514.4245186829155, 995.2535598301274, 1032.5714828346302, 1035.5495359518634, 1041.890601486848, 1050.5902697947806, 5615.6630602164005, 5670.262865827499, 5672.205891175238, 5675.177099320658, 5692.544596432275, 6026.5178785697035, 6034.24571928509, 6037.849053773691, 6060.121282414026, 6062.333143354227, 5487.0, 5668.0, 5675.801346952837, 5695.800646977336, 5718.0, 3208.7646256191533, 3213.839308034589, 3214.694604012615, 3227.2093337132083, 3238.5304130900886, 6045.6070355426755, 6221.906671399933, 6230.501559875199, 6244.531660125509, 6253.812385628438, 6150.077488376779, 6151.108089327112, 6156.29202641693, 6173.629582225081, 6175.320714721377, 6191.288001879751, 6195.19462469885, 6222.439980401695, 6236.18929539157, 6238.500919926486, 5818.301803783404, 6029.306629737461, 6032.426919442646, 6035.879282414415, 6041.848953776191, 5938.465538101592, 5950.702464876652, 5960.225170727777, 5961.523078153824, 5991.820245392645, 5964.493018093511, 6040.879182416415, 6259.092431597484, 6278.497720182466, 6306.1801965746, 4295.806688698954, 4308.46144231971, 4326.545712700247, 4334.349847522897, 4335.3063509838275, 5908.438698323653, 6084.421979911901, 6088.726007329769, 6088.969555152196, 6103.145559621746, 5852.94147058524, 5902.144189092472, 5910.202122713551, 5915.615484993462, 5925.851853703692, 5892.616979896465, 5893.823185304448, 5898.380670029756, 5929.436703513159, 5953.166556681981, 5707.315122185364, 5843.912341314799, 5850.561207909509, 5851.531877449709, 5854.619449735754, 5870.471657550841, 5875.206847075761, 5883.382244864228, 5904.793332233351, 5914.172015917689, 5576.749046292845, 5813.098969659541, 5826.184334193132, 5832.9708351457975, 5876.08920617305], "value": 4465.117229950165, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [796.0884786918978, 821.7781199076253, 826.4586695714305, 832.2717622080679, 843.5149788871397, 15381.692366152683, 15872.920635396837, 15961.99999999997, 15994.040357578539, 16000.679986400264, 14879.40482380706, 14928.0, 14969.625759356022, 15007.624809379771, 15063.246837658127, 664.8570557330173, 792.8136887831383, 803.3252068262673, 814.3485211830541, 819.635262308273, 817.3257062923083, 817.4441379861692, 821.6097353756977, 822.235321151329, 823.2960818500186, 844.5734903873536, 848.0, 849.732334314692, 851.216880469966, 851.3529717414748, 676.905233267343, 816.102287483769, 832.1096426823301, 832.7626626411444, 845.4124383553433, 604.0787798607115, 606.2543072021439, 606.2876120558326, 606.3572613030158, 606.5481216493696, 14190.716185676332, 14247.145171289756, 14254.714905701932, 14303.141811491343, 14311.35598898052, 13315.600531984055, 13478.595642130751, 13616.727665446735, 13631.18212907219, 13632.113912595749, 11354.26197297173, 11371.829422558669, 11522.481488333045, 11585.304881707125, 11628.418579071013, 3786.848526058954, 3812.7521711088966, 3853.402722577977, 3857.961420385788, 3898.5126859142606, 51160.74419627915, 51234.48765512335, 53202.0, 53245.73377133128, 53443.73278133584, 10379.221558383151, 10403.32378395417, 10543.31468454548, 10684.839727404094, 10865.45672716361, 18479.260829566665, 18703.34538291153, 18704.438866834018, 18717.625647486973, 18738.906305468387, 8196.262336389753, 8314.127016663284, 8543.658253669908, 8600.698975535952, 8725.432846864933, 4597.770111494412, 4609.124266389443, 4681.204195286809, 4728.40894888139, 4794.256890182028, 3243.0757234188613, 3243.221626809596, 3281.6554261802166, 3285.4743241081314, 3306.5205545195813, 607.1166452811149, 609.9237595300588, 615.6183166436748, 625.3652542669195, 625.43710660406, 723.616483263871, 734.1630541183056, 739.8557281330196, 755.3277582951177, 760.3347071312602, 8569.614367353359, 8767.868481972775, 8917.680644420694, 9076.954615226881, 9190.0, 560.6131769079403, 631.9368063193643, 690.1890278922247, 707.738136889344, 739.4988174006775, 4104.610062044101, 4238.660907127422, 4241.427407299975, 4275.273203555403, 4305.289627211475, 57144.71427642835, 57372.71313643405, 57495.712521437126, 57791.422085778606, 58210.126848097316, 47316.0, 47954.520454795704, 49813.25280120801, 50160.498395016315, 51791.7410412953, 46929.29606055912, 46963.29555056677, 47429.5257047432, 47452.0, 47511.04977900423, 7879.684812607661, 8284.46151000183, 8424.452410593292, 8475.830483390175, 8615.138486151334, 32607.836960815042, 32767.836160819043, 32936.176595585304, 33189.50215746718, 33613.495797562566, 39951.80024099861, 41006.79496602498, 42552.57447425486, 42917.78541107274, 43642.78178609087, 10561.41912194806, 10622.946885265525, 10647.30792498485, 10707.0898973585, 10934.507947142238, 11075.778484430428, 11398.715032124263, 11536.82694759596, 11586.594469193538, 13416.463341466622, 12617.179883307555, 12775.80836287475, 12813.0, 13079.149855259378, 13533.390997405337, 12600.810987835006, 13108.0, 13115.08194426381, 13126.40931158081, 13153.21080735159, 10553.63062292816, 10561.260711750103, 10577.682669519927, 10706.732331691459, 11073.390963497084, 10111.898881011095, 10318.638847640297, 10405.323653962469, 10599.47002649849, 10630.8936910633, 10607.363558186225, 10716.249862509549, 10736.141108711128, 10893.782124357627, 10899.673009809718], "value": 6570.921453973227, "unit": "score"}], "name": "dromaeo_css", "value": 7042.664272573236, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 105.0, 111.0, 111.0, 112.0, 100.0, 111.0, 110.0, 109.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 129.0, 152.0, 173.0, 135.0, 149.0, 153.0, 128.0, 172.0, 127.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 160.0, 160.0, 162.0, 164.0, 161.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 100.0, 105.0, 72.0, 76.0, 75.0, 123.0, 107.0, 75.0], "value": 88.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 143.0, 92.0, 92.0, 92.0, 136.0, 92.0, 92.0, 149.0], "value": 107.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 144.0, 145.0, 145.0, 147.0, 145.0, 146.0, 145.0, 146.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 60.0, 56.0, 56.0, 59.0, 64.0, 55.0, 66.0, 54.0, 54.0], "value": 58.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 62.0, 68.0, 63.0, 63.0, 63.0, 63.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 81.0, 80.0, 88.0, 88.0, 82.0, 81.0, 82.0, 89.0, 81.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 136.0, 128.0, 131.0, 126.0, 129.0, 131.0, 128.0, 134.0, 132.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 166.0, 180.0, 167.0, 171.0, 165.0, 163.0, 163.0, 164.0, 165.0], "value": 167.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 69.0, 69.0, 66.0, 67.0, 68.0, 67.0, 72.0, 68.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1542.8999999999999, "alertThreshold": 2.0}]} 18:39:15 INFO - Return code: 0 18:39:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 18:39:15 ERROR - # TBPL SUCCESS # 18:39:15 INFO - Running post-action listener: _resource_record_post_action 18:39:15 INFO - Running post-run listener: _resource_record_post_run 18:39:17 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 7811072; Write bytes: 418934784; Read time: 1944; Write time: 434040 18:39:17 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 83374080; Read time: 0; Write time: 93672 18:39:17 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 5914624; Write bytes: 335560704; Read time: 1412; Write time: 340368 18:39:17 INFO - Running post-run listener: _upload_blobber_files 18:39:17 INFO - Blob upload gear active. 18:39:17 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 18:39:17 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 18:39:17 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'] 18:39:17 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 18:39:17 INFO - (blobuploader) - INFO - Open directory for files ... 18:39:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:39:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:39:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:18 INFO - (blobuploader) - INFO - Done attempting. 18:39:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 18:39:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:39:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:19 INFO - (blobuploader) - INFO - Done attempting. 18:39:19 INFO - (blobuploader) - INFO - Iteration through files over. 18:39:19 INFO - Return code: 0 18:39:19 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 18:39:19 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 18:39:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f061b8be0904ea23e21e9f62ead0b50f8f2de6a890699d9018873315c4d4ae666957b7509d0d3c9478cdff0e7fac1021ac7f9062db014649ad0dadafd2bad23d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3edeec47e25c0c52e4dbf5ffedd0d041d248201854b54346ef42826f133c8ae1bdda90dc1ad196f2c732c87ee90fe190417534fe8b0064c4ab3c53e78bb3bfb"} 18:39:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 18:39:19 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 18:39:19 INFO - Contents: 18:39:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f061b8be0904ea23e21e9f62ead0b50f8f2de6a890699d9018873315c4d4ae666957b7509d0d3c9478cdff0e7fac1021ac7f9062db014649ad0dadafd2bad23d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3edeec47e25c0c52e4dbf5ffedd0d041d248201854b54346ef42826f133c8ae1bdda90dc1ad196f2c732c87ee90fe190417534fe8b0064c4ab3c53e78bb3bfb"} 18:39:19 INFO - Running post-run listener: copy_logs_to_upload_dir 18:39:19 INFO - Copying logs to upload dir... 18:39:19 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 18:39:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.591860 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-09 18:39:19.044154) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-09 18:39:19.047831) ========= 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=14ef55db36f7623abb31b9cf000001d5-1460248374.820157-664867496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f061b8be0904ea23e21e9f62ead0b50f8f2de6a890699d9018873315c4d4ae666957b7509d0d3c9478cdff0e7fac1021ac7f9062db014649ad0dadafd2bad23d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3edeec47e25c0c52e4dbf5ffedd0d041d248201854b54346ef42826f133c8ae1bdda90dc1ad196f2c732c87ee90fe190417534fe8b0064c4ab3c53e78bb3bfb"} build_url:https://queue.taskcluster.net/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011025 build_url: 'https://queue.taskcluster.net/v1/task/PKmde4d3RdOVuYR-zT85eA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f061b8be0904ea23e21e9f62ead0b50f8f2de6a890699d9018873315c4d4ae666957b7509d0d3c9478cdff0e7fac1021ac7f9062db014649ad0dadafd2bad23d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3edeec47e25c0c52e4dbf5ffedd0d041d248201854b54346ef42826f133c8ae1bdda90dc1ad196f2c732c87ee90fe190417534fe8b0064c4ab3c53e78bb3bfb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-09 18:39:19.072954) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:39:19.073305) ========= 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=14ef55db36f7623abb31b9cf000001d5-1460248374.820157-664867496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 18:39:19.159135) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-09 18:39:19.159495) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-09 18:39:19.159808) ========= ========= Total master_lag: 0.24 =========