builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-018 starttime: 1460476995.67 results: success (0) buildid: 20160412053028 builduid: a5f2c38b82714fbc8ba09323dbe241c3 revision: c6e90a3857c019e418c113f31dec86ca43e60243 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 09:03:15.673249) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 09:03:15.673759) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 09:03:15.674083) ========= 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=62c568580acbfdaac3eec7be000001dc-1460476112.854403-460469496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006322 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 09:03:15.698074) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 09:03:15.698419) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 09:03:15.721028) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 09:03:15.721329) ========= 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=62c568580acbfdaac3eec7be000001dc-1460476112.854403-460469496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.032252 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 09:03:15.769754) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 09:03:15.770095) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 09:03:15.770510) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 09:03:15.770815) ========= 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=62c568580acbfdaac3eec7be000001dc-1460476112.854403-460469496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-12 09:03:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-04-12 09:03:15 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181434 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 09:03:15.964686) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 09:03:15.965002) ========= 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=62c568580acbfdaac3eec7be000001dc-1460476112.854403-460469496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.101803 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 09:03:16.079026) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-12 09:03:16.079432) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c6e90a3857c019e418c113f31dec86ca43e60243 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev c6e90a3857c019e418c113f31dec86ca43e60243 --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=62c568580acbfdaac3eec7be000001dc-1460476112.854403-460469496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-12 09:03:16,100 truncating revision to first 12 chars 2016-04-12 09:03:16,101 Setting DEBUG logging. 2016-04-12 09:03:16,101 attempt 1/10 2016-04-12 09:03:16,101 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c6e90a3857c0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-12 09:03:17,005 unpacking tar archive at: fx-team-c6e90a3857c0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.174794 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-12 09:03:17.266109) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 09:03:17.266453) ========= echo c6e90a3857c019e418c113f31dec86ca43e60243 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c6e90a3857c019e418c113f31dec86ca43e60243'] 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=62c568580acbfdaac3eec7be000001dc-1460476112.854403-460469496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c6e90a3857c019e418c113f31dec86ca43e60243 program finished with exit code 0 elapsedTime=0.003629 script_repo_revision: 'c6e90a3857c019e418c113f31dec86ca43e60243' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 09:03:17.313593) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 09:03:17.313886) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 09:03:17.323710) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-12 09:03:17.324034) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=62c568580acbfdaac3eec7be000001dc-1460476112.854403-460469496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:03:17 INFO - MultiFileLogger online at 20160412 09:03:17 in /builds/slave/test-pgo 09:03:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:03:17 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:03:17 INFO - {'append_to_log': False, 09:03:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:03:17 INFO - 'blob_upload_branch': 'Fx-Team', 09:03:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:03:17 INFO - 'branch': 'Fx-Team', 09:03:17 INFO - 'buildbot_json_path': 'buildprops.json', 09:03:17 INFO - 'config_files': ('talos/linux_config.py',), 09:03:17 INFO - 'default_actions': ('clobber', 09:03:17 INFO - 'read-buildbot-config', 09:03:17 INFO - 'download-and-extract', 09:03:17 INFO - 'populate-webroot', 09:03:17 INFO - 'create-virtualenv', 09:03:17 INFO - 'install', 09:03:17 INFO - 'run-tests'), 09:03:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:03:17 INFO - 'download_minidump_stackwalk': True, 09:03:17 INFO - 'download_symbols': 'ondemand', 09:03:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:03:17 INFO - 'tooltool.py': '/tools/tooltool.py', 09:03:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:03:17 INFO - '/tools/misc-python/virtualenv.py')}, 09:03:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:03:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:03:17 INFO - 'installer_path': 'installer.exe', 09:03:17 INFO - 'log_level': 'info', 09:03:17 INFO - 'log_name': 'talos', 09:03:17 INFO - 'log_to_console': True, 09:03:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:03:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:03:17 INFO - 'opt_config_files': (), 09:03:17 INFO - 'pip_index': False, 09:03:17 INFO - 'sps_profile': False, 09:03:17 INFO - 'sps_profile_interval': 0, 09:03:17 INFO - 'suite': 'dromaeojs-e10s', 09:03:17 INFO - 'system_bits': '32', 09:03:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:03:17 INFO - 'title': 'talos-linux64-ix-018', 09:03:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:03:17 INFO - 'use_talos_json': True, 09:03:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:03:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:03:17 INFO - 'work_dir': 'build'} 09:03:17 INFO - ##### 09:03:17 INFO - ##### Running clobber step. 09:03:17 INFO - ##### 09:03:17 INFO - Running pre-action listener: _resource_record_pre_action 09:03:17 INFO - Running main action method: clobber 09:03:17 INFO - rmtree: /builds/slave/test-pgo/build 09:03:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:03:22 INFO - Running post-action listener: _resource_record_post_action 09:03:22 INFO - ##### 09:03:22 INFO - ##### Running read-buildbot-config step. 09:03:22 INFO - ##### 09:03:22 INFO - Running pre-action listener: _resource_record_pre_action 09:03:22 INFO - Running main action method: read_buildbot_config 09:03:22 INFO - Using buildbot properties: 09:03:22 INFO - { 09:03:22 INFO - "project": "", 09:03:22 INFO - "product": "firefox", 09:03:22 INFO - "script_repo_revision": "production", 09:03:22 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:03:22 INFO - "repository": "", 09:03:22 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 09:03:22 INFO - "buildid": "20160412053028", 09:03:22 INFO - "pgo_build": "True", 09:03:22 INFO - "basedir": "/builds/slave/test-pgo", 09:03:22 INFO - "buildnumber": 641, 09:03:22 INFO - "slavename": "talos-linux64-ix-018", 09:03:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:03:22 INFO - "platform": "ubuntu64_hw", 09:03:22 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 09:03:22 INFO - "branch": "fx-team", 09:03:22 INFO - "repo_path": "integration/fx-team", 09:03:22 INFO - "revision": "c6e90a3857c019e418c113f31dec86ca43e60243", 09:03:22 INFO - "stage_platform": "linux64-pgo", 09:03:22 INFO - "builduid": "a5f2c38b82714fbc8ba09323dbe241c3", 09:03:22 INFO - "slavebuilddir": "test" 09:03:22 INFO - } 09:03:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/DhtbjR9YTgK4DyWkyeSGVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 09:03:22 INFO - Running post-action listener: _resource_record_post_action 09:03:22 INFO - ##### 09:03:22 INFO - ##### Running download-and-extract step. 09:03:22 INFO - ##### 09:03:22 INFO - Running pre-action listener: _resource_record_pre_action 09:03:22 INFO - Running main action method: download_and_extract 09:03:22 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:03:22 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')]} 09:03:22 INFO - https://queue.taskcluster.net/v1/task/DhtbjR9YTgK4DyWkyeSGVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:03:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhtbjR9YTgK4DyWkyeSGVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:03:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhtbjR9YTgK4DyWkyeSGVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:03:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhtbjR9YTgK4DyWkyeSGVw/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 09:03:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhtbjR9YTgK4DyWkyeSGVw/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 09:03:24 INFO - Downloaded 1361 bytes. 09:03:24 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:03:24 INFO - Using the following test package requirements: 09:03:24 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:03:24 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:03:24 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:03:24 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:24 INFO - u'jsshell-linux-x86_64.zip'], 09:03:24 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:03:24 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:03:24 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:03:24 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:03:24 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:03:24 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:03:24 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:03:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:03:24 INFO - https://queue.taskcluster.net/v1/task/DhtbjR9YTgK4DyWkyeSGVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:03:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhtbjR9YTgK4DyWkyeSGVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:03:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhtbjR9YTgK4DyWkyeSGVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:03:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhtbjR9YTgK4DyWkyeSGVw/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 09:03:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhtbjR9YTgK4DyWkyeSGVw/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 09:03:27 INFO - Downloaded 23764659 bytes. 09:03:27 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'] 09:03:27 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 09:03:28 INFO - Return code: 0 09:03:28 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 09:03:28 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')]} 09:03:28 INFO - https://queue.taskcluster.net/v1/task/DhtbjR9YTgK4DyWkyeSGVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:03:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhtbjR9YTgK4DyWkyeSGVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:03:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhtbjR9YTgK4DyWkyeSGVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:03:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhtbjR9YTgK4DyWkyeSGVw/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 09:03:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhtbjR9YTgK4DyWkyeSGVw/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 09:03:34 INFO - Downloaded 23764659 bytes. 09:03:34 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'] 09:03:34 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 09:03:36 INFO - Return code: 0 09:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:03:36 INFO - https://queue.taskcluster.net/v1/task/DhtbjR9YTgK4DyWkyeSGVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:03:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhtbjR9YTgK4DyWkyeSGVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:03:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhtbjR9YTgK4DyWkyeSGVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:03:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhtbjR9YTgK4DyWkyeSGVw/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 09:03:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhtbjR9YTgK4DyWkyeSGVw/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 09:03:37 INFO - Downloaded 10841076 bytes. 09:03:37 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'] 09:03:37 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 09:03:37 INFO - Return code: 0 09:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:03:37 INFO - https://queue.taskcluster.net/v1/task/DhtbjR9YTgK4DyWkyeSGVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:03:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhtbjR9YTgK4DyWkyeSGVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:03:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhtbjR9YTgK4DyWkyeSGVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:03:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhtbjR9YTgK4DyWkyeSGVw/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 09:03:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DhtbjR9YTgK4DyWkyeSGVw/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 09:03:38 INFO - Downloaded 57837179 bytes. 09:03:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DhtbjR9YTgK4DyWkyeSGVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:03:38 INFO - mkdir: /builds/slave/test-pgo/properties 09:03:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:03:38 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:03:38 INFO - Contents: 09:03:38 INFO - build_url:https://queue.taskcluster.net/v1/task/DhtbjR9YTgK4DyWkyeSGVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:03:39 INFO - Running post-action listener: _resource_record_post_action 09:03:39 INFO - Running post-action listener: set_extra_try_arguments 09:03:39 INFO - ##### 09:03:39 INFO - ##### Running populate-webroot step. 09:03:39 INFO - ##### 09:03:39 INFO - Running pre-action listener: _resource_record_pre_action 09:03:39 INFO - Running main action method: populate_webroot 09:03:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:03:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:03:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:03:39 INFO - '--tppagecycles', 09:03:39 INFO - '7'], 09:03:39 INFO - 'tests': ['tsvgm']}}, 09:03:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:03:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:03:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:03:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:03:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:03:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:03:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:39 INFO - 'talos_options': ['--disable-e10s'], 09:03:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:03:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:03:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:39 INFO - 'talos_options': ['--disable-e10s'], 09:03:39 INFO - 'tests': ['damp', 'tps']}, 09:03:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:39 INFO - 'tests': ['damp', 'tps']}, 09:03:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:03:39 INFO - 'tests': ['dromaeo_dom']}, 09:03:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:03:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:03:39 INFO - 'tests': ['a11yr', 09:03:39 INFO - 'ts_paint', 09:03:39 INFO - 'tpaint', 09:03:39 INFO - 'sessionrestore', 09:03:39 INFO - 'sessionrestore_no_auto_restore', 09:03:39 INFO - 'tabpaint']}, 09:03:39 INFO - 'other-e10s': {'tests': ['a11yr', 09:03:39 INFO - 'ts_paint', 09:03:39 INFO - 'tpaint', 09:03:39 INFO - 'sessionrestore', 09:03:39 INFO - 'sessionrestore_no_auto_restore', 09:03:39 INFO - 'tabpaint']}, 09:03:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:03:39 INFO - 'ts_paint', 09:03:39 INFO - 'tpaint', 09:03:39 INFO - 'sessionrestore', 09:03:39 INFO - 'sessionrestore_no_auto_restore', 09:03:39 INFO - 'tabpaint']}, 09:03:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:03:39 INFO - 'ts_paint', 09:03:39 INFO - 'tpaint', 09:03:39 INFO - 'sessionrestore', 09:03:39 INFO - 'sessionrestore_no_auto_restore', 09:03:39 INFO - 'tabpaint']}, 09:03:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:03:39 INFO - 'tests': ['a11yr', 09:03:39 INFO - 'ts_paint', 09:03:39 INFO - 'tpaint', 09:03:39 INFO - 'sessionrestore', 09:03:39 INFO - 'sessionrestore_no_auto_restore', 09:03:39 INFO - 'tabpaint']}, 09:03:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:03:39 INFO - 'tests': ['a11yr', 09:03:39 INFO - 'ts_paint', 09:03:39 INFO - 'tpaint', 09:03:39 INFO - 'sessionrestore', 09:03:39 INFO - 'sessionrestore_no_auto_restore', 09:03:39 INFO - 'tabpaint']}, 09:03:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:03:39 INFO - 'tests': ['tsvgx', 09:03:39 INFO - 'tsvgr_opacity', 09:03:39 INFO - 'tart', 09:03:39 INFO - 'tscrollx', 09:03:39 INFO - 'cart']}, 09:03:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:03:39 INFO - 'tsvgr_opacity', 09:03:39 INFO - 'tart', 09:03:39 INFO - 'tscrollx', 09:03:39 INFO - 'cart']}, 09:03:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:39 INFO - 'talos_options': ['--disable-e10s'], 09:03:39 INFO - 'tests': ['tp5o']}, 09:03:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:39 INFO - 'tests': ['tp5o']}, 09:03:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:39 INFO - 'talos_options': ['--disable-e10s', 09:03:39 INFO - '--xperf_path', 09:03:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:03:39 INFO - 'tests': ['tp5n']}, 09:03:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:39 INFO - 'talos_options': ['--xperf_path', 09:03:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:03:39 INFO - 'tests': ['tp5n']}}, 09:03:39 INFO - 'talos.zip': {'path': '', 09:03:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:03:39 INFO - Running post-action listener: _resource_record_post_action 09:03:39 INFO - ##### 09:03:39 INFO - ##### Running create-virtualenv step. 09:03:39 INFO - ##### 09:03:39 INFO - Running pre-action listener: _resource_record_pre_action 09:03:39 INFO - Running main action method: create_virtualenv 09:03:39 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:03:39 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 09:03:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:03:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:03:40 INFO - Using real prefix '/usr' 09:03:40 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:03:40 INFO - Installing distribute.............................................................................................................................................................................................done. 09:03:42 INFO - Installing pip.................done. 09:03:42 INFO - Return code: 0 09:03:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9332575f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19718d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a008b0>, '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 0x1a017b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01c60>, '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': '62c568580acbfdaac3eec7be000001dc-1460476112.854403-460469496', '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 09:03:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 09:03:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:03:42 INFO - Using env: {'DISPLAY': ':0', 09:03:42 INFO - 'HOME': '/home/cltbld', 09:03:42 INFO - 'LANG': 'en_US.UTF-8', 09:03:42 INFO - 'LANGUAGE': 'en_US:en', 09:03:42 INFO - 'LOGNAME': 'cltbld', 09:03:42 INFO - 'MAIL': '/var/mail/cltbld', 09:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:42 INFO - 'MOZ_NO_REMOTE': '1', 09:03:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:42 INFO - 'NO_EM_RESTART': '1', 09:03:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:03:42 INFO - 'PWD': '/builds/slave/test-pgo', 09:03:42 INFO - 'SHELL': '/bin/bash', 09:03:42 INFO - 'SHLVL': '1', 09:03:42 INFO - 'TERM': 'linux', 09:03:42 INFO - 'TMOUT': '86400', 09:03:42 INFO - 'USER': 'cltbld', 09:03:42 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460476112.854403-460469496', 09:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:42 INFO - '_': '/tools/buildbot/bin/python'} 09:03:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:42 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 09:03:42 INFO - Cleaning up... 09:03:42 INFO - Return code: 0 09:03:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9332575f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19718d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a008b0>, '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 0x1a017b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01c60>, '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': '62c568580acbfdaac3eec7be000001dc-1460476112.854403-460469496', '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 09:03:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 09:03:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:03:42 INFO - Using env: {'DISPLAY': ':0', 09:03:42 INFO - 'HOME': '/home/cltbld', 09:03:42 INFO - 'LANG': 'en_US.UTF-8', 09:03:42 INFO - 'LANGUAGE': 'en_US:en', 09:03:42 INFO - 'LOGNAME': 'cltbld', 09:03:42 INFO - 'MAIL': '/var/mail/cltbld', 09:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:42 INFO - 'MOZ_NO_REMOTE': '1', 09:03:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:42 INFO - 'NO_EM_RESTART': '1', 09:03:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:03:42 INFO - 'PWD': '/builds/slave/test-pgo', 09:03:42 INFO - 'SHELL': '/bin/bash', 09:03:42 INFO - 'SHLVL': '1', 09:03:42 INFO - 'TERM': 'linux', 09:03:42 INFO - 'TMOUT': '86400', 09:03:42 INFO - 'USER': 'cltbld', 09:03:42 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460476112.854403-460469496', 09:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:42 INFO - '_': '/tools/buildbot/bin/python'} 09:03:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:42 INFO - Downloading/unpacking psutil>=0.7.1 09:03:42 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 09:03:42 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 09:03:42 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 09:03:42 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 09:03:42 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 09:03:42 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 09:03:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:03:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:03:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:03:44 INFO - Installing collected packages: psutil 09:03:44 INFO - Running setup.py install for psutil 09:03:45 INFO - building 'psutil._psutil_linux' extension 09:03:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:03:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:03:45 INFO - building 'psutil._psutil_posix' extension 09:03:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:03:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:03:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:03:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:03:45 INFO - Successfully installed psutil 09:03:45 INFO - Cleaning up... 09:03:45 INFO - Return code: 0 09:03:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:03: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')]} 09:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03: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')]} 09:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9332575f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19718d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a008b0>, '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 0x1a017b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01c60>, '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': '62c568580acbfdaac3eec7be000001dc-1460476112.854403-460469496', '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 09:03:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 09:03:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:03:45 INFO - Using env: {'DISPLAY': ':0', 09:03:45 INFO - 'HOME': '/home/cltbld', 09:03:45 INFO - 'LANG': 'en_US.UTF-8', 09:03:45 INFO - 'LANGUAGE': 'en_US:en', 09:03:45 INFO - 'LOGNAME': 'cltbld', 09:03:45 INFO - 'MAIL': '/var/mail/cltbld', 09:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:45 INFO - 'MOZ_NO_REMOTE': '1', 09:03:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:45 INFO - 'NO_EM_RESTART': '1', 09:03:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:03:45 INFO - 'PWD': '/builds/slave/test-pgo', 09:03:45 INFO - 'SHELL': '/bin/bash', 09:03:45 INFO - 'SHLVL': '1', 09:03:45 INFO - 'TERM': 'linux', 09:03:45 INFO - 'TMOUT': '86400', 09:03:45 INFO - 'USER': 'cltbld', 09:03:45 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460476112.854403-460469496', 09:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:45 INFO - '_': '/tools/buildbot/bin/python'} 09:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:03:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:03:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:03:48 INFO - Installing collected packages: mozsystemmonitor 09:03:48 INFO - Running setup.py install for mozsystemmonitor 09:03:48 INFO - Successfully installed mozsystemmonitor 09:03:48 INFO - Cleaning up... 09:03:48 INFO - Return code: 0 09:03:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:03:48 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')]} 09:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:48 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')]} 09:03:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:48 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 0x7f9332575f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19718d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a008b0>, '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 0x1a017b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01c60>, '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': '62c568580acbfdaac3eec7be000001dc-1460476112.854403-460469496', '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 09:03:48 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 09:03:48 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 09:03:48 INFO - Using env: {'DISPLAY': ':0', 09:03:48 INFO - 'HOME': '/home/cltbld', 09:03:48 INFO - 'LANG': 'en_US.UTF-8', 09:03:48 INFO - 'LANGUAGE': 'en_US:en', 09:03:48 INFO - 'LOGNAME': 'cltbld', 09:03:48 INFO - 'MAIL': '/var/mail/cltbld', 09:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:48 INFO - 'MOZ_NO_REMOTE': '1', 09:03:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:48 INFO - 'NO_EM_RESTART': '1', 09:03:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:03:48 INFO - 'PWD': '/builds/slave/test-pgo', 09:03:48 INFO - 'SHELL': '/bin/bash', 09:03:48 INFO - 'SHLVL': '1', 09:03:48 INFO - 'TERM': 'linux', 09:03:48 INFO - 'TMOUT': '86400', 09:03:48 INFO - 'USER': 'cltbld', 09:03:48 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460476112.854403-460469496', 09:03:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:48 INFO - '_': '/tools/buildbot/bin/python'} 09:03:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:48 INFO - Downloading/unpacking blobuploader==1.2.4 09:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:50 INFO - Downloading blobuploader-1.2.4.tar.gz 09:03:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:03:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:03:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:03:51 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 09:03:51 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 09:03:51 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 09:03:51 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 09:03:51 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 09:03:51 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 09:03:51 INFO - Downloading docopt-0.6.1.tar.gz 09:03:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:03:51 INFO - Installing collected packages: blobuploader, requests, docopt 09:03:51 INFO - Running setup.py install for blobuploader 09:03:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:03:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:03:51 INFO - Running setup.py install for requests 09:03:52 INFO - Running setup.py install for docopt 09:03:52 INFO - Successfully installed blobuploader requests docopt 09:03:52 INFO - Cleaning up... 09:03:52 INFO - Return code: 0 09:03:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:03: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')]} 09:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03: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')]} 09:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:52 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 0x7f9332575f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19718d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a008b0>, '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 0x1a017b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01c60>, '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': '62c568580acbfdaac3eec7be000001dc-1460476112.854403-460469496', '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 09:03:52 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 09:03:52 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 09:03:52 INFO - Using env: {'DISPLAY': ':0', 09:03:52 INFO - 'HOME': '/home/cltbld', 09:03:52 INFO - 'LANG': 'en_US.UTF-8', 09:03:52 INFO - 'LANGUAGE': 'en_US:en', 09:03:52 INFO - 'LOGNAME': 'cltbld', 09:03:52 INFO - 'MAIL': '/var/mail/cltbld', 09:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:52 INFO - 'MOZ_NO_REMOTE': '1', 09:03:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:52 INFO - 'NO_EM_RESTART': '1', 09:03:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:03:52 INFO - 'PWD': '/builds/slave/test-pgo', 09:03:52 INFO - 'SHELL': '/bin/bash', 09:03:52 INFO - 'SHLVL': '1', 09:03:52 INFO - 'TERM': 'linux', 09:03:52 INFO - 'TMOUT': '86400', 09:03:52 INFO - 'USER': 'cltbld', 09:03:52 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460476112.854403-460469496', 09:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:52 INFO - '_': '/tools/buildbot/bin/python'} 09:03:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:03:52 INFO - Running setup.py (path:/tmp/pip-LnZKmh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:03:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:03:52 INFO - Running setup.py (path:/tmp/pip-BGlDoz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:03:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:03:52 INFO - Running setup.py (path:/tmp/pip-hT98UQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:03:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:03:52 INFO - Running setup.py (path:/tmp/pip-9_UPn6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:03:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:03:52 INFO - Running setup.py (path:/tmp/pip-ookBBM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:03:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:03:52 INFO - Running setup.py (path:/tmp/pip-Nht7GG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:03:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:03:52 INFO - Running setup.py (path:/tmp/pip-3YS3IB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:03:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:03:52 INFO - Running setup.py (path:/tmp/pip-PIKS9a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:03:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:03:52 INFO - Running setup.py (path:/tmp/pip-SN0KE_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:03:53 INFO - Running setup.py (path:/tmp/pip-CQdh5H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:03:53 INFO - Running setup.py (path:/tmp/pip-YliHuF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:03:53 INFO - Running setup.py (path:/tmp/pip-SfWAM_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:03:53 INFO - Running setup.py (path:/tmp/pip-dsEZAx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:03:53 INFO - Running setup.py (path:/tmp/pip-na_0QL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:03:53 INFO - Running setup.py (path:/tmp/pip-U_MDjz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:03:53 INFO - Running setup.py (path:/tmp/pip-OCT0tO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:03:53 INFO - Running setup.py (path:/tmp/pip-NMBeyi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:03:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:03:53 INFO - Running setup.py install for manifestparser 09:03:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:03:53 INFO - Running setup.py install for mozcrash 09:03:53 INFO - Running setup.py install for mozdebug 09:03:53 INFO - Running setup.py install for mozdevice 09:03:54 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:03:54 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:03:54 INFO - Running setup.py install for mozfile 09:03:54 INFO - Running setup.py install for mozhttpd 09:03:54 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:03:54 INFO - Running setup.py install for mozinfo 09:03:54 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:03:54 INFO - Running setup.py install for mozInstall 09:03:54 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:03:54 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:03:54 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:03:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:03:54 INFO - Running setup.py install for mozleak 09:03:54 INFO - Running setup.py install for mozlog 09:03:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:03:54 INFO - Running setup.py install for moznetwork 09:03:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:03:54 INFO - Running setup.py install for mozprocess 09:03:54 INFO - Running setup.py install for mozprofile 09:03:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:03:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:03:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:03:54 INFO - Running setup.py install for mozrunner 09:03:55 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:03:55 INFO - Running setup.py install for mozscreenshot 09:03:55 INFO - Running setup.py install for moztest 09:03:55 INFO - Running setup.py install for mozversion 09:03:55 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:03:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:03:55 INFO - Cleaning up... 09:03:55 INFO - Return code: 0 09:03:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:55 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 0x7f9332575f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19718d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a008b0>, '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 0x1a017b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01c60>, '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': '62c568580acbfdaac3eec7be000001dc-1460476112.854403-460469496', '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 09:03:55 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 09:03:55 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 09:03:55 INFO - Using env: {'DISPLAY': ':0', 09:03:55 INFO - 'HOME': '/home/cltbld', 09:03:55 INFO - 'LANG': 'en_US.UTF-8', 09:03:55 INFO - 'LANGUAGE': 'en_US:en', 09:03:55 INFO - 'LOGNAME': 'cltbld', 09:03:55 INFO - 'MAIL': '/var/mail/cltbld', 09:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:55 INFO - 'MOZ_NO_REMOTE': '1', 09:03:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:55 INFO - 'NO_EM_RESTART': '1', 09:03:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:03:55 INFO - 'PWD': '/builds/slave/test-pgo', 09:03:55 INFO - 'SHELL': '/bin/bash', 09:03:55 INFO - 'SHLVL': '1', 09:03:55 INFO - 'TERM': 'linux', 09:03:55 INFO - 'TMOUT': '86400', 09:03:55 INFO - 'USER': 'cltbld', 09:03:55 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460476112.854403-460469496', 09:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:55 INFO - '_': '/tools/buildbot/bin/python'} 09:03:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:03:55 INFO - Running setup.py (path:/tmp/pip-sAgvpR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:03:55 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)) 09:03:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:03:55 INFO - Running setup.py (path:/tmp/pip-8kbx3v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:03:55 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)) 09:03:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:03:55 INFO - Running setup.py (path:/tmp/pip-1or15b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:03:55 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)) 09:03:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:03:55 INFO - Running setup.py (path:/tmp/pip-7t5unK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:03:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:03:55 INFO - Running setup.py (path:/tmp/pip-r2gyAz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 09:03:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:03:55 INFO - Running setup.py (path:/tmp/pip-mEhpcm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:03:56 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)) 09:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:03:56 INFO - Running setup.py (path:/tmp/pip-CTKZCJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:03:56 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)) 09:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:03:56 INFO - Running setup.py (path:/tmp/pip-GMZ0lF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:03:56 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)) 09:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:03:56 INFO - Running setup.py (path:/tmp/pip-PYcV9O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:03:56 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)) 09:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:03:56 INFO - Running setup.py (path:/tmp/pip-1QHjzG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:03:56 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)) 09:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:03:56 INFO - Running setup.py (path:/tmp/pip-KLxB1j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:03:56 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)) 09:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:03:56 INFO - Running setup.py (path:/tmp/pip-asKfYg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:03:56 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)) 09:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:03:56 INFO - Running setup.py (path:/tmp/pip-vNSgZj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:03:56 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)) 09:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:03:56 INFO - Running setup.py (path:/tmp/pip-Bi2Wes-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:03:56 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)) 09:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:03:56 INFO - Running setup.py (path:/tmp/pip-YTMwf2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:03:56 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)) 09:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:03:56 INFO - Running setup.py (path:/tmp/pip-S2jQm6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:03:56 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)) 09:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:03:56 INFO - Running setup.py (path:/tmp/pip-Yu2V0U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:03:56 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)) 09:03:56 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)) 09:03:56 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)) 09:03:56 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)) 09:03:56 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)) 09:03:56 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)) 09:03:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:58 INFO - Downloading blessings-1.6.tar.gz 09:03:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:03:58 INFO - Installing collected packages: blessings 09:03:58 INFO - Running setup.py install for blessings 09:03:58 INFO - Successfully installed blessings 09:03:58 INFO - Cleaning up... 09:03:58 INFO - Return code: 0 09:03:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:03:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:03:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:03:59 INFO - Reading from file tmpfile_stdout 09:03:59 INFO - Current package versions: 09:03:59 INFO - argparse == 1.2.1 09:03:59 INFO - blessings == 1.6 09:03:59 INFO - blobuploader == 1.2.4 09:03:59 INFO - docopt == 0.6.1 09:03:59 INFO - manifestparser == 1.1 09:03:59 INFO - mozInstall == 1.12 09:03:59 INFO - mozcrash == 0.17 09:03:59 INFO - mozdebug == 0.1 09:03:59 INFO - mozdevice == 0.48 09:03:59 INFO - mozfile == 1.2 09:03:59 INFO - mozhttpd == 0.7 09:03:59 INFO - mozinfo == 0.9 09:03:59 INFO - mozleak == 0.1 09:03:59 INFO - mozlog == 3.1 09:03:59 INFO - moznetwork == 0.27 09:03:59 INFO - mozprocess == 0.22 09:03:59 INFO - mozprofile == 0.28 09:03:59 INFO - mozrunner == 6.11 09:03:59 INFO - mozscreenshot == 0.1 09:03:59 INFO - mozsystemmonitor == 0.0 09:03:59 INFO - moztest == 0.7 09:03:59 INFO - mozversion == 1.4 09:03:59 INFO - psutil == 3.1.1 09:03:59 INFO - requests == 1.2.3 09:03:59 INFO - wsgiref == 0.1.2 09:03:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:03: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')]} 09:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03: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')]} 09:03:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:59 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 0x7f9332575f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19718d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a008b0>, '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 0x1a017b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01c60>, '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': '62c568580acbfdaac3eec7be000001dc-1460476112.854403-460469496', '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 09:03:59 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 09:03:59 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 09:03:59 INFO - Using env: {'DISPLAY': ':0', 09:03:59 INFO - 'HOME': '/home/cltbld', 09:03:59 INFO - 'LANG': 'en_US.UTF-8', 09:03:59 INFO - 'LANGUAGE': 'en_US:en', 09:03:59 INFO - 'LOGNAME': 'cltbld', 09:03:59 INFO - 'MAIL': '/var/mail/cltbld', 09:03:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:59 INFO - 'MOZ_NO_REMOTE': '1', 09:03:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:59 INFO - 'NO_EM_RESTART': '1', 09:03:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:03:59 INFO - 'PWD': '/builds/slave/test-pgo', 09:03:59 INFO - 'SHELL': '/bin/bash', 09:03:59 INFO - 'SHLVL': '1', 09:03:59 INFO - 'TERM': 'linux', 09:03:59 INFO - 'TMOUT': '86400', 09:03:59 INFO - 'USER': 'cltbld', 09:03:59 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460476112.854403-460469496', 09:03:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:59 INFO - '_': '/tools/buildbot/bin/python'} 09:03:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:59 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)) 09:03:59 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)) 09:03:59 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)) 09:03:59 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)) 09:03:59 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)) 09:03:59 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)) 09:03:59 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)) 09:03:59 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)) 09:03:59 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)) 09:03:59 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)) 09:03:59 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)) 09:03:59 INFO - Cleaning up... 09:03:59 INFO - Return code: 0 09:03:59 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:03: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')]} 09:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03: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')]} 09:03:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9332575f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19718d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a008b0>, '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 0x1a017b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01c60>, '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': '62c568580acbfdaac3eec7be000001dc-1460476112.854403-460469496', '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 09:03: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', 'jsonschema'] in /builds/slave/test-pgo/build 09:03: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 jsonschema 09:03:59 INFO - Using env: {'DISPLAY': ':0', 09:03:59 INFO - 'HOME': '/home/cltbld', 09:03:59 INFO - 'LANG': 'en_US.UTF-8', 09:03:59 INFO - 'LANGUAGE': 'en_US:en', 09:03:59 INFO - 'LOGNAME': 'cltbld', 09:03:59 INFO - 'MAIL': '/var/mail/cltbld', 09:03:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:59 INFO - 'MOZ_NO_REMOTE': '1', 09:03:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:59 INFO - 'NO_EM_RESTART': '1', 09:03:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:03:59 INFO - 'PWD': '/builds/slave/test-pgo', 09:03:59 INFO - 'SHELL': '/bin/bash', 09:03:59 INFO - 'SHLVL': '1', 09:03:59 INFO - 'TERM': 'linux', 09:03:59 INFO - 'TMOUT': '86400', 09:03:59 INFO - 'USER': 'cltbld', 09:03:59 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460476112.854403-460469496', 09:03:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:59 INFO - '_': '/tools/buildbot/bin/python'} 09:03:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:59 INFO - Downloading/unpacking jsonschema 09:03: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 09:03: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 09:03: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 09:03: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 09:03: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 09:03: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 09:04:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:04:01 INFO - Downloading/unpacking functools32 (from jsonschema) 09:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:01 INFO - Downloading functools32-3.2.3-2.tar.gz 09:04:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:04:01 INFO - warning: no files found matching '*.txt' 09:04:01 INFO - no previously-included directories found matching 'build' 09:04:01 INFO - no previously-included directories found matching 'dist' 09:04:01 INFO - no previously-included directories found matching '.git*' 09:04:01 INFO - Installing collected packages: jsonschema, functools32 09:04:01 INFO - Running setup.py install for functools32 09:04:01 INFO - warning: no files found matching '*.txt' 09:04:01 INFO - no previously-included directories found matching 'build' 09:04:01 INFO - no previously-included directories found matching 'dist' 09:04:01 INFO - no previously-included directories found matching '.git*' 09:04:01 INFO - Successfully installed jsonschema functools32 09:04:01 INFO - Cleaning up... 09:04:01 INFO - Return code: 0 09:04:01 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:04:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:02 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')]} 09:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:02 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 0x7f9332575f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19718d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a008b0>, '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 0x1a017b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01c60>, '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': '62c568580acbfdaac3eec7be000001dc-1460476112.854403-460469496', '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 09:04:02 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 09:04:02 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 09:04:02 INFO - Using env: {'DISPLAY': ':0', 09:04:02 INFO - 'HOME': '/home/cltbld', 09:04:02 INFO - 'LANG': 'en_US.UTF-8', 09:04:02 INFO - 'LANGUAGE': 'en_US:en', 09:04:02 INFO - 'LOGNAME': 'cltbld', 09:04:02 INFO - 'MAIL': '/var/mail/cltbld', 09:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:02 INFO - 'MOZ_NO_REMOTE': '1', 09:04:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:02 INFO - 'NO_EM_RESTART': '1', 09:04:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:02 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:02 INFO - 'SHELL': '/bin/bash', 09:04:02 INFO - 'SHLVL': '1', 09:04:02 INFO - 'TERM': 'linux', 09:04:02 INFO - 'TMOUT': '86400', 09:04:02 INFO - 'USER': 'cltbld', 09:04:02 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460476112.854403-460469496', 09:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:02 INFO - '_': '/tools/buildbot/bin/python'} 09:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:02 INFO - Downloading/unpacking flake8 09:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:04:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:04:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:04:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:04:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:04:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:04:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:04:04 INFO - no previously-included directories found matching 'docs/_build' 09:04:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:04:04 INFO - Running setup.py install for pep8 09:04:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:04:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:04:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:04:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:04:04 INFO - no previously-included directories found matching 'docs/_build' 09:04:04 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:04:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:04:04 INFO - Cleaning up... 09:04:05 INFO - Return code: 0 09:04:05 INFO - Running post-action listener: _resource_record_post_action 09:04:05 INFO - Running post-action listener: _start_resource_monitoring 09:04:05 INFO - Starting resource monitoring. 09:04:05 INFO - ##### 09:04:05 INFO - ##### Running install step. 09:04:05 INFO - ##### 09:04:05 INFO - Running pre-action listener: _resource_record_pre_action 09:04:05 INFO - Running main action method: install 09:04:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:04:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:04:05 INFO - Reading from file tmpfile_stdout 09:04:05 INFO - Detecting whether we're running mozinstall >=1.0... 09:04:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:04:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:04:05 INFO - Reading from file tmpfile_stdout 09:04:05 INFO - Output received: 09:04:05 INFO - Usage: mozinstall [options] installer 09:04:05 INFO - Options: 09:04:05 INFO - -h, --help show this help message and exit 09:04:05 INFO - -d DEST, --destination=DEST 09:04:05 INFO - Directory to install application into. [default: 09:04:05 INFO - "/builds/slave/test-pgo"] 09:04:05 INFO - --app=APP Application being installed. [default: firefox] 09:04:05 INFO - mkdir: /builds/slave/test-pgo/build/application 09:04:05 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'] 09:04:05 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 09:04:21 INFO - Reading from file tmpfile_stdout 09:04:21 INFO - Output received: 09:04:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:04:21 INFO - Running post-action listener: _resource_record_post_action 09:04:21 INFO - ##### 09:04:21 INFO - ##### Running run-tests step. 09:04:21 INFO - ##### 09:04:21 INFO - Running pre-action listener: _resource_record_pre_action 09:04:21 INFO - Running main action method: run_tests 09:04:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:04:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:04:21 INFO - Python 2.7.3 09:04:21 INFO - Return code: 0 09:04:21 INFO - grabbing minidump binary from tooltool 09:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:21 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 0x1a008b0>, '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 0x1a017b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01c60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:04:21 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 09:04:21 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 09:04:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:04:21 INFO - Return code: 0 09:04:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:04:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:04:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:04:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:04:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:04:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:04:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:04:22 INFO - Return code: 0 09:04:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DhtbjR9YTgK4DyWkyeSGVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 09:04:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DhtbjR9YTgK4DyWkyeSGVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:04:22 INFO - Using env: {'DISPLAY': ':0', 09:04:22 INFO - 'HOME': '/home/cltbld', 09:04:22 INFO - 'LANG': 'en_US.UTF-8', 09:04:22 INFO - 'LANGUAGE': 'en_US:en', 09:04:22 INFO - 'LOGNAME': 'cltbld', 09:04:22 INFO - 'MAIL': '/var/mail/cltbld', 09:04:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:04:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:04:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:22 INFO - 'MOZ_NO_REMOTE': '1', 09:04:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:04:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:22 INFO - 'NO_EM_RESTART': '1', 09:04:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:22 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:04:22 INFO - 'SHELL': '/bin/bash', 09:04:22 INFO - 'SHLVL': '1', 09:04:22 INFO - 'TERM': 'linux', 09:04:22 INFO - 'TMOUT': '86400', 09:04:22 INFO - 'USER': 'cltbld', 09:04:22 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460476112.854403-460469496', 09:04:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:22 INFO - '_': '/tools/buildbot/bin/python'} 09:04:22 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DhtbjR9YTgK4DyWkyeSGVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:04:23 INFO - mozversion application_buildid: 20160412053028 09:04:23 INFO - mozversion application_changeset: c6e90a3857c019e418c113f31dec86ca43e60243 09:04:23 INFO - mozversion application_display_name: Nightly 09:04:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:04:23 INFO - mozversion application_name: Firefox 09:04:23 INFO - mozversion application_remotingname: firefox 09:04:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:04:23 INFO - mozversion application_vendor: Mozilla 09:04:23 INFO - mozversion application_version: 48.0a1 09:04:23 INFO - mozversion platform_buildid: 20160412053028 09:04:23 INFO - mozversion platform_changeset: c6e90a3857c019e418c113f31dec86ca43e60243 09:04:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:04:23 INFO - mozversion platform_version: 48.0a1 09:04:23 INFO - using testdate: 1460477063 09:04:23 INFO - actual date: 1460477063 09:04:23 INFO - starting webserver on 'localhost:45077' 09:04:23 INFO - SUITE-START | Running 2 tests 09:04:23 INFO - TEST-START | dromaeo_css 09:04:23 INFO - operating with platform_type : linux_ 09:04:23 INFO - Initialising browser for dromaeo_css test... 09:04:23 INFO - TEST-INFO | started process 28360 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvw8y7t/profile http://localhost:45077/getInfo.html) 09:04:26 INFO - PROCESS | 28360 | 09:04:26 INFO - PROCESS | 28360 | (process:28427): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:04:27 INFO - PROCESS | 28360 | JavaScript error: jar:file:///builds/slave/test-pgo/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 09:04:27 INFO - PROCESS | 28360 | __metrics Screen width/height:1600/1200 09:04:27 INFO - PROCESS | 28360 | colorDepth:24 09:04:27 INFO - PROCESS | 28360 | Browser inner width/height: 1024/697 09:04:27 INFO - PROCESS | 28360 | __metrics 09:04:28 ERROR - PROCESS | 28360 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 09:04:29 INFO - TEST-INFO | 28360: exit 0 09:04:29 INFO - Browser initialized. 09:04:29 INFO - Running cycle 1/1 for dromaeo_css test... 09:04:29 INFO - TEST-INFO | started process 28478 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvw8y7t/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:04:31 INFO - PROCESS | 28478 | 09:04:31 INFO - PROCESS | 28478 | (process:28537): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:04:41 INFO - PROCESS | 28478 | RSS: Main: 163450880 09:04:41 INFO - PROCESS | 28478 | 09:05:30 INFO - PROCESS | 28478 | 1460477130789 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] 09:07:38 INFO - PROCESS | 28478 | Cycle 1(1): loaded http://localhost:45077/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45077/tests/dromaeo/cssquery-ext.html) 09:07:39 INFO - PROCESS | 28478 | RSS: Main: 168120320 09:07:39 INFO - PROCESS | 28478 | 09:10:41 INFO - PROCESS | 28478 | Cycle 1(1): loaded http://localhost:45077/tests/dromaeo/cssquery-ext.html (next: http://localhost:45077/tests/dromaeo/cssquery-jquery.html) 09:10:42 INFO - PROCESS | 28478 | RSS: Main: 164999168 09:10:42 INFO - PROCESS | 28478 | 09:13:43 INFO - PROCESS | 28478 | Cycle 1(1): loaded http://localhost:45077/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45077/tests/dromaeo/cssquery-mootools.html) 09:13:44 INFO - PROCESS | 28478 | RSS: Main: 166883328 09:13:44 INFO - PROCESS | 28478 | 09:16:46 INFO - PROCESS | 28478 | Cycle 1(1): loaded http://localhost:45077/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45077/tests/dromaeo/cssquery-prototype.html) 09:16:46 INFO - PROCESS | 28478 | RSS: Main: 164331520 09:16:46 INFO - PROCESS | 28478 | 09:19:49 INFO - PROCESS | 28478 | Cycle 1(1): loaded http://localhost:45077/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45077/tests/dromaeo/cssquery-yui.html) 09:19:49 INFO - PROCESS | 28478 | RSS: Main: 165830656 09:19:49 INFO - PROCESS | 28478 | 09:22:51 INFO - PROCESS | 28478 | Cycle 1(1): loaded http://localhost:45077/tests/dromaeo/cssquery-yui.html (next: http://localhost:45077/tests/dromaeo/cssquery-dojo.html) 09:22:52 INFO - PROCESS | 28478 | RSS: Main: 168026112 09:22:52 INFO - PROCESS | 28478 | 09:22:52 INFO - PROCESS | 28478 | __start_tp_report 09:22:52 INFO - PROCESS | 28478 | _x_x_mozilla_page_load 09:22:52 INFO - PROCESS | 28478 | _x_x_mozilla_page_load_details 09:22:52 INFO - PROCESS | 28478 | |i|pagename|runs| 09:22:52 INFO - PROCESS | 28478 | |0;dojo.html;3092.7216550510448;3164.572782674338;3164.66770989046;3183.6179658440974;3202.8718851245935;5348.224507446423;5361.463853614637;5391.811286604965;5416.783328666848;5433.782648694048;5277.102892508273;5364.141737322029;5437.592180586452;5438.53772429343;5475.069238229501;4917.532834380737;4927.802887884481;4939.086269040239;5113.079645663779;5120.718360490171;5028.974855125737;5050.368703912011;5065.189569668853;5077.466865979056;5100.15847385181;4728.787204575802;4871.342368780222;4926.162552366106;4956.529129732669;5048.570871475929;4866.416030076378;4891.046245982035;4897.583705385046;4906.852794416173;4937.975310123462;4830.3479030331155;4871.585915197213;4877.244027175793;4877.268409738567;4938.037082768861;5308.628396012281;5324.494173053554;5348.224507446398;5352.464753524655;5369.4630536946;5688.715564221772;5700.543956483513;5707.086866101446;5729.799457018984;5734.541236701054;5623.212750214973;5771.797987070432;5777.826665200051;5781.479666830005;5816.156657284712;5395.730213489349;5435.809746658848;5435.891282174334;5445.101558242885;5446.83659490212;5868.149118377812;5890.1164825276555;5914.142449344821;5918.289805223315;5919.644821310735;5602.775888964396;5699.401562835926;5730.484256416859;5734.942650573441;5806.970965145148;5726.484616384545;5745.109508026179;5749.626274292157;5754.1944127822135;5776.826695199066;5474.233607294982;5569.303837020372;5577.609567330329;5577.832665020056;5799;5760.251167348218;5795.333536643256;5800.738966746507;5809.2738407699035;5813.912791308134;4277.401163837066;4356.934645980313;4411.823527058882;4428.070105277863;4465.352523884018;3859.0352411897024;3870.5935876732538;3891.3190191716335;3912.315344814646;3918.9804050979565;5342.679439233659;5491;5499.642523235977;5508.44915508446;5510.586705997066;5830.7084645767545;5847.035239185572;5872.442117998783;5890.057590785539;5929.851753706192;5425.13197888336;5441.211024401439;5447.782088716407;5453.127499600045;5478.643888147258;4733.313669517901;4745.383100197021;4757.452892917289;4788.808447662054;4806.038792241566;6020.277566692025;6064.241969753781;6064.272287325549;6067.2112625359305;6117.082437634391;5800.767969281266;5824.330202026652;5832.912506312494;5856.853578660568;5871.794487192928;5926.792562260473;5998.3401825798255;6003.219581454383;6018.157457955802;6091.451769340781;5766.163906233656;5775.7400916957995;5779.133130030529;5779.422057794355;5806.6516009037905;5839.503642190291;5880.882382352243;5888.116782482662;5890;5899.056151015817;5479.04116779554;5651.491365777099;5679.261695979496;5772.624779389326;5774.162746401832;5623.297087864017;5715.171300161536;5731.426857314235;5740.368559458373;5826.038703613856;5616.66300022;5620;5637.661740295432;5643.35101463337;5663.66018038919;5717.571182161271;5725.2843394575675;5755.050416681201;5755.884882302246;5757.740901659352;5439.619226654255;5556.444355564411;5613.270274864241;5634.070378387684;5645.745941432563 09:22:52 INFO - PROCESS | 28478 | |1;ext.html;634.6065439427553;669.9916625478654;681.577421998361;722.1586851318215;722.9132504099509;29255.41489170218;38266.234675306514;38837;38992.41511377325;39114.413283800764;41144.58855411445;42150;42201.57798422015;42202.155956880844;42329.15341693172;8436.156384361546;8710.477371357707;8736.039035706068;8747.693830715927;8750.03749587545;8594.398392112524;8695.21743043126;8757.51833649149;8772.56137193141;8774.561271936378;8702.651893924236;8795.296376289882;8821.735347939572;8835.337349698766;9041.457512549268;8797.384183107186;8834.160754728291;8853.557322133867;8854.380193386465;8875.467471951704;8842.46945183291;8941.687040953535;8957.731268061969;8962.955185224033;8970.372073954826;40731.796341018104;41218;41320.79339603313;41419.7929010356;41559.584404155874;3311.3211791582667;3444.6727560881677;3494.545709057806;3519.1202199450136;3856.3058649443087;27392.178234652794;27795;27855.16434506968;29483.557746633818;32009;4331.350297455376;4378.846740364103;4380.167768124078;4443.2224360736745;4459.821607135743;256613;256625;259157;259301;261171;59483.40516594865;60024.69987650034;60105.69947150236;60306;60605.39394606086;71039;71683.64158179176;72481;72505.6374718123;72902.63548682223;15272.694546109238;15445.150516721687;15537.611559710871;15572.377104915902;15629.687406252038;11681.18231723788;11829.645110646694;11829.822552661717;11836.822447663291;11841.5855445059;20410.48973775638;20589.48526286825;20642.27752028672;20674.069666865027;20689.17243310281;7553.811154721066;7694.769156925301;7701.537907725442;7783.377329813601;7938;1029.8043371759343;1039.8648175737105;1099.4612639806437;1136;1162.2503485251966;31439.84280078585;31568.368632627677;31729;31795.84102079521;32926;1068.7274744939991;1136.613551392514;1139.0887290167998;1160.4081918221768;1167.3054532553117;14902;15189;15257.779377649762;15567.29947152381;15592.532224033297;439402;444758;448428;449150;449596;54545.45454545483;55111.72444137753;55525.44474555203;55618.16572751412;55855;1334.9399277032558;1342.2215115233141;1359.9728005439836;1362.7410791949499;1365.2286458151113;27994.16017519478;28171.71828281773;29147.271318216364;29575.704242957294;29599.112026639235;45174.54825451835;53785;55493.167602485184;55872.44127558672;55892.44107558872;395797;401267;401655.9917200395;404037;404712;42916;43106.78446607747;43196.78401607972;43227.135457291304;43905;48175.27737083876;48520.27219591638;49183.50816491789;49568.256476153605;49641.50358496369;39122.804385977885;39632;40280.3957940637;41917.161656767305;42104;38074;38584.6141538581;38751.6124838748;39805.80097099496;40160.1967960645;36897.26205475929;40543.1891362177;41580;44291.55708443003;45510.30507830723;33415.33169336648;35673.82163089168;35925.28149436945;35931;36507.634923650425;25957.74042259629;26143;26266.767324777607;26392.340191495365;26466.338341540846 09:22:52 INFO - PROCESS | 28478 | |2;jquery.html;400.40539798399374;403.79406502683634;404.4216770018872;407.124681933842;412.6121445840909;18006.72989905151;18613.162407691652;18667.71998420025;18762.43712688618;19331.51671208217;17944.57748203992;18140.63718725625;18907.338243161492;18911.90544047278;18948.242070317207;5487.368952570456;5655.293088363955;5678.829635110933;5722.113072473773;5747.281589801275;5430.15832545956;5588.189712491686;5608.887822243552;5617.325920889479;5623.353314368859;5549.334079910416;5557.3331200255825;5648.774049038054;5670.574706896979;5672.149177623348;5630.859228519279;5643.153526970947;5669.801556945528;5673.546116310686;5731.455511726379;4961.627877909171;5034.219695947134;5056.570191533688;5063.721495317756;5087.79648814047;21869.453263668376;22230.11079556816;22517.21189758367;22659.20692775745;22762.54474910509;2394.892229849661;2473.51766405551;2476.8018558515278;2501.124606387768;2722.768564672005;9172;9805.754856128653;9853.605855765762;10213.897861021369;13605.931970340183;1809.80092189859;1850.824171703686;1889.5087277307862;1935.5064458563118;1949.9317523886739;76617;79793;79865;80233.59883200664;80365;10711.410872401937;10928.398938058483;10941.726456838484;10984.670459886216;11002.669919902255;15461.304241308942;15492.07047577149;15492.845071549365;15529.922350388175;15612.29744661493;7727.806804829812;7859;7860.135385107634;7958.840823183504;8000.839878217742;7387.556746595222;7417;7424.220456852061;7518.097828260644;7528.473006889575;4603.332516785047;4789.760511974388;4807.086653535817;4833.637477189154;4870;1888.3202047262973;1917.1947781931344;1931.0923865783059;1944.3389247655582;2020.4342784020498;906.8231694819578;1031.8194315994822;1033.4987531047436;1087.8803331633515;1135.937523436219;18655;18702.81297187038;18786.342478013205;18982.71525927112;19639.705404418946;1000.0599436529639;1033.6330602636106;1035.2028937717914;1052.984205236922;1101.5648818716722;10069.949650251701;10422.739431514121;10612.151027917747;10704.571817127384;10837.295575787548;457712;472341.8297451082;472823;474554;485716;86755;87591;88238;88841.11158888458;89464;1065.5098654618807;1088.5591335509132;1097.846301517788;1110.655696734015;1111.9722006949892;16540.338386464406;16871.409500667418;17129;17188.398406055727;17236.310547578458;34782.17396086378;35760;36491.817540912125;37172.62827371692;37983.620163798005;50697.49302506928;52285.7385713069;52919.47080529299;53093.4690653104;53628.195577067156;8308.501489910625;8359.623816928131;8482.533460659477;8583.65665373378;8644.524551149747;12789.424475898793;13324.733505330032;13448.462061517821;13508.32458377097;13739.587812365646;7816.765497035098;11774.3524106175;12028.518859245532;12229.082818788449;12283;11447.885521144683;11685.532578697097;11851.466683999068;11882.28706277626;12024.579139730067;12015.45930433115;12111.515539378679;12131.393430328624;12304.446299916704;12548.24710517372;8389.496630202208;8427.157284271523;8508.234258916727;8516;8590.570471476276;11308.378039207593;11483.885161148615;11504.769904602028;11715.941420292844;11809.586664466702 09:22:52 INFO - PROCESS | 28478 | |3;mootools.html;1535.723569757443;1537.2467490929444;1728.5160155156552;1816.3188804198426;1847.1318480314264;7348.963255183717;8072.152423995477;8246.628901699423;8389.412741108124;8412.789680257996;8172.795680108;8175.223353781396;8195.59022048898;8235.052968908578;8241.052278987918;2301.309607117866;2331.067572970817;2339.7543257957923;2341.0401735288533;2341.496578235679;2259.638457846745;2273.6703178039174;2285.6114460541667;2288.061894623205;2296.115995341797;2241.7870302321335;2259.8531095478743;2298.230092918866;2303.170858490942;2348.3307257431634;2269.1604106480545;2276.1350686739097;2280.1221529711015;2284.383216531544;2285.0174424997163;2253.267688001406;2262.7058482397183;2267.7845604667696;2273.624851899435;2274.6019446596947;8314.916850831474;8453.450525715809;8455.74632761018;8473.49159050459;8517.701880434155;5048.974755126237;5229.738513074369;5239.266502689627;5245.947540524622;5250.9737451312885;3158.09994151668;3196.4246435641576;3216.212028053142;3221.903342899717;3222.452183128874;1109.9500522476508;1110.5502271580024;1117.3072694929115;1144.1361771862273;1149.0979581028935;11260.155488338325;11408.486618102288;11421.31472111676;11433.771324573461;11467.19729618927;4473.485549161823;4526.728396296233;4663.533646635377;4741.715497070187;4752.358431611758;9691.951540242253;9746.512674366253;9763.365381250196;9791.46146961924;9812.067853554045;5149.253358263031;5169.172932330885;5181.792728290901;5188.818391356284;5215.713135777492;4085.346344584852;4775.140474714584;4796.784144713496;4868.464468908417;4894.363732714724;3871.9612803872164;3874.8643797466952;3960.148568057824;3967.147063381387;3973.562908080109;1308.1693124865778;1313.074282630743;1328.4553333133563;1334.3728447629599;1339.5311640925597;1406.627243780399;1408.7886816977536;1411.6894283257666;1431.9427222911174;1447.9131252124696;8084;8094.271515563628;8115.9855018122735;8143.51138931666;8157.632906519221;488.1993530609803;1215.295128825279;1282.5887331816125;1307.4116647508658;1312.2716892124772;6286.968565157236;6288.622682639057;6411.455026322721;6425.967870160619;6466.030095485715;9823.508824558743;10314.381137131797;10349.94825025885;10380.636677716395;10391.636292729869;10023.448710321003;10076.305618868386;10135.594576217016;10194.847077293847;10296.845547316796;7772.300492955661;7866.252705992922;7880.487768295043;7887.369010479148;7895.68417263303;7824.061112666289;7828.217178282354;7838.725644602411;7955.5226686399;7975.361971042419;9612.038796120332;9623.807523849624;9623.845138583134;9639.373440726611;9724.367916085432;9178.219851312713;9646.469444180357;9692.321537492307;9852.359596626196;9972.30193886421;6510.283868774526;7033.542819716702;7206.56760594366;7263.164736055422;7435.256474352522;7613.885791713018;7626.618669066635;7654.961725191339;7681.846363072819;7687.5387476751575;6881.621510816954;7078.1506219254015;7110.577884423033;7136.7145314186855;7183.102112235971;7097.290270972861;7102.14774227096;7132.714691412285;7235.131784185932;7257.129144502694;7377.631118444164;7517.6241187939295;7559.584222867795;7609.353204977639;7668.693252269847;6740.224874139537;6756.493263005196;6821.93178068213;6851.725930962705;6852.486063545353;7013.263607321158;7085.185203701641;7184.209736928829;7187.604681742554;7188.568685878864 09:22:52 INFO - PROCESS | 28478 | |4;prototype.html;311.74281217995156;317.7632663665569;321.7088534875938;326.3375348043473;327.56761075380507;5922.674252916088;6024.518038556916;6054.455099041085;6059.909101363478;6060.454559089681;5948.910766338508;5955.88088238236;5972.641641501502;5973.551983601225;5977.701114944246;4325;4419.64642828573;4531.546845315475;4536.5236650151755;4547.909041819162;4514.097180563884;4524.185646583614;4539.182947069527;4548.408706868119;4556.9088618227615;4550.704204226715;4560.657950653697;4570.154521413532;4578.885527861797;4583.175028494869;4323.632491238264;4535.934055496956;4545.159145558082;4561.498235194126;4564.0871825635;3975.8807235782974;3976.9602303977167;3986.820593073319;3988.481497405348;3995.7802320872343;5723.771049158028;5752;5762.74067666956;5771.249737534135;5773.769049238025;4997.275395067732;5229.843104706865;5236.345456817898;5257.658252213594;5258.6318957672975;6227.3772622737815;6242.344553821874;6253.749850005995;6267.433141714571;6276.905846412307;4347.456567929009;4371.497277813029;4381.25518661825;4385.780710964471;4387.232234358974;6202.534809889276;6455.515836312248;6463.800418792681;6481.481481481517;6505.7397704092255;4309.224339618899;4342.435483387139;4352.73883566987;4359.847405340798;4368.694191406571;4291.978540107342;4395.296752519582;4400.777607308289;4410.051838854598;4418;5126.051680439131;5157.071727089085;5158.638895277295;5174.172132458789;5184.9740751296;6206.937930620727;6274.152989346471;6289.842753931097;6297.905531417033;6319.9368006320265;1563.78107065011;1571.1908367190906;1581.5176371206662;1595.9760603590955;1604.7432410814213;990.2869933647762;1022.2231104360591;1030.9381437113798;1038.2265212416646;1063.542676649033;5894.086416605433;5928.377520360386;5960.612560183661;6009.519238460913;6013.30846952606;6365.777197798055;6393.968030159913;6399.744010239631;6402.263739669997;6442.452391546771;5787.594868359259;5959;5980.37206093354;6004.939950600438;6014.36849130835;3428.2971990742335;3440.7591468596956;3442.141243728359;3446.293509830479;3458;6449.419552240321;6609.570377925419;6622.668866556653;6659.334066593302;6667.499937504706;6532.5753826001155;6533.020046992894;6549.443297319686;6556.737730490727;6562.179727534059;6489.7404103835315;6494.253160886558;6616.4045235929;6635.966820165868;6642.711857630407;6313.273973493107;6338.778142764981;6354.1104245406605;6388.361163883575;6391.137196478416;6106.908396374147;6311.116443697794;6324.810255692337;6328.398802113792;6336.683165841781;6591.373819487141;6615.37153970372;6640.103586015826;6642;6651.235107962646;4376.4967028790825;4399.780010999373;4444.599986001146;4446.798834576905;4463.665225108195;6178;6351;6369;6606.768763093269;6612.173478315211;6309;6363.936360636334;6384;6406.1031455597185;6421.614703117828;6197.659128747962;6388.648624325707;6389.712462939272;6390.4248617624635;6418.679066046772;6125.693715314127;6265.15420418256;6266.777978294189;6271.498280137487;6301.6534090625455;6382.138411314599;6411.8397040072505;6417.197850268716;6423.325550817097;6425.967870160619;6121.173641558333;6252.249730032425;6313.842153946188;6317.862784698798;6324.778632747832 09:22:52 INFO - PROCESS | 28478 | |5;yui.html;738.7820592925087;778.711876605656;799.2447137455104;843.5487014447268;851.9872201916972;14302.141871487705;14477.78283325751;14503.564893053212;14508.056976296533;14705.70588588229;12913.096083274175;12983.415746291415;13050;13050.347482625879;13053.543125990593;663.1180529895252;763.7823220382193;785.5404588315843;785.9764207073797;797.4378063465258;790.5414859381544;797.0833541427376;797.6889013284795;804.6982381606897;806.5160903457908;828.6768160417442;831.9001719793633;833.4041160570222;833.6582001379436;834.2783492279165;826.0459169659053;826.2563692676579;826.5908375354209;827.8096037911254;827.8675411934062;610.1031483718926;614.7387360371869;615.4737699267151;618.6504624886925;620.4601996263235;13226.669333266746;13237.735245295136;13240.271785051818;13251.271180085092;13285.202887826761;14028.579142625738;14191.787123193057;14286;14287.928560357132;14419.206943618097;11297.943510282477;11312.660620181408;11364.204505684605;11424.885751142465;11468.483918223617;3868.2650296443585;3902.3756199008308;3914.9804250978846;3964.3657014877767;3978.1844721831953;56363.436365636226;56984.715076424356;57936.71031644857;58363.70818145967;58404;11309.886901131047;11313.15151363651;11322.773544529064;11511.769764604662;11638.1271404645;20220.595588088156;20325.796742032686;20340.491487712927;20345;20665.17339306411;8215.917840821634;8283.08886022537;8444.324454043663;8461.746147615582;8486.872696909551;4760;4763.976180119077;4793.424789025269;4831;4846.8788280292565;3273.2798784267898;3378.1892345837314;3395.6604339565847;3400.6769356911054;3401.149712571857;657.5692921136567;663.4625952978104;690.126989358462;691.1844024051667;701.281186783551;680.9727610895608;751.3012898004907;765.7358211417052;774.2180397798264;790.8497385496737;9003.954980225188;9385.155336019654;9397.530123493798;9436.575354109082;9632.181264592447;695.2387136085978;696.585531608692;716.6954044531053;731.6890321613294;758.2000988956594;4529.38853254813;4580.862574122782;4584.724916505021;4596.6322694185055;4616.561426664462;62601;63293;63865.361346385944;64065.67967160134;64233;53133.46866531362;53673.46326536763;54065.72967135139;55008;56498;49360.50639493631;49496.50503494919;49745.502544974814;50394.24408633873;50672.98654026899;8773.473591584525;9032.096790320915;9077.45535267886;9188.678396256098;9210.171084602418;33977.83011084929;34245.48631770476;34808.82595587107;34945.650543495256;35477.46783798194;42969;46049.76975115103;46210.53789462197;46441.53558464507;46530;11182.384968826793;11301;11323.810999844898;11470.655880323604;11525.654230373102;12898.355082246038;13033.869661303645;13246.470141194244;13270.071095023643;13660.385282662106;12180.939095304468;12345.93827030895;12370.257784532956;12789.93605032006;12886.935565322114;11620.477078531318;11946.641600751991;12019.879801202225;12045.939770301093;12081.456334465145;11378.886211138113;11587.130965177814;11958.402079895797;11969.341686207343;11972.521099155936;9971.713562602179;10010.199184065112;10071;10344.53449594755;10518;9628.229741620793;10314.845277320695;10526.157907367546;10533.525991330562;10580.41807700553 09:22:52 INFO - PROCESS | 28478 | __end_tp_report 09:22:52 INFO - PROCESS | 28478 | __start_cc_report 09:22:52 INFO - PROCESS | 28478 | _x_x_mozilla_cycle_collect,342 09:22:52 INFO - PROCESS | 28478 | __end_cc_report 09:22:52 INFO - PROCESS | 28478 | __startTimestamp1460478172232__endTimestamp 09:22:52 INFO - PROCESS | 28478 | 09:22:52 INFO - PROCESS | 28478 | ------- Summary: start ------- 09:22:52 INFO - PROCESS | 28478 | Number of tests: 6 09:22:52 INFO - PROCESS | 28478 | 09:22:52 INFO - PROCESS | 28478 | [#0] dojo.html Cycles:165 Average:5377.92 Median:5602.78 stddev:622.73 (11.1%) stddev-sans-first:598.28 09:22:52 INFO - PROCESS | 28478 | Values: 3092.7 3164.6 3164.7 3183.6 3202.9 5348.2 5361.5 5391.8 5416.8 5433.8 5277.1 5364.1 5437.6 5438.5 5475.1 4917.5 4927.8 4939.1 5113.1 5120.7 5029.0 5050.4 5065.2 5077.5 5100.2 4728.8 4871.3 4926.2 4956.5 5048.6 4866.4 4891.0 4897.6 4906.9 4938.0 4830.3 4871.6 4877.2 4877.3 4938.0 5308.6 5324.5 5348.2 5352.5 5369.5 5688.7 5700.5 5707.1 5729.8 5734.5 5623.2 5771.8 5777.8 5781.5 5816.2 5395.7 5435.8 5435.9 5445.1 5446.8 5868.1 5890.1 5914.1 5918.3 5919.6 5602.8 5699.4 5730.5 5734.9 5807.0 5726.5 5745.1 5749.6 5754.2 5776.8 5474.2 5569.3 5577.6 5577.8 5799.0 5760.3 5795.3 5800.7 5809.3 5813.9 4277.4 4356.9 4411.8 4428.1 4465.4 3859.0 3870.6 3891.3 3912.3 3919.0 5342.7 5491.0 5499.6 5508.4 5510.6 5830.7 5847.0 5872.4 5890.1 5929.9 5425.1 5441.2 5447.8 5453.1 5478.6 4733.3 4745.4 4757.5 4788.8 4806.0 6020.3 6064.2 6064.3 6067.2 6117.1 5800.8 5824.3 5832.9 5856.9 5871.8 5926.8 5998.3 6003.2 6018.2 6091.5 5766.2 5775.7 5779.1 5779.4 5806.7 5839.5 5880.9 5888.1 5890.0 5899.1 5479.0 5651.5 5679.3 5772.6 5774.2 5623.3 5715.2 5731.4 5740.4 5826.0 5616.7 5620.0 5637.7 5643.4 5663.7 5717.6 5725.3 5755.1 5755.9 5757.7 5439.6 5556.4 5613.3 5634.1 5645.7 09:22:52 INFO - PROCESS | 28478 | 09:22:52 INFO - PROCESS | 28478 | [#1] ext.html Cycles:180 Average:54433.10 Median:40938.19 stddev:99652.04 (243.4%) stddev-sans-first:99849.72 09:22:52 INFO - PROCESS | 28478 | Values: 634.6 670.0 681.6 722.2 722.9 29255.4 38266.2 38837.0 38992.4 39114.4 41144.6 42150.0 42201.6 42202.2 42329.2 8436.2 8710.5 8736.0 8747.7 8750.0 8594.4 8695.2 8757.5 8772.6 8774.6 8702.7 8795.3 8821.7 8835.3 9041.5 8797.4 8834.2 8853.6 8854.4 8875.5 8842.5 8941.7 8957.7 8963.0 8970.4 40731.8 41218.0 41320.8 41419.8 41559.6 3311.3 3444.7 3494.5 3519.1 3856.3 27392.2 27795.0 27855.2 29483.6 32009.0 4331.4 4378.8 4380.2 4443.2 4459.8 256613.0 256625.0 259157.0 259301.0 261171.0 59483.4 60024.7 60105.7 60306.0 60605.4 71039.0 71683.6 72481.0 72505.6 72902.6 15272.7 15445.2 15537.6 15572.4 15629.7 11681.2 11829.6 11829.8 11836.8 11841.6 20410.5 20589.5 20642.3 20674.1 20689.2 7553.8 7694.8 7701.5 7783.4 7938.0 1029.8 1039.9 1099.5 1136.0 1162.3 31439.8 31568.4 31729.0 31795.8 32926.0 1068.7 1136.6 1139.1 1160.4 1167.3 14902.0 15189.0 15257.8 15567.3 15592.5 439402.0 444758.0 448428.0 449150.0 449596.0 54545.5 55111.7 55525.4 55618.2 55855.0 1334.9 1342.2 1360.0 1362.7 1365.2 27994.2 28171.7 29147.3 29575.7 29599.1 45174.5 53785.0 55493.2 55872.4 55892.4 395797.0 401267.0 401656.0 404037.0 404712.0 42916.0 43106.8 43196.8 43227.1 43905.0 48175.3 48520.3 49183.5 49568.3 49641.5 39122.8 39632.0 40280.4 41917.2 42104.0 38074.0 38584.6 38751.6 39805.8 40160.2 36897.3 40543.2 41580.0 44291.6 45510.3 33415.3 35673.8 35925.3 35931.0 36507.6 25957.7 26143.0 26266.8 26392.3 26466.3 09:22:52 INFO - PROCESS | 28478 | 09:22:52 INFO - PROCESS | 28478 | [#2] jquery.html Cycles:180 Average:27971.03 Median:2434.20 stddev:77868.22 (3198.9%) stddev-sans-first:78059.15 09:22:52 INFO - PROCESS | 28478 | Values: 400.4 403.8 404.4 407.1 412.6 18006.7 18613.2 18667.7 18762.4 19331.5 17944.6 18140.6 18907.3 18911.9 18948.2 5487.4 5655.3 5678.8 5722.1 5747.3 5430.2 5588.2 5608.9 5617.3 5623.4 5549.3 5557.3 5648.8 5670.6 5672.1 5630.9 5643.2 5669.8 5673.5 5731.5 4961.6 5034.2 5056.6 5063.7 5087.8 21869.5 22230.1 22517.2 22659.2 22762.5 2394.9 2473.5 2476.8 2501.1 2722.8 9172.0 9805.8 9853.6 10213.9 13605.9 1809.8 1850.8 1889.5 1935.5 1949.9 76617.0 79793.0 79865.0 80233.6 80365.0 10711.4 10928.4 10941.7 10984.7 11002.7 15461.3 15492.1 15492.8 15529.9 15612.3 7727.8 7859.0 7860.1 7958.8 8000.8 7387.6 7417.0 7424.2 7518.1 7528.5 4603.3 4789.8 4807.1 4833.6 4870.0 1888.3 1917.2 1931.1 1944.3 2020.4 906.8 1031.8 1033.5 1087.9 1135.9 18655.0 18702.8 18786.3 18982.7 19639.7 1000.1 1033.6 1035.2 1053.0 1101.6 10069.9 10422.7 10612.2 10704.6 10837.3 457712.0 472341.8 472823.0 474554.0 485716.0 86755.0 87591.0 88238.0 88841.1 89464.0 1065.5 1088.6 1097.8 1110.7 1112.0 16540.3 16871.4 17129.0 17188.4 17236.3 34782.2 35760.0 36491.8 37172.6 37983.6 50697.5 52285.7 52919.5 53093.5 53628.2 8308.5 8359.6 8482.5 8583.7 8644.5 12789.4 13324.7 13448.5 13508.3 13739.6 7816.8 11774.4 12028.5 12229.1 12283.0 11447.9 11685.5 11851.5 11882.3 12024.6 12015.5 12111.5 12131.4 12304.4 12548.2 8389.5 8427.2 8508.2 8516.0 8590.6 11308.4 11483.9 11504.8 11715.9 11809.6 09:22:52 INFO - PROCESS | 28478 | 09:22:52 INFO - PROCESS | 28478 | [#3] mootools.html Cycles:180 Average:5869.02 Median:5234.50 stddev:3071.58 (58.7%) stddev-sans-first:3062.93 09:22:52 INFO - PROCESS | 28478 | Values: 1535.7 1537.2 1728.5 1816.3 1847.1 7349.0 8072.2 8246.6 8389.4 8412.8 8172.8 8175.2 8195.6 8235.1 8241.1 2301.3 2331.1 2339.8 2341.0 2341.5 2259.6 2273.7 2285.6 2288.1 2296.1 2241.8 2259.9 2298.2 2303.2 2348.3 2269.2 2276.1 2280.1 2284.4 2285.0 2253.3 2262.7 2267.8 2273.6 2274.6 8314.9 8453.5 8455.7 8473.5 8517.7 5049.0 5229.7 5239.3 5245.9 5251.0 3158.1 3196.4 3216.2 3221.9 3222.5 1110.0 1110.6 1117.3 1144.1 1149.1 11260.2 11408.5 11421.3 11433.8 11467.2 4473.5 4526.7 4663.5 4741.7 4752.4 9692.0 9746.5 9763.4 9791.5 9812.1 5149.3 5169.2 5181.8 5188.8 5215.7 4085.3 4775.1 4796.8 4868.5 4894.4 3872.0 3874.9 3960.1 3967.1 3973.6 1308.2 1313.1 1328.5 1334.4 1339.5 1406.6 1408.8 1411.7 1431.9 1447.9 8084.0 8094.3 8116.0 8143.5 8157.6 488.2 1215.3 1282.6 1307.4 1312.3 6287.0 6288.6 6411.5 6426.0 6466.0 9823.5 10314.4 10349.9 10380.6 10391.6 10023.4 10076.3 10135.6 10194.8 10296.8 7772.3 7866.3 7880.5 7887.4 7895.7 7824.1 7828.2 7838.7 7955.5 7975.4 9612.0 9623.8 9623.8 9639.4 9724.4 9178.2 9646.5 9692.3 9852.4 9972.3 6510.3 7033.5 7206.6 7263.2 7435.3 7613.9 7626.6 7655.0 7681.8 7687.5 6881.6 7078.2 7110.6 7136.7 7183.1 7097.3 7102.1 7132.7 7235.1 7257.1 7377.6 7517.6 7559.6 7609.4 7668.7 6740.2 6756.5 6821.9 6851.7 6852.5 7013.3 7085.2 7184.2 7187.6 7188.6 09:22:52 INFO - PROCESS | 28478 | 09:22:52 INFO - PROCESS | 28478 | [#4] prototype.html Cycles:180 Average:5233.77 Median:5992.66 stddev:1581.29 (26.4%) stddev-sans-first:1541.97 09:22:52 INFO - PROCESS | 28478 | Values: 311.7 317.8 321.7 326.3 327.6 5922.7 6024.5 6054.5 6059.9 6060.5 5948.9 5955.9 5972.6 5973.6 5977.7 4325.0 4419.6 4531.5 4536.5 4547.9 4514.1 4524.2 4539.2 4548.4 4556.9 4550.7 4560.7 4570.2 4578.9 4583.2 4323.6 4535.9 4545.2 4561.5 4564.1 3975.9 3977.0 3986.8 3988.5 3995.8 5723.8 5752.0 5762.7 5771.2 5773.8 4997.3 5229.8 5236.3 5257.7 5258.6 6227.4 6242.3 6253.7 6267.4 6276.9 4347.5 4371.5 4381.3 4385.8 4387.2 6202.5 6455.5 6463.8 6481.5 6505.7 4309.2 4342.4 4352.7 4359.8 4368.7 4292.0 4395.3 4400.8 4410.1 4418.0 5126.1 5157.1 5158.6 5174.2 5185.0 6206.9 6274.2 6289.8 6297.9 6319.9 1563.8 1571.2 1581.5 1596.0 1604.7 990.3 1022.2 1030.9 1038.2 1063.5 5894.1 5928.4 5960.6 6009.5 6013.3 6365.8 6394.0 6399.7 6402.3 6442.5 5787.6 5959.0 5980.4 6004.9 6014.4 3428.3 3440.8 3442.1 3446.3 3458.0 6449.4 6609.6 6622.7 6659.3 6667.5 6532.6 6533.0 6549.4 6556.7 6562.2 6489.7 6494.3 6616.4 6636.0 6642.7 6313.3 6338.8 6354.1 6388.4 6391.1 6106.9 6311.1 6324.8 6328.4 6336.7 6591.4 6615.4 6640.1 6642.0 6651.2 4376.5 4399.8 4444.6 4446.8 4463.7 6178.0 6351.0 6369.0 6606.8 6612.2 6309.0 6363.9 6384.0 6406.1 6421.6 6197.7 6388.6 6389.7 6390.4 6418.7 6125.7 6265.2 6266.8 6271.5 6301.7 6382.1 6411.8 6417.2 6423.3 6426.0 6121.2 6252.2 6313.8 6317.9 6324.8 09:22:52 INFO - PROCESS | 28478 | 09:22:52 INFO - PROCESS | 28478 | [#5] yui.html Cycles:180 Average:14881.11 Median:46326.04 stddev:17406.53 (37.6%) stddev-sans-first:17422.96 09:22:52 INFO - PROCESS | 28478 | Values: 738.8 778.7 799.2 843.5 852.0 14302.1 14477.8 14503.6 14508.1 14705.7 12913.1 12983.4 13050.0 13050.3 13053.5 663.1 763.8 785.5 786.0 797.4 790.5 797.1 797.7 804.7 806.5 828.7 831.9 833.4 833.7 834.3 826.0 826.3 826.6 827.8 827.9 610.1 614.7 615.5 618.7 620.5 13226.7 13237.7 13240.3 13251.3 13285.2 14028.6 14191.8 14286.0 14287.9 14419.2 11297.9 11312.7 11364.2 11424.9 11468.5 3868.3 3902.4 3915.0 3964.4 3978.2 56363.4 56984.7 57936.7 58363.7 58404.0 11309.9 11313.2 11322.8 11511.8 11638.1 20220.6 20325.8 20340.5 20345.0 20665.2 8215.9 8283.1 8444.3 8461.7 8486.9 4760.0 4764.0 4793.4 4831.0 4846.9 3273.3 3378.2 3395.7 3400.7 3401.1 657.6 663.5 690.1 691.2 701.3 681.0 751.3 765.7 774.2 790.8 9004.0 9385.2 9397.5 9436.6 9632.2 695.2 696.6 716.7 731.7 758.2 4529.4 4580.9 4584.7 4596.6 4616.6 62601.0 63293.0 63865.4 64065.7 64233.0 53133.5 53673.5 54065.7 55008.0 56498.0 49360.5 49496.5 49745.5 50394.2 50673.0 8773.5 9032.1 9077.5 9188.7 9210.2 33977.8 34245.5 34808.8 34945.7 35477.5 42969.0 46049.8 46210.5 46441.5 46530.0 11182.4 11301.0 11323.8 11470.7 11525.7 12898.4 13033.9 13246.5 13270.1 13660.4 12180.9 12345.9 12370.3 12789.9 12886.9 11620.5 11946.6 12019.9 12045.9 12081.5 11378.9 11587.1 11958.4 11969.3 11972.5 9971.7 10010.2 10071.0 10344.5 10518.0 9628.2 10314.8 10526.2 10533.5 10580.4 09:22:52 INFO - PROCESS | 28478 | -------- Summary: end -------- 09:22:52 INFO - PROCESS | 28478 | 09:22:52 INFO - TEST-INFO | 28478: exit 0 09:22:52 INFO - TEST-OK | dromaeo_css | took 1109798ms 09:22:52 INFO - TEST-START | kraken 09:22:52 INFO - operating with platform_type : linux_ 09:22:52 INFO - Initialising browser for kraken test... 09:22:52 INFO - TEST-INFO | started process 28713 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsqv5T2/profile http://localhost:45077/getInfo.html) 09:22:56 INFO - PROCESS | 28713 | 09:22:56 INFO - PROCESS | 28713 | (process:28781): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:22:56 INFO - PROCESS | 28713 | JavaScript error: jar:file:///builds/slave/test-pgo/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 09:22:57 INFO - PROCESS | 28713 | __metrics Screen width/height:1600/1200 09:22:57 INFO - PROCESS | 28713 | colorDepth:24 09:22:57 INFO - PROCESS | 28713 | Browser inner width/height: 1024/697 09:22:57 INFO - PROCESS | 28713 | __metrics 09:22:57 ERROR - PROCESS | 28713 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 09:22:58 INFO - TEST-INFO | 28713: exit 0 09:22:58 INFO - Browser initialized. 09:22:58 INFO - Running cycle 1/1 for kraken test... 09:22:58 INFO - TEST-INFO | started process 28832 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsqv5T2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:23:00 INFO - PROCESS | 28832 | 09:23:00 INFO - PROCESS | 28832 | (process:28894): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:23:10 INFO - PROCESS | 28832 | RSS: Main: 163213312 09:23:10 INFO - PROCESS | 28832 | 09:23:13 INFO - PROCESS | 28832 | Cycle 1(1): loaded http://localhost:45077/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45077/tests/kraken/driver.html?testName=audio-beat-detection) 09:23:13 INFO - PROCESS | 28832 | RSS: Main: 167780352 09:23:13 INFO - PROCESS | 28832 | 09:23:16 INFO - PROCESS | 28832 | Cycle 1(1): loaded http://localhost:45077/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45077/tests/kraken/driver.html?testName=audio-dft) 09:23:17 INFO - PROCESS | 28832 | RSS: Main: 171319296 09:23:17 INFO - PROCESS | 28832 | 09:23:20 INFO - PROCESS | 28832 | Cycle 1(1): loaded http://localhost:45077/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45077/tests/kraken/driver.html?testName=audio-fft) 09:23:20 INFO - PROCESS | 28832 | RSS: Main: 162484224 09:23:20 INFO - PROCESS | 28832 | 09:23:22 INFO - PROCESS | 28832 | Cycle 1(1): loaded http://localhost:45077/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45077/tests/kraken/driver.html?testName=audio-oscillator) 09:23:23 INFO - PROCESS | 28832 | RSS: Main: 163061760 09:23:23 INFO - PROCESS | 28832 | 09:23:25 INFO - PROCESS | 28832 | Cycle 1(1): loaded http://localhost:45077/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45077/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:23:26 INFO - PROCESS | 28832 | RSS: Main: 163516416 09:23:26 INFO - PROCESS | 28832 | 09:23:29 INFO - PROCESS | 28832 | Cycle 1(1): loaded http://localhost:45077/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45077/tests/kraken/driver.html?testName=imaging-darkroom) 09:23:29 INFO - PROCESS | 28832 | RSS: Main: 163614720 09:23:29 INFO - PROCESS | 28832 | 09:23:33 INFO - PROCESS | 28832 | Cycle 1(1): loaded http://localhost:45077/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45077/tests/kraken/driver.html?testName=imaging-desaturate) 09:23:33 INFO - PROCESS | 28832 | RSS: Main: 163799040 09:23:33 INFO - PROCESS | 28832 | 09:23:36 INFO - PROCESS | 28832 | Cycle 1(1): loaded http://localhost:45077/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45077/tests/kraken/driver.html?testName=json-parse-financial) 09:23:37 INFO - PROCESS | 28832 | RSS: Main: 165888000 09:23:37 INFO - PROCESS | 28832 | 09:23:38 INFO - PROCESS | 28832 | Cycle 1(1): loaded http://localhost:45077/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45077/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:23:39 INFO - PROCESS | 28832 | RSS: Main: 165781504 09:23:39 INFO - PROCESS | 28832 | 09:23:41 INFO - PROCESS | 28832 | Cycle 1(1): loaded http://localhost:45077/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45077/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:23:41 INFO - PROCESS | 28832 | RSS: Main: 165695488 09:23:41 INFO - PROCESS | 28832 | 09:23:43 INFO - PROCESS | 28832 | Cycle 1(1): loaded http://localhost:45077/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45077/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:23:44 INFO - PROCESS | 28832 | RSS: Main: 165756928 09:23:44 INFO - PROCESS | 28832 | 09:23:47 INFO - PROCESS | 28832 | Cycle 1(1): loaded http://localhost:45077/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45077/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:23:47 INFO - PROCESS | 28832 | RSS: Main: 166121472 09:23:47 INFO - PROCESS | 28832 | 09:23:50 INFO - PROCESS | 28832 | Cycle 1(1): loaded http://localhost:45077/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45077/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:23:51 INFO - PROCESS | 28832 | RSS: Main: 166211584 09:23:51 INFO - PROCESS | 28832 | 09:23:52 INFO - PROCESS | 28832 | Cycle 1(1): loaded http://localhost:45077/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45077/tests/kraken/driver.html?testName=ai-astar) 09:23:53 INFO - PROCESS | 28832 | RSS: Main: 167907328 09:23:53 INFO - PROCESS | 28832 | 09:23:53 INFO - PROCESS | 28832 | __start_tp_report 09:23:53 INFO - PROCESS | 28832 | _x_x_mozilla_page_load 09:23:53 INFO - PROCESS | 28832 | _x_x_mozilla_page_load_details 09:23:53 INFO - PROCESS | 28832 | |i|pagename|runs| 09:23:53 INFO - PROCESS | 28832 | |0;ai-astar;111;103;111;110;111;121;110;113;110;110 09:23:53 INFO - PROCESS | 28832 | |1;audio-beat-detection;162;134;151;182;130;155;157;129;182;136 09:23:53 INFO - PROCESS | 28832 | |2;audio-dft;163;162;163;160;163;163;167;164;164;163 09:23:53 INFO - PROCESS | 28832 | |3;audio-fft;72;76;75;163;78;72;76;75;168;73 09:23:53 INFO - PROCESS | 28832 | |4;audio-oscillator;93;94;154;93;93;94;143;93;92;147 09:23:53 INFO - PROCESS | 28832 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;118;117;117 09:23:53 INFO - PROCESS | 28832 | |6;imaging-darkroom;146;148;146;147;147;147;146;147;147;146 09:23:53 INFO - PROCESS | 28832 | |7;imaging-desaturate;96;96;95;96;96;96;96;96;96;96 09:23:53 INFO - PROCESS | 28832 | |8;json-parse-financial;60;61;58;59;58;58;58;76;57;59 09:23:53 INFO - PROCESS | 28832 | |9;json-stringify-tinderbox;61;61;61;62;62;61;62;62;62;62 09:23:53 INFO - PROCESS | 28832 | |10;stanford-crypto-aes;79;81;80;83;80;80;80;80;81;82 09:23:53 INFO - PROCESS | 28832 | |11;stanford-crypto-ccm;132;129;137;132;135;130;137;132;161;147 09:23:53 INFO - PROCESS | 28832 | |12;stanford-crypto-pbkdf2;164;178;164;167;163;161;162;163;171;164 09:23:53 INFO - PROCESS | 28832 | |13;stanford-crypto-sha256-iterative;69;66;66;67;69;67;67;69;70;70 09:23:53 INFO - PROCESS | 28832 | __end_tp_report 09:23:53 INFO - PROCESS | 28832 | __start_cc_report 09:23:53 INFO - PROCESS | 28832 | _x_x_mozilla_cycle_collect,860 09:23:53 INFO - PROCESS | 28832 | __end_cc_report 09:23:53 INFO - PROCESS | 28832 | __startTimestamp1460478233197__endTimestamp 09:23:53 INFO - PROCESS | 28832 | 09:23:53 INFO - PROCESS | 28832 | ------- Summary: start ------- 09:23:53 INFO - PROCESS | 28832 | Number of tests: 14 09:23:53 INFO - PROCESS | 28832 | 09:23:53 INFO - PROCESS | 28832 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:4.37 (3.9%) stddev-sans-first:4.64 09:23:53 INFO - PROCESS | 28832 | Values: 111.0 103.0 111.0 110.0 111.0 121.0 110.0 113.0 110.0 110.0 09:23:53 INFO - PROCESS | 28832 | 09:23:53 INFO - PROCESS | 28832 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:156.00 stddev:19.80 (12.7%) stddev-sans-first:20.65 09:23:53 INFO - PROCESS | 28832 | Values: 162.0 134.0 151.0 182.0 130.0 155.0 157.0 129.0 182.0 136.0 09:23:53 INFO - PROCESS | 28832 | 09:23:53 INFO - PROCESS | 28832 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:1.75 (1.1%) stddev-sans-first:1.86 09:23:53 INFO - PROCESS | 28832 | Values: 163.0 162.0 163.0 160.0 163.0 163.0 167.0 164.0 164.0 163.0 09:23:53 INFO - PROCESS | 28832 | 09:23:53 INFO - PROCESS | 28832 | [#3] audio-fft Cycles:10 Average:92.80 Median:75.00 stddev:38.38 (51.2%) stddev-sans-first:39.96 09:23:53 INFO - PROCESS | 28832 | Values: 72.0 76.0 75.0 163.0 78.0 72.0 76.0 75.0 168.0 73.0 09:23:53 INFO - PROCESS | 28832 | 09:23:53 INFO - PROCESS | 28832 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:93.00 stddev:26.63 (28.6%) stddev-sans-first:27.56 09:23:53 INFO - PROCESS | 28832 | Values: 93.0 94.0 154.0 93.0 93.0 94.0 143.0 93.0 92.0 147.0 09:23:53 INFO - PROCESS | 28832 | 09:23:53 INFO - PROCESS | 28832 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:23:53 INFO - PROCESS | 28832 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 09:23:53 INFO - PROCESS | 28832 | 09:23:53 INFO - PROCESS | 28832 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 09:23:53 INFO - PROCESS | 28832 | Values: 146.0 148.0 146.0 147.0 147.0 147.0 146.0 147.0 147.0 146.0 09:23:53 INFO - PROCESS | 28832 | 09:23:53 INFO - PROCESS | 28832 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:23:53 INFO - PROCESS | 28832 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 09:23:53 INFO - PROCESS | 28832 | 09:23:53 INFO - PROCESS | 28832 | [#8] json-parse-financial Cycles:10 Average:60.40 Median:59.00 stddev:5.60 (9.5%) stddev-sans-first:5.94 09:23:53 INFO - PROCESS | 28832 | Values: 60.0 61.0 58.0 59.0 58.0 58.0 58.0 76.0 57.0 59.0 09:23:53 INFO - PROCESS | 28832 | 09:23:53 INFO - PROCESS | 28832 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 09:23:53 INFO - PROCESS | 28832 | Values: 61.0 61.0 61.0 62.0 62.0 61.0 62.0 62.0 62.0 62.0 09:23:53 INFO - PROCESS | 28832 | 09:23:53 INFO - PROCESS | 28832 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.50 stddev:1.17 (1.5%) stddev-sans-first:1.09 09:23:53 INFO - PROCESS | 28832 | Values: 79.0 81.0 80.0 83.0 80.0 80.0 80.0 80.0 81.0 82.0 09:23:53 INFO - PROCESS | 28832 | 09:23:53 INFO - PROCESS | 28832 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:136.00 stddev:9.82 (7.2%) stddev-sans-first:10.23 09:23:53 INFO - PROCESS | 28832 | Values: 132.0 129.0 137.0 132.0 135.0 130.0 137.0 132.0 161.0 147.0 09:23:53 INFO - PROCESS | 28832 | 09:23:53 INFO - PROCESS | 28832 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.70 Median:164.00 stddev:5.17 (3.1%) stddev-sans-first:5.44 09:23:53 INFO - PROCESS | 28832 | Values: 164.0 178.0 164.0 167.0 163.0 161.0 162.0 163.0 171.0 164.0 09:23:53 INFO - PROCESS | 28832 | 09:23:53 INFO - PROCESS | 28832 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:69.00 stddev:1.56 (2.3%) stddev-sans-first:1.62 09:23:53 INFO - PROCESS | 28832 | Values: 69.0 66.0 66.0 67.0 69.0 67.0 67.0 69.0 70.0 70.0 09:23:53 INFO - PROCESS | 28832 | -------- Summary: end -------- 09:23:53 INFO - PROCESS | 28832 | 09:23:54 INFO - TEST-INFO | 28832: exit 0 09:23:54 INFO - TEST-OK | kraken | took 61266ms 09:23:54 INFO - SUITE-END | took 1171s 09:23:54 INFO - Completed test suite (00:19:31) 09:23:54 INFO - javascript benchmark 09:23:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3092.7216550510448, 3164.572782674338, 3164.66770989046, 3183.6179658440974, 3202.8718851245935, 5348.224507446423, 5361.463853614637, 5391.811286604965, 5416.783328666848, 5433.782648694048, 5277.102892508273, 5364.141737322029, 5437.592180586452, 5438.53772429343, 5475.069238229501, 4917.532834380737, 4927.802887884481, 4939.086269040239, 5113.079645663779, 5120.718360490171, 5028.974855125737, 5050.368703912011, 5065.189569668853, 5077.466865979056, 5100.15847385181, 4728.787204575802, 4871.342368780222, 4926.162552366106, 4956.529129732669, 5048.570871475929, 4866.416030076378, 4891.046245982035, 4897.583705385046, 4906.852794416173, 4937.975310123462, 4830.3479030331155, 4871.585915197213, 4877.244027175793, 4877.268409738567, 4938.037082768861, 5308.628396012281, 5324.494173053554, 5348.224507446398, 5352.464753524655, 5369.4630536946, 5688.715564221772, 5700.543956483513, 5707.086866101446, 5729.799457018984, 5734.541236701054, 5623.212750214973, 5771.797987070432, 5777.826665200051, 5781.479666830005, 5816.156657284712, 5395.730213489349, 5435.809746658848, 5435.891282174334, 5445.101558242885, 5446.83659490212, 5868.149118377812, 5890.1164825276555, 5914.142449344821, 5918.289805223315, 5919.644821310735, 5602.775888964396, 5699.401562835926, 5730.484256416859, 5734.942650573441, 5806.970965145148, 5726.484616384545, 5745.109508026179, 5749.626274292157, 5754.1944127822135, 5776.826695199066, 5474.233607294982, 5569.303837020372, 5577.609567330329, 5577.832665020056, 5799.0, 5760.251167348218, 5795.333536643256, 5800.738966746507, 5809.2738407699035, 5813.912791308134, 4277.401163837066, 4356.934645980313, 4411.823527058882, 4428.070105277863, 4465.352523884018, 3859.0352411897024, 3870.5935876732538, 3891.3190191716335, 3912.315344814646, 3918.9804050979565, 5342.679439233659, 5491.0, 5499.642523235977, 5508.44915508446, 5510.586705997066, 5830.7084645767545, 5847.035239185572, 5872.442117998783, 5890.057590785539, 5929.851753706192, 5425.13197888336, 5441.211024401439, 5447.782088716407, 5453.127499600045, 5478.643888147258, 4733.313669517901, 4745.383100197021, 4757.452892917289, 4788.808447662054, 4806.038792241566, 6020.277566692025, 6064.241969753781, 6064.272287325549, 6067.2112625359305, 6117.082437634391, 5800.767969281266, 5824.330202026652, 5832.912506312494, 5856.853578660568, 5871.794487192928, 5926.792562260473, 5998.3401825798255, 6003.219581454383, 6018.157457955802, 6091.451769340781, 5766.163906233656, 5775.7400916957995, 5779.133130030529, 5779.422057794355, 5806.6516009037905, 5839.503642190291, 5880.882382352243, 5888.116782482662, 5890.0, 5899.056151015817, 5479.04116779554, 5651.491365777099, 5679.261695979496, 5772.624779389326, 5774.162746401832, 5623.297087864017, 5715.171300161536, 5731.426857314235, 5740.368559458373, 5826.038703613856, 5616.66300022, 5620.0, 5637.661740295432, 5643.35101463337, 5663.66018038919, 5717.571182161271, 5725.2843394575675, 5755.050416681201, 5755.884882302246, 5757.740901659352, 5439.619226654255, 5556.444355564411, 5613.270274864241, 5634.070378387684, 5645.745941432563], "value": 5335.347979595794, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.6065439427553, 669.9916625478654, 681.577421998361, 722.1586851318215, 722.9132504099509, 29255.41489170218, 38266.234675306514, 38837.0, 38992.41511377325, 39114.413283800764, 41144.58855411445, 42150.0, 42201.57798422015, 42202.155956880844, 42329.15341693172, 8436.156384361546, 8710.477371357707, 8736.039035706068, 8747.693830715927, 8750.03749587545, 8594.398392112524, 8695.21743043126, 8757.51833649149, 8772.56137193141, 8774.561271936378, 8702.651893924236, 8795.296376289882, 8821.735347939572, 8835.337349698766, 9041.457512549268, 8797.384183107186, 8834.160754728291, 8853.557322133867, 8854.380193386465, 8875.467471951704, 8842.46945183291, 8941.687040953535, 8957.731268061969, 8962.955185224033, 8970.372073954826, 40731.796341018104, 41218.0, 41320.79339603313, 41419.7929010356, 41559.584404155874, 3311.3211791582667, 3444.6727560881677, 3494.545709057806, 3519.1202199450136, 3856.3058649443087, 27392.178234652794, 27795.0, 27855.16434506968, 29483.557746633818, 32009.0, 4331.350297455376, 4378.846740364103, 4380.167768124078, 4443.2224360736745, 4459.821607135743, 256613.0, 256625.0, 259157.0, 259301.0, 261171.0, 59483.40516594865, 60024.69987650034, 60105.69947150236, 60306.0, 60605.39394606086, 71039.0, 71683.64158179176, 72481.0, 72505.6374718123, 72902.63548682223, 15272.694546109238, 15445.150516721687, 15537.611559710871, 15572.377104915902, 15629.687406252038, 11681.18231723788, 11829.645110646694, 11829.822552661717, 11836.822447663291, 11841.5855445059, 20410.48973775638, 20589.48526286825, 20642.27752028672, 20674.069666865027, 20689.17243310281, 7553.811154721066, 7694.769156925301, 7701.537907725442, 7783.377329813601, 7938.0, 1029.8043371759343, 1039.8648175737105, 1099.4612639806437, 1136.0, 1162.2503485251966, 31439.84280078585, 31568.368632627677, 31729.0, 31795.84102079521, 32926.0, 1068.7274744939991, 1136.613551392514, 1139.0887290167998, 1160.4081918221768, 1167.3054532553117, 14902.0, 15189.0, 15257.779377649762, 15567.29947152381, 15592.532224033297, 439402.0, 444758.0, 448428.0, 449150.0, 449596.0, 54545.45454545483, 55111.72444137753, 55525.44474555203, 55618.16572751412, 55855.0, 1334.9399277032558, 1342.2215115233141, 1359.9728005439836, 1362.7410791949499, 1365.2286458151113, 27994.16017519478, 28171.71828281773, 29147.271318216364, 29575.704242957294, 29599.112026639235, 45174.54825451835, 53785.0, 55493.167602485184, 55872.44127558672, 55892.44107558872, 395797.0, 401267.0, 401655.9917200395, 404037.0, 404712.0, 42916.0, 43106.78446607747, 43196.78401607972, 43227.135457291304, 43905.0, 48175.27737083876, 48520.27219591638, 49183.50816491789, 49568.256476153605, 49641.50358496369, 39122.804385977885, 39632.0, 40280.3957940637, 41917.161656767305, 42104.0, 38074.0, 38584.6141538581, 38751.6124838748, 39805.80097099496, 40160.1967960645, 36897.26205475929, 40543.1891362177, 41580.0, 44291.55708443003, 45510.30507830723, 33415.33169336648, 35673.82163089168, 35925.28149436945, 35931.0, 36507.634923650425, 25957.74042259629, 26143.0, 26266.767324777607, 26392.340191495365, 26466.338341540846], "value": 19883.92170597631, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.40539798399374, 403.79406502683634, 404.4216770018872, 407.124681933842, 412.6121445840909, 18006.72989905151, 18613.162407691652, 18667.71998420025, 18762.43712688618, 19331.51671208217, 17944.57748203992, 18140.63718725625, 18907.338243161492, 18911.90544047278, 18948.242070317207, 5487.368952570456, 5655.293088363955, 5678.829635110933, 5722.113072473773, 5747.281589801275, 5430.15832545956, 5588.189712491686, 5608.887822243552, 5617.325920889479, 5623.353314368859, 5549.334079910416, 5557.3331200255825, 5648.774049038054, 5670.574706896979, 5672.149177623348, 5630.859228519279, 5643.153526970947, 5669.801556945528, 5673.546116310686, 5731.455511726379, 4961.627877909171, 5034.219695947134, 5056.570191533688, 5063.721495317756, 5087.79648814047, 21869.453263668376, 22230.11079556816, 22517.21189758367, 22659.20692775745, 22762.54474910509, 2394.892229849661, 2473.51766405551, 2476.8018558515278, 2501.124606387768, 2722.768564672005, 9172.0, 9805.754856128653, 9853.605855765762, 10213.897861021369, 13605.931970340183, 1809.80092189859, 1850.824171703686, 1889.5087277307862, 1935.5064458563118, 1949.9317523886739, 76617.0, 79793.0, 79865.0, 80233.59883200664, 80365.0, 10711.410872401937, 10928.398938058483, 10941.726456838484, 10984.670459886216, 11002.669919902255, 15461.304241308942, 15492.07047577149, 15492.845071549365, 15529.922350388175, 15612.29744661493, 7727.806804829812, 7859.0, 7860.135385107634, 7958.840823183504, 8000.839878217742, 7387.556746595222, 7417.0, 7424.220456852061, 7518.097828260644, 7528.473006889575, 4603.332516785047, 4789.760511974388, 4807.086653535817, 4833.637477189154, 4870.0, 1888.3202047262973, 1917.1947781931344, 1931.0923865783059, 1944.3389247655582, 2020.4342784020498, 906.8231694819578, 1031.8194315994822, 1033.4987531047436, 1087.8803331633515, 1135.937523436219, 18655.0, 18702.81297187038, 18786.342478013205, 18982.71525927112, 19639.705404418946, 1000.0599436529639, 1033.6330602636106, 1035.2028937717914, 1052.984205236922, 1101.5648818716722, 10069.949650251701, 10422.739431514121, 10612.151027917747, 10704.571817127384, 10837.295575787548, 457712.0, 472341.8297451082, 472823.0, 474554.0, 485716.0, 86755.0, 87591.0, 88238.0, 88841.11158888458, 89464.0, 1065.5098654618807, 1088.5591335509132, 1097.846301517788, 1110.655696734015, 1111.9722006949892, 16540.338386464406, 16871.409500667418, 17129.0, 17188.398406055727, 17236.310547578458, 34782.17396086378, 35760.0, 36491.817540912125, 37172.62827371692, 37983.620163798005, 50697.49302506928, 52285.7385713069, 52919.47080529299, 53093.4690653104, 53628.195577067156, 8308.501489910625, 8359.623816928131, 8482.533460659477, 8583.65665373378, 8644.524551149747, 12789.424475898793, 13324.733505330032, 13448.462061517821, 13508.32458377097, 13739.587812365646, 7816.765497035098, 11774.3524106175, 12028.518859245532, 12229.082818788449, 12283.0, 11447.885521144683, 11685.532578697097, 11851.466683999068, 11882.28706277626, 12024.579139730067, 12015.45930433115, 12111.515539378679, 12131.393430328624, 12304.446299916704, 12548.24710517372, 8389.496630202208, 8427.157284271523, 8508.234258916727, 8516.0, 8590.570471476276, 11308.378039207593, 11483.885161148615, 11504.769904602028, 11715.941420292844, 11809.586664466702], "value": 9103.041549288193, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1535.723569757443, 1537.2467490929444, 1728.5160155156552, 1816.3188804198426, 1847.1318480314264, 7348.963255183717, 8072.152423995477, 8246.628901699423, 8389.412741108124, 8412.789680257996, 8172.795680108, 8175.223353781396, 8195.59022048898, 8235.052968908578, 8241.052278987918, 2301.309607117866, 2331.067572970817, 2339.7543257957923, 2341.0401735288533, 2341.496578235679, 2259.638457846745, 2273.6703178039174, 2285.6114460541667, 2288.061894623205, 2296.115995341797, 2241.7870302321335, 2259.8531095478743, 2298.230092918866, 2303.170858490942, 2348.3307257431634, 2269.1604106480545, 2276.1350686739097, 2280.1221529711015, 2284.383216531544, 2285.0174424997163, 2253.267688001406, 2262.7058482397183, 2267.7845604667696, 2273.624851899435, 2274.6019446596947, 8314.916850831474, 8453.450525715809, 8455.74632761018, 8473.49159050459, 8517.701880434155, 5048.974755126237, 5229.738513074369, 5239.266502689627, 5245.947540524622, 5250.9737451312885, 3158.09994151668, 3196.4246435641576, 3216.212028053142, 3221.903342899717, 3222.452183128874, 1109.9500522476508, 1110.5502271580024, 1117.3072694929115, 1144.1361771862273, 1149.0979581028935, 11260.155488338325, 11408.486618102288, 11421.31472111676, 11433.771324573461, 11467.19729618927, 4473.485549161823, 4526.728396296233, 4663.533646635377, 4741.715497070187, 4752.358431611758, 9691.951540242253, 9746.512674366253, 9763.365381250196, 9791.46146961924, 9812.067853554045, 5149.253358263031, 5169.172932330885, 5181.792728290901, 5188.818391356284, 5215.713135777492, 4085.346344584852, 4775.140474714584, 4796.784144713496, 4868.464468908417, 4894.363732714724, 3871.9612803872164, 3874.8643797466952, 3960.148568057824, 3967.147063381387, 3973.562908080109, 1308.1693124865778, 1313.074282630743, 1328.4553333133563, 1334.3728447629599, 1339.5311640925597, 1406.627243780399, 1408.7886816977536, 1411.6894283257666, 1431.9427222911174, 1447.9131252124696, 8084.0, 8094.271515563628, 8115.9855018122735, 8143.51138931666, 8157.632906519221, 488.1993530609803, 1215.295128825279, 1282.5887331816125, 1307.4116647508658, 1312.2716892124772, 6286.968565157236, 6288.622682639057, 6411.455026322721, 6425.967870160619, 6466.030095485715, 9823.508824558743, 10314.381137131797, 10349.94825025885, 10380.636677716395, 10391.636292729869, 10023.448710321003, 10076.305618868386, 10135.594576217016, 10194.847077293847, 10296.845547316796, 7772.300492955661, 7866.252705992922, 7880.487768295043, 7887.369010479148, 7895.68417263303, 7824.061112666289, 7828.217178282354, 7838.725644602411, 7955.5226686399, 7975.361971042419, 9612.038796120332, 9623.807523849624, 9623.845138583134, 9639.373440726611, 9724.367916085432, 9178.219851312713, 9646.469444180357, 9692.321537492307, 9852.359596626196, 9972.30193886421, 6510.283868774526, 7033.542819716702, 7206.56760594366, 7263.164736055422, 7435.256474352522, 7613.885791713018, 7626.618669066635, 7654.961725191339, 7681.846363072819, 7687.5387476751575, 6881.621510816954, 7078.1506219254015, 7110.577884423033, 7136.7145314186855, 7183.102112235971, 7097.290270972861, 7102.14774227096, 7132.714691412285, 7235.131784185932, 7257.129144502694, 7377.631118444164, 7517.6241187939295, 7559.584222867795, 7609.353204977639, 7668.693252269847, 6740.224874139537, 6756.493263005196, 6821.93178068213, 6851.725930962705, 6852.486063545353, 7013.263607321158, 7085.185203701641, 7184.209736928829, 7187.604681742554, 7188.568685878864], "value": 4811.649485434681, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.74281217995156, 317.7632663665569, 321.7088534875938, 326.3375348043473, 327.56761075380507, 5922.674252916088, 6024.518038556916, 6054.455099041085, 6059.909101363478, 6060.454559089681, 5948.910766338508, 5955.88088238236, 5972.641641501502, 5973.551983601225, 5977.701114944246, 4325.0, 4419.64642828573, 4531.546845315475, 4536.5236650151755, 4547.909041819162, 4514.097180563884, 4524.185646583614, 4539.182947069527, 4548.408706868119, 4556.9088618227615, 4550.704204226715, 4560.657950653697, 4570.154521413532, 4578.885527861797, 4583.175028494869, 4323.632491238264, 4535.934055496956, 4545.159145558082, 4561.498235194126, 4564.0871825635, 3975.8807235782974, 3976.9602303977167, 3986.820593073319, 3988.481497405348, 3995.7802320872343, 5723.771049158028, 5752.0, 5762.74067666956, 5771.249737534135, 5773.769049238025, 4997.275395067732, 5229.843104706865, 5236.345456817898, 5257.658252213594, 5258.6318957672975, 6227.3772622737815, 6242.344553821874, 6253.749850005995, 6267.433141714571, 6276.905846412307, 4347.456567929009, 4371.497277813029, 4381.25518661825, 4385.780710964471, 4387.232234358974, 6202.534809889276, 6455.515836312248, 6463.800418792681, 6481.481481481517, 6505.7397704092255, 4309.224339618899, 4342.435483387139, 4352.73883566987, 4359.847405340798, 4368.694191406571, 4291.978540107342, 4395.296752519582, 4400.777607308289, 4410.051838854598, 4418.0, 5126.051680439131, 5157.071727089085, 5158.638895277295, 5174.172132458789, 5184.9740751296, 6206.937930620727, 6274.152989346471, 6289.842753931097, 6297.905531417033, 6319.9368006320265, 1563.78107065011, 1571.1908367190906, 1581.5176371206662, 1595.9760603590955, 1604.7432410814213, 990.2869933647762, 1022.2231104360591, 1030.9381437113798, 1038.2265212416646, 1063.542676649033, 5894.086416605433, 5928.377520360386, 5960.612560183661, 6009.519238460913, 6013.30846952606, 6365.777197798055, 6393.968030159913, 6399.744010239631, 6402.263739669997, 6442.452391546771, 5787.594868359259, 5959.0, 5980.37206093354, 6004.939950600438, 6014.36849130835, 3428.2971990742335, 3440.7591468596956, 3442.141243728359, 3446.293509830479, 3458.0, 6449.419552240321, 6609.570377925419, 6622.668866556653, 6659.334066593302, 6667.499937504706, 6532.5753826001155, 6533.020046992894, 6549.443297319686, 6556.737730490727, 6562.179727534059, 6489.7404103835315, 6494.253160886558, 6616.4045235929, 6635.966820165868, 6642.711857630407, 6313.273973493107, 6338.778142764981, 6354.1104245406605, 6388.361163883575, 6391.137196478416, 6106.908396374147, 6311.116443697794, 6324.810255692337, 6328.398802113792, 6336.683165841781, 6591.373819487141, 6615.37153970372, 6640.103586015826, 6642.0, 6651.235107962646, 4376.4967028790825, 4399.780010999373, 4444.599986001146, 4446.798834576905, 4463.665225108195, 6178.0, 6351.0, 6369.0, 6606.768763093269, 6612.173478315211, 6309.0, 6363.936360636334, 6384.0, 6406.1031455597185, 6421.614703117828, 6197.659128747962, 6388.648624325707, 6389.712462939272, 6390.4248617624635, 6418.679066046772, 6125.693715314127, 6265.15420418256, 6266.777978294189, 6271.498280137487, 6301.6534090625455, 6382.138411314599, 6411.8397040072505, 6417.197850268716, 6423.325550817097, 6425.967870160619, 6121.173641558333, 6252.249730032425, 6313.842153946188, 6317.862784698798, 6324.778632747832], "value": 4712.885976897908, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.7820592925087, 778.711876605656, 799.2447137455104, 843.5487014447268, 851.9872201916972, 14302.141871487705, 14477.78283325751, 14503.564893053212, 14508.056976296533, 14705.70588588229, 12913.096083274175, 12983.415746291415, 13050.0, 13050.347482625879, 13053.543125990593, 663.1180529895252, 763.7823220382193, 785.5404588315843, 785.9764207073797, 797.4378063465258, 790.5414859381544, 797.0833541427376, 797.6889013284795, 804.6982381606897, 806.5160903457908, 828.6768160417442, 831.9001719793633, 833.4041160570222, 833.6582001379436, 834.2783492279165, 826.0459169659053, 826.2563692676579, 826.5908375354209, 827.8096037911254, 827.8675411934062, 610.1031483718926, 614.7387360371869, 615.4737699267151, 618.6504624886925, 620.4601996263235, 13226.669333266746, 13237.735245295136, 13240.271785051818, 13251.271180085092, 13285.202887826761, 14028.579142625738, 14191.787123193057, 14286.0, 14287.928560357132, 14419.206943618097, 11297.943510282477, 11312.660620181408, 11364.204505684605, 11424.885751142465, 11468.483918223617, 3868.2650296443585, 3902.3756199008308, 3914.9804250978846, 3964.3657014877767, 3978.1844721831953, 56363.436365636226, 56984.715076424356, 57936.71031644857, 58363.70818145967, 58404.0, 11309.886901131047, 11313.15151363651, 11322.773544529064, 11511.769764604662, 11638.1271404645, 20220.595588088156, 20325.796742032686, 20340.491487712927, 20345.0, 20665.17339306411, 8215.917840821634, 8283.08886022537, 8444.324454043663, 8461.746147615582, 8486.872696909551, 4760.0, 4763.976180119077, 4793.424789025269, 4831.0, 4846.8788280292565, 3273.2798784267898, 3378.1892345837314, 3395.6604339565847, 3400.6769356911054, 3401.149712571857, 657.5692921136567, 663.4625952978104, 690.126989358462, 691.1844024051667, 701.281186783551, 680.9727610895608, 751.3012898004907, 765.7358211417052, 774.2180397798264, 790.8497385496737, 9003.954980225188, 9385.155336019654, 9397.530123493798, 9436.575354109082, 9632.181264592447, 695.2387136085978, 696.585531608692, 716.6954044531053, 731.6890321613294, 758.2000988956594, 4529.38853254813, 4580.862574122782, 4584.724916505021, 4596.6322694185055, 4616.561426664462, 62601.0, 63293.0, 63865.361346385944, 64065.67967160134, 64233.0, 53133.46866531362, 53673.46326536763, 54065.72967135139, 55008.0, 56498.0, 49360.50639493631, 49496.50503494919, 49745.502544974814, 50394.24408633873, 50672.98654026899, 8773.473591584525, 9032.096790320915, 9077.45535267886, 9188.678396256098, 9210.171084602418, 33977.83011084929, 34245.48631770476, 34808.82595587107, 34945.650543495256, 35477.46783798194, 42969.0, 46049.76975115103, 46210.53789462197, 46441.53558464507, 46530.0, 11182.384968826793, 11301.0, 11323.810999844898, 11470.655880323604, 11525.654230373102, 12898.355082246038, 13033.869661303645, 13246.470141194244, 13270.071095023643, 13660.385282662106, 12180.939095304468, 12345.93827030895, 12370.257784532956, 12789.93605032006, 12886.935565322114, 11620.477078531318, 11946.641600751991, 12019.879801202225, 12045.939770301093, 12081.456334465145, 11378.886211138113, 11587.130965177814, 11958.402079895797, 11969.341686207343, 11972.521099155936, 9971.713562602179, 10010.199184065112, 10071.0, 10344.53449594755, 10518.0, 9628.229741620793, 10314.845277320695, 10526.157907367546, 10533.525991330562, 10580.41807700553], "value": 6733.599187105002, "unit": "score"}], "name": "dromaeo_css", "value": 7268.639691429027, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 103.0, 111.0, 110.0, 111.0, 121.0, 110.0, 113.0, 110.0, 110.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 134.0, 151.0, 182.0, 130.0, 155.0, 157.0, 129.0, 182.0, 136.0], "value": 151.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 160.0, 163.0, 163.0, 167.0, 164.0, 164.0, 163.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 75.0, 163.0, 78.0, 72.0, 76.0, 75.0, 168.0, 73.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 154.0, 93.0, 93.0, 94.0, 143.0, 93.0, 92.0, 147.0], "value": 109.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 58.0, 59.0, 58.0, 58.0, 58.0, 76.0, 57.0, 59.0], "value": 60.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 80.0, 83.0, 80.0, 80.0, 80.0, 80.0, 81.0, 82.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 129.0, 137.0, 132.0, 135.0, 130.0, 137.0, 132.0, 161.0, 147.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 178.0, 164.0, 167.0, 163.0, 161.0, 162.0, 163.0, 171.0, 164.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 66.0, 67.0, 69.0, 67.0, 67.0, 69.0, 70.0, 70.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1561.6999999999998, "alertThreshold": 2.0}]} 09:23:54 INFO - Return code: 0 09:23:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:23:54 ERROR - # TBPL SUCCESS # 09:23:54 INFO - Running post-action listener: _resource_record_post_action 09:23:54 INFO - Running post-run listener: _resource_record_post_run 09:23:55 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 20480; Write bytes: 296284160; Read time: 28; Write time: 266776 09:23:55 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 5177344; Read time: 0; Write time: 524 09:23:55 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 20480; Write bytes: 291106816; Read time: 28; Write time: 266252 09:23:55 INFO - Running post-run listener: _upload_blobber_files 09:23:55 INFO - Blob upload gear active. 09:23:55 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 09:23:55 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 09:23:55 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 09:23:55 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 09:23:55 INFO - (blobuploader) - INFO - Open directory for files ... 09:23:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:23:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:23:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:23:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:23:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:23:56 INFO - (blobuploader) - INFO - Done attempting. 09:23:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:23:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:23:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:23:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:23:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:23:57 INFO - (blobuploader) - INFO - Done attempting. 09:23:57 INFO - (blobuploader) - INFO - Iteration through files over. 09:23:57 INFO - Return code: 0 09:23:57 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 09:23:57 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 09:23:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/487f1703102c1fbf32d5f77a1799a4a178b8d08b624fc8537a83d02c0987c8a611977951285c965ff15bf6d6b596de5de706ee31f523c6b45f9292cf5f53e66b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05083d0aa90295dca61585030760a1b27022155e58982c1750659aca61545fe8433005fa705faad2a4da3be7edde3780232f6d5ea59a02481fee0744101cbf95"} 09:23:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 09:23:57 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 09:23:57 INFO - Contents: 09:23:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/487f1703102c1fbf32d5f77a1799a4a178b8d08b624fc8537a83d02c0987c8a611977951285c965ff15bf6d6b596de5de706ee31f523c6b45f9292cf5f53e66b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05083d0aa90295dca61585030760a1b27022155e58982c1750659aca61545fe8433005fa705faad2a4da3be7edde3780232f6d5ea59a02481fee0744101cbf95"} 09:23:57 INFO - Running post-run listener: copy_logs_to_upload_dir 09:23:57 INFO - Copying logs to upload dir... 09:23:57 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 09:23:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.708045 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-12 09:23:58.053099) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 09:23:58.056503) ========= 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=62c568580acbfdaac3eec7be000001dc-1460476112.854403-460469496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/487f1703102c1fbf32d5f77a1799a4a178b8d08b624fc8537a83d02c0987c8a611977951285c965ff15bf6d6b596de5de706ee31f523c6b45f9292cf5f53e66b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05083d0aa90295dca61585030760a1b27022155e58982c1750659aca61545fe8433005fa705faad2a4da3be7edde3780232f6d5ea59a02481fee0744101cbf95"} build_url:https://queue.taskcluster.net/v1/task/DhtbjR9YTgK4DyWkyeSGVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011484 build_url: 'https://queue.taskcluster.net/v1/task/DhtbjR9YTgK4DyWkyeSGVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/487f1703102c1fbf32d5f77a1799a4a178b8d08b624fc8537a83d02c0987c8a611977951285c965ff15bf6d6b596de5de706ee31f523c6b45f9292cf5f53e66b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05083d0aa90295dca61585030760a1b27022155e58982c1750659aca61545fe8433005fa705faad2a4da3be7edde3780232f6d5ea59a02481fee0744101cbf95"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 09:23:58.085250) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 09:23:58.085737) ========= 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=62c568580acbfdaac3eec7be000001dc-1460476112.854403-460469496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 09:23:58.169340) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 09:23:58.169715) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 09:23:58.170092) ========= ========= Total master_lag: 0.23 =========