builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1458105500.31 results: success (0) buildid: 20160315193458 builduid: 3aedcd4457cb4dd5ba2cb08936049379 revision: 7773387a9a2f1fd10e4424ea923c6185063f620b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 22:18:20.313319) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 22:18:20.313834) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-15 22:18:20.314165) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1458102853.599975-766418463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006346 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-15 22:18:20.341640) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-15 22:18:20.342412) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-15 22:18:20.357323) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 22:18:20.358026) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1458102853.599975-766418463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004650 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 22:18:20.412653) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 22:18:20.413485) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 22:18:20.414450) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 22:18:20.415173) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1458102853.599975-766418463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-15 22:18:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 17.0M=0.001s 2016-03-15 22:18:20 (17.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.152359 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 22:18:20.582660) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 22:18:20.583132) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1458102853.599975-766418463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017547 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 22:18:20.637681) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 22:18:20.638306) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7773387a9a2f1fd10e4424ea923c6185063f620b --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 7773387a9a2f1fd10e4424ea923c6185063f620b --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=b5f16d05e5ea93ddf675e67e000001bf-1458102853.599975-766418463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-15 22:18:20,944 truncating revision to first 12 chars 2016-03-15 22:18:20,945 Setting DEBUG logging. 2016-03-15 22:18:20,945 attempt 1/10 2016-03-15 22:18:20,945 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7773387a9a2f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-15 22:18:21,609 unpacking tar archive at: mozilla-central-7773387a9a2f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.943010 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 22:18:21.598866) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 22:18:21.599301) ========= echo 7773387a9a2f1fd10e4424ea923c6185063f620b in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7773387a9a2f1fd10e4424ea923c6185063f620b'] 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=b5f16d05e5ea93ddf675e67e000001bf-1458102853.599975-766418463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 7773387a9a2f1fd10e4424ea923c6185063f620b program finished with exit code 0 elapsedTime=0.004682 script_repo_revision: '7773387a9a2f1fd10e4424ea923c6185063f620b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 22:18:21.653474) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 22:18:21.653817) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 22:18:21.664374) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-03-15 22:18:21.664896) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b5f16d05e5ea93ddf675e67e000001bf-1458102853.599975-766418463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:18:22 INFO - MultiFileLogger online at 20160315 22:18:22 in /builds/slave/test-pgo 22:18:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 22:18:22 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:18:22 INFO - {'append_to_log': False, 22:18:22 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:18:22 INFO - 'blob_upload_branch': 'Firefox', 22:18:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:18:22 INFO - 'branch': 'Firefox', 22:18:22 INFO - 'buildbot_json_path': 'buildprops.json', 22:18:22 INFO - 'config_files': ('talos/linux_config.py',), 22:18:22 INFO - 'default_actions': ('clobber', 22:18:22 INFO - 'read-buildbot-config', 22:18:22 INFO - 'download-and-extract', 22:18:22 INFO - 'populate-webroot', 22:18:22 INFO - 'create-virtualenv', 22:18:22 INFO - 'install', 22:18:22 INFO - 'run-tests'), 22:18:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:18:22 INFO - 'download_minidump_stackwalk': True, 22:18:22 INFO - 'download_symbols': 'ondemand', 22:18:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:18:22 INFO - 'tooltool.py': '/tools/tooltool.py', 22:18:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:18:22 INFO - '/tools/misc-python/virtualenv.py')}, 22:18:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:18:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:18:22 INFO - 'installer_path': 'installer.exe', 22:18:22 INFO - 'log_level': 'info', 22:18:22 INFO - 'log_name': 'talos', 22:18:22 INFO - 'log_to_console': True, 22:18:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:18:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:18:22 INFO - 'opt_config_files': (), 22:18:22 INFO - 'pip_index': False, 22:18:22 INFO - 'sps_profile': False, 22:18:22 INFO - 'sps_profile_interval': 0, 22:18:22 INFO - 'suite': 'dromaeojs', 22:18:22 INFO - 'system_bits': '32', 22:18:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:18:22 INFO - 'title': 'talos-linux64-ix-007', 22:18:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:18:22 INFO - 'use_talos_json': True, 22:18:22 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:18:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:18:22 INFO - 'work_dir': 'build'} 22:18:22 INFO - ##### 22:18:22 INFO - ##### Running clobber step. 22:18:22 INFO - ##### 22:18:22 INFO - Running pre-action listener: _resource_record_pre_action 22:18:22 INFO - Running main action method: clobber 22:18:22 INFO - rmtree: /builds/slave/test-pgo/build 22:18:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:18:22 INFO - Running post-action listener: _resource_record_post_action 22:18:22 INFO - ##### 22:18:22 INFO - ##### Running read-buildbot-config step. 22:18:22 INFO - ##### 22:18:22 INFO - Running pre-action listener: _resource_record_pre_action 22:18:22 INFO - Running main action method: read_buildbot_config 22:18:22 INFO - Using buildbot properties: 22:18:22 INFO - { 22:18:22 INFO - "project": "", 22:18:22 INFO - "product": "firefox", 22:18:22 INFO - "script_repo_revision": "production", 22:18:22 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 22:18:22 INFO - "repository": "", 22:18:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 22:18:22 INFO - "buildid": "20160315193458", 22:18:22 INFO - "pgo_build": "True", 22:18:22 INFO - "basedir": "/builds/slave/test-pgo", 22:18:22 INFO - "buildnumber": 224, 22:18:22 INFO - "slavename": "talos-linux64-ix-007", 22:18:22 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:18:22 INFO - "platform": "ubuntu64_hw", 22:18:22 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 22:18:22 INFO - "branch": "mozilla-central", 22:18:22 INFO - "repo_path": "mozilla-central", 22:18:22 INFO - "revision": "7773387a9a2f1fd10e4424ea923c6185063f620b", 22:18:22 INFO - "stage_platform": "linux64-pgo", 22:18:22 INFO - "builduid": "3aedcd4457cb4dd5ba2cb08936049379", 22:18:22 INFO - "slavebuilddir": "test" 22:18:22 INFO - } 22:18:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/CBHuFhFRRK-nKYCTZtivvQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:18:22 INFO - Running post-action listener: _resource_record_post_action 22:18:22 INFO - ##### 22:18:22 INFO - ##### Running download-and-extract step. 22:18:22 INFO - ##### 22:18:22 INFO - Running pre-action listener: _resource_record_pre_action 22:18:22 INFO - Running main action method: download_and_extract 22:18:22 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:18: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')]} 22:18:22 INFO - https://queue.taskcluster.net/v1/task/CBHuFhFRRK-nKYCTZtivvQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:18:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CBHuFhFRRK-nKYCTZtivvQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:18:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CBHuFhFRRK-nKYCTZtivvQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:18:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CBHuFhFRRK-nKYCTZtivvQ/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 22:18:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CBHuFhFRRK-nKYCTZtivvQ/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 22:18:23 INFO - Downloaded 1361 bytes. 22:18:23 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:18:23 INFO - Using the following test package requirements: 22:18:23 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:18:23 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:18:23 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:18:23 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:23 INFO - u'jsshell-linux-x86_64.zip'], 22:18:23 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:18:23 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:18:23 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:18:23 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:18:23 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:18:23 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:18:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:18:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:18:23 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')]} 22:18:23 INFO - https://queue.taskcluster.net/v1/task/CBHuFhFRRK-nKYCTZtivvQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:18:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CBHuFhFRRK-nKYCTZtivvQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:18:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CBHuFhFRRK-nKYCTZtivvQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:18:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CBHuFhFRRK-nKYCTZtivvQ/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 22:18:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CBHuFhFRRK-nKYCTZtivvQ/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 22:18:24 INFO - Downloaded 23562370 bytes. 22:18:24 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'] 22:18:24 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 22:18:25 INFO - Return code: 0 22:18:25 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 22:18:25 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')]} 22:18:25 INFO - https://queue.taskcluster.net/v1/task/CBHuFhFRRK-nKYCTZtivvQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:18:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CBHuFhFRRK-nKYCTZtivvQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:18:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CBHuFhFRRK-nKYCTZtivvQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:18:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CBHuFhFRRK-nKYCTZtivvQ/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 22:18:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CBHuFhFRRK-nKYCTZtivvQ/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 22:18:27 INFO - Downloaded 23562370 bytes. 22:18: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'] 22:18: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 22:18:28 INFO - Return code: 0 22:18: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')]} 22:18:28 INFO - https://queue.taskcluster.net/v1/task/CBHuFhFRRK-nKYCTZtivvQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:18:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CBHuFhFRRK-nKYCTZtivvQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:18:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CBHuFhFRRK-nKYCTZtivvQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:18:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CBHuFhFRRK-nKYCTZtivvQ/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 22:18:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CBHuFhFRRK-nKYCTZtivvQ/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 22:18:29 INFO - Downloaded 10846462 bytes. 22:18:29 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'] 22:18:29 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 22:18:29 INFO - Return code: 0 22:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:18:29 INFO - https://queue.taskcluster.net/v1/task/CBHuFhFRRK-nKYCTZtivvQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:18:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CBHuFhFRRK-nKYCTZtivvQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:18:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CBHuFhFRRK-nKYCTZtivvQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:18:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CBHuFhFRRK-nKYCTZtivvQ/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 22:18:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CBHuFhFRRK-nKYCTZtivvQ/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 22:18:31 INFO - Downloaded 57630820 bytes. 22:18:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CBHuFhFRRK-nKYCTZtivvQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:18:31 INFO - mkdir: /builds/slave/test-pgo/properties 22:18:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:18:31 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:18:31 INFO - Contents: 22:18:31 INFO - build_url:https://queue.taskcluster.net/v1/task/CBHuFhFRRK-nKYCTZtivvQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:18:32 INFO - Running post-action listener: _resource_record_post_action 22:18:32 INFO - Running post-action listener: set_extra_try_arguments 22:18:32 INFO - ##### 22:18:32 INFO - ##### Running populate-webroot step. 22:18:32 INFO - ##### 22:18:32 INFO - Running pre-action listener: _resource_record_pre_action 22:18:32 INFO - Running main action method: populate_webroot 22:18:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:18:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:18:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:18:32 INFO - '--tppagecycles', 22:18:32 INFO - '7'], 22:18:32 INFO - 'tests': ['tsvgm']}}, 22:18:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:18:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:18:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:18:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:18:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:18:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:18:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:18:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:18:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:18:32 INFO - 'talos_options': ['--e10s'], 22:18:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:18:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:18:32 INFO - 'tests': ['damp', 'tps']}, 22:18:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:18:32 INFO - 'talos_options': ['--e10s'], 22:18:32 INFO - 'tests': ['damp', 'tps']}, 22:18:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:18:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:18:32 INFO - 'other': {'tests': ['a11yr', 22:18:32 INFO - 'ts_paint', 22:18:32 INFO - 'tpaint', 22:18:32 INFO - 'sessionrestore', 22:18:32 INFO - 'sessionrestore_no_auto_restore', 22:18:32 INFO - 'tabpaint']}, 22:18:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:18:32 INFO - 'tests': ['a11yr', 22:18:32 INFO - 'ts_paint', 22:18:32 INFO - 'tpaint', 22:18:32 INFO - 'sessionrestore', 22:18:32 INFO - 'sessionrestore_no_auto_restore', 22:18:32 INFO - 'tabpaint']}, 22:18:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:18:32 INFO - 'tests': ['a11yr', 22:18:32 INFO - 'ts_paint', 22:18:32 INFO - 'tpaint', 22:18:32 INFO - 'sessionrestore', 22:18:32 INFO - 'sessionrestore_no_auto_restore', 22:18:32 INFO - 'tabpaint']}, 22:18:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:18:32 INFO - 'tests': ['a11yr', 22:18:32 INFO - 'ts_paint', 22:18:32 INFO - 'tpaint', 22:18:32 INFO - 'sessionrestore', 22:18:32 INFO - 'sessionrestore_no_auto_restore', 22:18:32 INFO - 'tabpaint']}, 22:18:32 INFO - 'other_l64': {'tests': ['a11yr', 22:18:32 INFO - 'ts_paint', 22:18:32 INFO - 'tpaint', 22:18:32 INFO - 'sessionrestore', 22:18:32 INFO - 'sessionrestore_no_auto_restore', 22:18:32 INFO - 'tabpaint']}, 22:18:32 INFO - 'other_nol64': {'tests': ['a11yr', 22:18:32 INFO - 'ts_paint', 22:18:32 INFO - 'tpaint', 22:18:32 INFO - 'sessionrestore', 22:18:32 INFO - 'sessionrestore_no_auto_restore', 22:18:32 INFO - 'tabpaint']}, 22:18:32 INFO - 'svgr': {'tests': ['tsvgx', 22:18:32 INFO - 'tsvgr_opacity', 22:18:32 INFO - 'tart', 22:18:32 INFO - 'tscrollx', 22:18:32 INFO - 'cart']}, 22:18:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:18:32 INFO - 'tests': ['tsvgx', 22:18:32 INFO - 'tsvgr_opacity', 22:18:32 INFO - 'tart', 22:18:32 INFO - 'tscrollx', 22:18:32 INFO - 'cart']}, 22:18:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:18:32 INFO - 'tests': ['tp5o']}, 22:18:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:18:32 INFO - 'talos_options': ['--e10s'], 22:18:32 INFO - 'tests': ['tp5o']}, 22:18:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:18:32 INFO - 'talos_options': ['--xperf_path', 22:18:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:18:32 INFO - 'tests': ['tp5n']}, 22:18:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:18:32 INFO - 'talos_options': ['--e10s', 22:18:32 INFO - '--xperf_path', 22:18:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:18:32 INFO - 'tests': ['tp5n']}}, 22:18:32 INFO - 'talos.zip': {'path': '', 22:18:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:18:32 INFO - Running post-action listener: _resource_record_post_action 22:18:32 INFO - ##### 22:18:32 INFO - ##### Running create-virtualenv step. 22:18:32 INFO - ##### 22:18:32 INFO - Running pre-action listener: _resource_record_pre_action 22:18:32 INFO - Running main action method: create_virtualenv 22:18:32 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:18:32 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 22:18:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:18:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:18:32 INFO - Using real prefix '/usr' 22:18:32 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:18:32 INFO - Installing distribute.............................................................................................................................................................................................done. 22:18:34 INFO - Installing pip.................done. 22:18:34 INFO - Return code: 0 22:18:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:18:34 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')]} 22:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:18:34 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')]} 22:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:18:34 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 0x7fad219aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ee6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257d920>, '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 0x257e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x257ecb0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1458102853.599975-766418463', '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 22:18:34 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 22:18:34 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 22:18:34 INFO - Using env: {'DISPLAY': ':0', 22:18:34 INFO - 'HOME': '/home/cltbld', 22:18:34 INFO - 'LANG': 'en_US.UTF-8', 22:18:34 INFO - 'LANGUAGE': 'en_US:en', 22:18:34 INFO - 'LOGNAME': 'cltbld', 22:18:34 INFO - 'MAIL': '/var/mail/cltbld', 22:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:18:34 INFO - 'MOZ_NO_REMOTE': '1', 22:18:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:18:34 INFO - 'NO_EM_RESTART': '1', 22:18:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:18:34 INFO - 'PWD': '/builds/slave/test-pgo', 22:18:34 INFO - 'SHELL': '/bin/bash', 22:18:34 INFO - 'SHLVL': '1', 22:18:34 INFO - 'TERM': 'linux', 22:18:34 INFO - 'TMOUT': '86400', 22:18:34 INFO - 'USER': 'cltbld', 22:18:34 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1458102853.599975-766418463', 22:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:18:34 INFO - '_': '/tools/buildbot/bin/python'} 22:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:18:35 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 22:18:35 INFO - Cleaning up... 22:18:35 INFO - Return code: 0 22:18:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:18:35 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')]} 22:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:18:35 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')]} 22:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:18:35 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 0x7fad219aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ee6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257d920>, '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 0x257e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x257ecb0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1458102853.599975-766418463', '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 22:18:35 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 22:18:35 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 22:18:35 INFO - Using env: {'DISPLAY': ':0', 22:18:35 INFO - 'HOME': '/home/cltbld', 22:18:35 INFO - 'LANG': 'en_US.UTF-8', 22:18:35 INFO - 'LANGUAGE': 'en_US:en', 22:18:35 INFO - 'LOGNAME': 'cltbld', 22:18:35 INFO - 'MAIL': '/var/mail/cltbld', 22:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:18:35 INFO - 'MOZ_NO_REMOTE': '1', 22:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:18:35 INFO - 'NO_EM_RESTART': '1', 22:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:18:35 INFO - 'PWD': '/builds/slave/test-pgo', 22:18:35 INFO - 'SHELL': '/bin/bash', 22:18:35 INFO - 'SHLVL': '1', 22:18:35 INFO - 'TERM': 'linux', 22:18:35 INFO - 'TMOUT': '86400', 22:18:35 INFO - 'USER': 'cltbld', 22:18:35 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1458102853.599975-766418463', 22:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:18:35 INFO - '_': '/tools/buildbot/bin/python'} 22:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:18:35 INFO - Downloading/unpacking psutil>=0.7.1 22:18:35 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 22:18:35 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 22:18:35 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 22:18:35 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 22:18:35 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 22:18:35 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 22:18:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:18:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:18:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:18:37 INFO - Installing collected packages: psutil 22:18:37 INFO - Running setup.py install for psutil 22:18:37 INFO - building 'psutil._psutil_linux' extension 22:18:37 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 22:18:37 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 22:18:37 INFO - building 'psutil._psutil_posix' extension 22:18:37 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 22:18:37 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 22:18:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:18:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:18:37 INFO - Successfully installed psutil 22:18:37 INFO - Cleaning up... 22:18:37 INFO - Return code: 0 22:18:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:18: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')]} 22:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:18: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')]} 22:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:18:37 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 0x7fad219aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ee6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257d920>, '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 0x257e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x257ecb0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1458102853.599975-766418463', '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 22:18:37 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 22:18:37 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 22:18:37 INFO - Using env: {'DISPLAY': ':0', 22:18:37 INFO - 'HOME': '/home/cltbld', 22:18:37 INFO - 'LANG': 'en_US.UTF-8', 22:18:37 INFO - 'LANGUAGE': 'en_US:en', 22:18:37 INFO - 'LOGNAME': 'cltbld', 22:18:37 INFO - 'MAIL': '/var/mail/cltbld', 22:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:18:37 INFO - 'MOZ_NO_REMOTE': '1', 22:18:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:18:37 INFO - 'NO_EM_RESTART': '1', 22:18:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:18:37 INFO - 'PWD': '/builds/slave/test-pgo', 22:18:37 INFO - 'SHELL': '/bin/bash', 22:18:37 INFO - 'SHLVL': '1', 22:18:37 INFO - 'TERM': 'linux', 22:18:37 INFO - 'TMOUT': '86400', 22:18:37 INFO - 'USER': 'cltbld', 22:18:37 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1458102853.599975-766418463', 22:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:18:37 INFO - '_': '/tools/buildbot/bin/python'} 22:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:18:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:18:37 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 22:18:37 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 22:18:37 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 22:18:37 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 22:18:37 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 22:18:37 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 22:18:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:18:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:18:39 INFO - Installing collected packages: mozsystemmonitor 22:18:39 INFO - Running setup.py install for mozsystemmonitor 22:18:39 INFO - Successfully installed mozsystemmonitor 22:18:39 INFO - Cleaning up... 22:18:39 INFO - Return code: 0 22:18:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:18:39 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 0x7fad219aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ee6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257d920>, '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 0x257e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x257ecb0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1458102853.599975-766418463', '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 22:18:39 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 22:18:39 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 22:18:39 INFO - Using env: {'DISPLAY': ':0', 22:18:39 INFO - 'HOME': '/home/cltbld', 22:18:39 INFO - 'LANG': 'en_US.UTF-8', 22:18:39 INFO - 'LANGUAGE': 'en_US:en', 22:18:39 INFO - 'LOGNAME': 'cltbld', 22:18:39 INFO - 'MAIL': '/var/mail/cltbld', 22:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:18:39 INFO - 'MOZ_NO_REMOTE': '1', 22:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:18:39 INFO - 'NO_EM_RESTART': '1', 22:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:18:39 INFO - 'PWD': '/builds/slave/test-pgo', 22:18:39 INFO - 'SHELL': '/bin/bash', 22:18:39 INFO - 'SHLVL': '1', 22:18:39 INFO - 'TERM': 'linux', 22:18:39 INFO - 'TMOUT': '86400', 22:18:39 INFO - 'USER': 'cltbld', 22:18:39 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1458102853.599975-766418463', 22:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:18:39 INFO - '_': '/tools/buildbot/bin/python'} 22:18:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:18:40 INFO - Downloading/unpacking blobuploader==1.2.4 22:18:40 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 22:18:40 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 22:18:40 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 22:18:40 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 22:18:40 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 22:18:40 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 22:18:42 INFO - Downloading blobuploader-1.2.4.tar.gz 22:18:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:18:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:18: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 22:18: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 22:18: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 22:18: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 22:18: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 22:18: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 22:18:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:18:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:18: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 22:18: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 22:18: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 22:18: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 22:18: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 22:18: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 22:18:42 INFO - Downloading docopt-0.6.1.tar.gz 22:18:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:18:42 INFO - Installing collected packages: blobuploader, requests, docopt 22:18:42 INFO - Running setup.py install for blobuploader 22:18:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:18:42 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:18:42 INFO - Running setup.py install for requests 22:18:43 INFO - Running setup.py install for docopt 22:18:43 INFO - Successfully installed blobuploader requests docopt 22:18:43 INFO - Cleaning up... 22:18:43 INFO - Return code: 0 22:18:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:18:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:18:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:18:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:18:43 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 0x7fad219aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ee6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257d920>, '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 0x257e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x257ecb0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1458102853.599975-766418463', '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 22:18:43 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 22:18:43 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 22:18:43 INFO - Using env: {'DISPLAY': ':0', 22:18:43 INFO - 'HOME': '/home/cltbld', 22:18:43 INFO - 'LANG': 'en_US.UTF-8', 22:18:43 INFO - 'LANGUAGE': 'en_US:en', 22:18:43 INFO - 'LOGNAME': 'cltbld', 22:18:43 INFO - 'MAIL': '/var/mail/cltbld', 22:18:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:18:43 INFO - 'MOZ_NO_REMOTE': '1', 22:18:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:18:43 INFO - 'NO_EM_RESTART': '1', 22:18:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:18:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:18:43 INFO - 'PWD': '/builds/slave/test-pgo', 22:18:43 INFO - 'SHELL': '/bin/bash', 22:18:43 INFO - 'SHLVL': '1', 22:18:43 INFO - 'TERM': 'linux', 22:18:43 INFO - 'TMOUT': '86400', 22:18:43 INFO - 'USER': 'cltbld', 22:18:43 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1458102853.599975-766418463', 22:18:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:18:43 INFO - '_': '/tools/buildbot/bin/python'} 22:18:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:18:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:18:43 INFO - Running setup.py (path:/tmp/pip-Bt31G7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:18:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:18:43 INFO - Running setup.py (path:/tmp/pip-Mw781l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:18:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:18:43 INFO - Running setup.py (path:/tmp/pip-crfu00-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:18:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:18:43 INFO - Running setup.py (path:/tmp/pip-07nkd2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:18:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:18:43 INFO - Running setup.py (path:/tmp/pip-P2ZSbg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:18:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:18:43 INFO - Running setup.py (path:/tmp/pip-jkgz8r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:18:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:18:44 INFO - Running setup.py (path:/tmp/pip-6Yrn1o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:18:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:18:44 INFO - Running setup.py (path:/tmp/pip-O8UIoQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:18:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:18:44 INFO - Running setup.py (path:/tmp/pip-d6FZod-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:18:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:18:44 INFO - Running setup.py (path:/tmp/pip-JZli7e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:18:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:18:44 INFO - Running setup.py (path:/tmp/pip-2DG4C8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:18:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:18:44 INFO - Running setup.py (path:/tmp/pip-ZikIkr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:18:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:18:44 INFO - Running setup.py (path:/tmp/pip-2Sq6eO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:18:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:18:44 INFO - Running setup.py (path:/tmp/pip-AFbDtp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:18:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:18:44 INFO - Running setup.py (path:/tmp/pip-MTNUQr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:18:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:18:44 INFO - Running setup.py (path:/tmp/pip-3zL0ru-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:18:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:18:44 INFO - Running setup.py (path:/tmp/pip-57RBCF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:18:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:18:44 INFO - Running setup.py install for manifestparser 22:18:44 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:18:44 INFO - Running setup.py install for mozcrash 22:18:45 INFO - Running setup.py install for mozdebug 22:18:45 INFO - Running setup.py install for mozdevice 22:18:45 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:18:45 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:18:45 INFO - Running setup.py install for mozfile 22:18:45 INFO - Running setup.py install for mozhttpd 22:18:45 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:18:45 INFO - Running setup.py install for mozinfo 22:18:45 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:18:45 INFO - Running setup.py install for mozInstall 22:18:45 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:18:45 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:18:45 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:18:45 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:18:45 INFO - Running setup.py install for mozleak 22:18:45 INFO - Running setup.py install for mozlog 22:18:45 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:18:45 INFO - Running setup.py install for moznetwork 22:18:45 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:18:45 INFO - Running setup.py install for mozprocess 22:18:46 INFO - Running setup.py install for mozprofile 22:18:46 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:18:46 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:18:46 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:18:46 INFO - Running setup.py install for mozrunner 22:18:46 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:18:46 INFO - Running setup.py install for mozscreenshot 22:18:46 INFO - Running setup.py install for moztest 22:18:46 INFO - Running setup.py install for mozversion 22:18:46 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:18:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:18:46 INFO - Cleaning up... 22:18:46 INFO - Return code: 0 22:18:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:18:46 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 0x7fad219aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ee6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257d920>, '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 0x257e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x257ecb0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1458102853.599975-766418463', '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 22:18:46 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 22:18:46 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 22:18:46 INFO - Using env: {'DISPLAY': ':0', 22:18:46 INFO - 'HOME': '/home/cltbld', 22:18:46 INFO - 'LANG': 'en_US.UTF-8', 22:18:46 INFO - 'LANGUAGE': 'en_US:en', 22:18:46 INFO - 'LOGNAME': 'cltbld', 22:18:46 INFO - 'MAIL': '/var/mail/cltbld', 22:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:18:46 INFO - 'MOZ_NO_REMOTE': '1', 22:18:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:18:46 INFO - 'NO_EM_RESTART': '1', 22:18:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:18:46 INFO - 'PWD': '/builds/slave/test-pgo', 22:18:46 INFO - 'SHELL': '/bin/bash', 22:18:46 INFO - 'SHLVL': '1', 22:18:46 INFO - 'TERM': 'linux', 22:18:46 INFO - 'TMOUT': '86400', 22:18:46 INFO - 'USER': 'cltbld', 22:18:46 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1458102853.599975-766418463', 22:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:18:46 INFO - '_': '/tools/buildbot/bin/python'} 22:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:18:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:18:46 INFO - Running setup.py (path:/tmp/pip-G5hQed-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:18:46 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)) 22:18:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:18:46 INFO - Running setup.py (path:/tmp/pip-utAW7E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:18:46 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)) 22:18:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:18:46 INFO - Running setup.py (path:/tmp/pip-Ncuqb7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:18:47 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)) 22:18:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:18:47 INFO - Running setup.py (path:/tmp/pip-0uQECq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:18:47 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)) 22:18:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:18:47 INFO - Running setup.py (path:/tmp/pip-xmYAlU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:18:47 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)) 22:18:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:18:47 INFO - Running setup.py (path:/tmp/pip-jccEz7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:18:47 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)) 22:18:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:18:47 INFO - Running setup.py (path:/tmp/pip-3VANlX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:18:47 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)) 22:18:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:18:47 INFO - Running setup.py (path:/tmp/pip-K3NAQi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:18:47 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)) 22:18:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:18:47 INFO - Running setup.py (path:/tmp/pip-_6VXU6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:18:47 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)) 22:18:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:18:47 INFO - Running setup.py (path:/tmp/pip-GRxbAF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:18:47 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)) 22:18:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:18:47 INFO - Running setup.py (path:/tmp/pip-Jifp14-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:18:47 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)) 22:18:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:18:47 INFO - Running setup.py (path:/tmp/pip-5TlHUt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:18:47 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)) 22:18:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:18:47 INFO - Running setup.py (path:/tmp/pip-fcBylm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:18:47 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)) 22:18:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:18:47 INFO - Running setup.py (path:/tmp/pip-VPkB3E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:18:47 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)) 22:18:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:18:47 INFO - Running setup.py (path:/tmp/pip-mmfU6B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:18:47 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)) 22:18:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:18:47 INFO - Running setup.py (path:/tmp/pip-u5Txrv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:18:48 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)) 22:18:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:18:48 INFO - Running setup.py (path:/tmp/pip-pjSwIY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:18:48 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)) 22:18:48 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)) 22:18:48 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)) 22:18:48 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)) 22:18:48 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)) 22:18:48 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)) 22:18:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:18: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 22:18: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 22:18: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 22:18: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 22:18: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 22:18: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 22:18:49 INFO - Downloading blessings-1.6.tar.gz 22:18:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:18:49 INFO - Installing collected packages: blessings 22:18:50 INFO - Running setup.py install for blessings 22:18:50 INFO - Successfully installed blessings 22:18:50 INFO - Cleaning up... 22:18:50 INFO - Return code: 0 22:18:50 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:18:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:18:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:18:50 INFO - Reading from file tmpfile_stdout 22:18:50 INFO - Current package versions: 22:18:50 INFO - argparse == 1.2.1 22:18:50 INFO - blessings == 1.6 22:18:50 INFO - blobuploader == 1.2.4 22:18:50 INFO - docopt == 0.6.1 22:18:50 INFO - manifestparser == 1.1 22:18:50 INFO - mozInstall == 1.12 22:18:50 INFO - mozcrash == 0.17 22:18:50 INFO - mozdebug == 0.1 22:18:50 INFO - mozdevice == 0.48 22:18:50 INFO - mozfile == 1.2 22:18:50 INFO - mozhttpd == 0.7 22:18:50 INFO - mozinfo == 0.9 22:18:50 INFO - mozleak == 0.1 22:18:50 INFO - mozlog == 3.1 22:18:50 INFO - moznetwork == 0.27 22:18:50 INFO - mozprocess == 0.22 22:18:50 INFO - mozprofile == 0.28 22:18:50 INFO - mozrunner == 6.11 22:18:50 INFO - mozscreenshot == 0.1 22:18:50 INFO - mozsystemmonitor == 0.0 22:18:50 INFO - moztest == 0.7 22:18:50 INFO - mozversion == 1.4 22:18:50 INFO - psutil == 3.1.1 22:18:50 INFO - requests == 1.2.3 22:18:50 INFO - wsgiref == 0.1.2 22:18:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:18:50 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')]} 22:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:18:50 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')]} 22:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:18:50 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 0x7fad219aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ee6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257d920>, '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 0x257e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x257ecb0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1458102853.599975-766418463', '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 22:18:50 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 22:18:50 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 22:18:50 INFO - Using env: {'DISPLAY': ':0', 22:18:50 INFO - 'HOME': '/home/cltbld', 22:18:50 INFO - 'LANG': 'en_US.UTF-8', 22:18:50 INFO - 'LANGUAGE': 'en_US:en', 22:18:50 INFO - 'LOGNAME': 'cltbld', 22:18:50 INFO - 'MAIL': '/var/mail/cltbld', 22:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:18:50 INFO - 'MOZ_NO_REMOTE': '1', 22:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:18:50 INFO - 'NO_EM_RESTART': '1', 22:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:18:50 INFO - 'PWD': '/builds/slave/test-pgo', 22:18:50 INFO - 'SHELL': '/bin/bash', 22:18:50 INFO - 'SHLVL': '1', 22:18:50 INFO - 'TERM': 'linux', 22:18:50 INFO - 'TMOUT': '86400', 22:18:50 INFO - 'USER': 'cltbld', 22:18:50 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1458102853.599975-766418463', 22:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:18:50 INFO - '_': '/tools/buildbot/bin/python'} 22:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:18:50 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)) 22:18:50 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)) 22:18:50 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)) 22:18:50 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)) 22:18:50 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)) 22:18:50 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)) 22:18:50 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)) 22:18:50 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)) 22:18:50 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)) 22:18:50 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)) 22:18:50 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)) 22:18:50 INFO - Cleaning up... 22:18:50 INFO - Return code: 0 22:18:50 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:18:50 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')]} 22:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:18:50 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')]} 22:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:18:50 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 0x7fad219aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ee6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257d920>, '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 0x257e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x257ecb0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1458102853.599975-766418463', '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 22:18:50 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 22:18:50 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 22:18:50 INFO - Using env: {'DISPLAY': ':0', 22:18:50 INFO - 'HOME': '/home/cltbld', 22:18:50 INFO - 'LANG': 'en_US.UTF-8', 22:18:50 INFO - 'LANGUAGE': 'en_US:en', 22:18:50 INFO - 'LOGNAME': 'cltbld', 22:18:50 INFO - 'MAIL': '/var/mail/cltbld', 22:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:18:50 INFO - 'MOZ_NO_REMOTE': '1', 22:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:18:50 INFO - 'NO_EM_RESTART': '1', 22:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:18:50 INFO - 'PWD': '/builds/slave/test-pgo', 22:18:50 INFO - 'SHELL': '/bin/bash', 22:18:50 INFO - 'SHLVL': '1', 22:18:50 INFO - 'TERM': 'linux', 22:18:50 INFO - 'TMOUT': '86400', 22:18:50 INFO - 'USER': 'cltbld', 22:18:50 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1458102853.599975-766418463', 22:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:18:50 INFO - '_': '/tools/buildbot/bin/python'} 22:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:18:50 INFO - Downloading/unpacking jsonschema 22:18: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 22:18: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 22:18: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 22:18: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 22:18: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 22:18: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 22:18:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:18:52 INFO - Downloading/unpacking functools32 (from jsonschema) 22:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:18:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:18:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:18:52 INFO - Downloading functools32-3.2.3-2.tar.gz 22:18:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:18:52 INFO - warning: no files found matching '*.txt' 22:18:52 INFO - no previously-included directories found matching 'build' 22:18:52 INFO - no previously-included directories found matching 'dist' 22:18:52 INFO - no previously-included directories found matching '.git*' 22:18:52 INFO - Installing collected packages: jsonschema, functools32 22:18:52 INFO - Running setup.py install for functools32 22:18:53 INFO - warning: no files found matching '*.txt' 22:18:53 INFO - no previously-included directories found matching 'build' 22:18:53 INFO - no previously-included directories found matching 'dist' 22:18:53 INFO - no previously-included directories found matching '.git*' 22:18:53 INFO - Successfully installed jsonschema functools32 22:18:53 INFO - Cleaning up... 22:18:53 INFO - Return code: 0 22:18:53 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:18:53 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 0x7fad219aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ee6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257d920>, '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 0x257e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x257ecb0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1458102853.599975-766418463', '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 22:18:53 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 22:18:53 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 22:18:53 INFO - Using env: {'DISPLAY': ':0', 22:18:53 INFO - 'HOME': '/home/cltbld', 22:18:53 INFO - 'LANG': 'en_US.UTF-8', 22:18:53 INFO - 'LANGUAGE': 'en_US:en', 22:18:53 INFO - 'LOGNAME': 'cltbld', 22:18:53 INFO - 'MAIL': '/var/mail/cltbld', 22:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:18:53 INFO - 'MOZ_NO_REMOTE': '1', 22:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:18:53 INFO - 'NO_EM_RESTART': '1', 22:18:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:18:53 INFO - 'PWD': '/builds/slave/test-pgo', 22:18:53 INFO - 'SHELL': '/bin/bash', 22:18:53 INFO - 'SHLVL': '1', 22:18:53 INFO - 'TERM': 'linux', 22:18:53 INFO - 'TMOUT': '86400', 22:18:53 INFO - 'USER': 'cltbld', 22:18:53 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1458102853.599975-766418463', 22:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:18:53 INFO - '_': '/tools/buildbot/bin/python'} 22:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:18:53 INFO - Downloading/unpacking flake8 22:18:53 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 22:18:53 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 22:18:53 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 22:18:53 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 22:18:53 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 22:18:53 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 22:18:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:18:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:18:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:18:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:18:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:18:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:18:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:18:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:18:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:18:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:18:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:18:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:18:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:18:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:18:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:18:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:18:55 INFO - no previously-included directories found matching 'docs/_build' 22:18:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:18:55 INFO - Running setup.py install for pep8 22:18:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:18:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:18:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:18:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:18:56 INFO - no previously-included directories found matching 'docs/_build' 22:18:56 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:18:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:18:56 INFO - Cleaning up... 22:18:56 INFO - Return code: 0 22:18:56 INFO - Running post-action listener: _resource_record_post_action 22:18:56 INFO - Running post-action listener: _start_resource_monitoring 22:18:56 INFO - Starting resource monitoring. 22:18:56 INFO - ##### 22:18:56 INFO - ##### Running install step. 22:18:56 INFO - ##### 22:18:56 INFO - Running pre-action listener: _resource_record_pre_action 22:18:56 INFO - Running main action method: install 22:18:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:18:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:18:56 INFO - Reading from file tmpfile_stdout 22:18:56 INFO - Detecting whether we're running mozinstall >=1.0... 22:18:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:18:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:18:56 INFO - Reading from file tmpfile_stdout 22:18:56 INFO - Output received: 22:18:56 INFO - Usage: mozinstall [options] installer 22:18:56 INFO - Options: 22:18:56 INFO - -h, --help show this help message and exit 22:18:56 INFO - -d DEST, --destination=DEST 22:18:56 INFO - Directory to install application into. [default: 22:18:56 INFO - "/builds/slave/test-pgo"] 22:18:56 INFO - --app=APP Application being installed. [default: firefox] 22:18:56 INFO - mkdir: /builds/slave/test-pgo/build/application 22:18:56 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'] 22:18:56 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 22:19:12 INFO - Reading from file tmpfile_stdout 22:19:12 INFO - Output received: 22:19:12 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:19:12 INFO - Running post-action listener: _resource_record_post_action 22:19:12 INFO - ##### 22:19:12 INFO - ##### Running run-tests step. 22:19:12 INFO - ##### 22:19:12 INFO - Running pre-action listener: _resource_record_pre_action 22:19:12 INFO - Running main action method: run_tests 22:19:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:19:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:19:12 INFO - Python 2.7.3 22:19:12 INFO - Return code: 0 22:19:12 INFO - grabbing minidump binary from tooltool 22:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:12 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 0x257d920>, '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 0x257e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x257ecb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:19:12 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 22:19:12 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 22:19:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:19:12 INFO - Return code: 0 22:19:12 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:19:12 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:19:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:19:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:19:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:19:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:19:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:19:13 INFO - Return code: 0 22:19:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CBHuFhFRRK-nKYCTZtivvQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 22:19:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CBHuFhFRRK-nKYCTZtivvQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 22:19:13 INFO - Using env: {'DISPLAY': ':0', 22:19:13 INFO - 'HOME': '/home/cltbld', 22:19:13 INFO - 'LANG': 'en_US.UTF-8', 22:19:13 INFO - 'LANGUAGE': 'en_US:en', 22:19:13 INFO - 'LOGNAME': 'cltbld', 22:19:13 INFO - 'MAIL': '/var/mail/cltbld', 22:19:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:19:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:19:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:13 INFO - 'MOZ_NO_REMOTE': '1', 22:19:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:19:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:13 INFO - 'NO_EM_RESTART': '1', 22:19:13 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:19:13 INFO - 'PWD': '/builds/slave/test-pgo', 22:19:13 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:19:13 INFO - 'SHELL': '/bin/bash', 22:19:13 INFO - 'SHLVL': '1', 22:19:13 INFO - 'TERM': 'linux', 22:19:13 INFO - 'TMOUT': '86400', 22:19:13 INFO - 'USER': 'cltbld', 22:19:13 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1458102853.599975-766418463', 22:19:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:13 INFO - '_': '/tools/buildbot/bin/python'} 22:19:13 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CBHuFhFRRK-nKYCTZtivvQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:19:14 INFO - mozversion application_buildid: 20160315193458 22:19:14 INFO - mozversion application_changeset: 7773387a9a2f1fd10e4424ea923c6185063f620b 22:19:14 INFO - mozversion application_display_name: Nightly 22:19:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:19:14 INFO - mozversion application_name: Firefox 22:19:14 INFO - mozversion application_remotingname: firefox 22:19:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:19:14 INFO - mozversion application_vendor: Mozilla 22:19:14 INFO - mozversion application_version: 48.0a1 22:19:14 INFO - mozversion platform_buildid: 20160315193458 22:19:14 INFO - mozversion platform_changeset: 7773387a9a2f1fd10e4424ea923c6185063f620b 22:19:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:19:14 INFO - mozversion platform_version: 48.0a1 22:19:14 INFO - using testdate: 1458105554 22:19:14 INFO - actual date: 1458105554 22:19:14 INFO - starting webserver on 'localhost:41655' 22:19:14 INFO - SUITE-START | Running 2 tests 22:19:14 INFO - TEST-START | dromaeo_css 22:19:14 INFO - operating with platform_type : linux_ 22:19:14 INFO - Initialising browser for dromaeo_css test... 22:19:14 INFO - TEST-INFO | started process 23357 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp15SHi5/profile http://localhost:41655/getInfo.html) 22:19:18 INFO - PROCESS | 23357 | __metrics Screen width/height:1600/1200 22:19:18 INFO - PROCESS | 23357 | colorDepth:24 22:19:18 INFO - PROCESS | 23357 | Browser inner width/height: 1024/697 22:19:18 INFO - PROCESS | 23357 | __metrics 22:19:19 ERROR - PROCESS | 23357 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:19:20 INFO - TEST-INFO | 23357: exit 0 22:19:20 INFO - Browser initialized. 22:19:20 INFO - Running cycle 1/1 for dromaeo_css test... 22:19:20 INFO - TEST-INFO | started process 23450 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp15SHi5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:19:32 INFO - PROCESS | 23450 | RSS: Main: 153436160 22:19:32 INFO - PROCESS | 23450 | 22:20:22 INFO - PROCESS | 23450 | 1458105622762 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] 22:22:30 INFO - PROCESS | 23450 | Cycle 1(1): loaded http://localhost:41655/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41655/tests/dromaeo/cssquery-ext.html) 22:22:31 INFO - PROCESS | 23450 | RSS: Main: 255004672 22:22:31 INFO - PROCESS | 23450 | 22:25:33 INFO - PROCESS | 23450 | Cycle 1(1): loaded http://localhost:41655/tests/dromaeo/cssquery-ext.html (next: http://localhost:41655/tests/dromaeo/cssquery-jquery.html) 22:25:33 INFO - PROCESS | 23450 | RSS: Main: 234688512 22:25:33 INFO - PROCESS | 23450 | 22:28:35 INFO - PROCESS | 23450 | Cycle 1(1): loaded http://localhost:41655/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41655/tests/dromaeo/cssquery-mootools.html) 22:28:36 INFO - PROCESS | 23450 | RSS: Main: 236281856 22:28:36 INFO - PROCESS | 23450 | 22:31:38 INFO - PROCESS | 23450 | Cycle 1(1): loaded http://localhost:41655/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41655/tests/dromaeo/cssquery-prototype.html) 22:31:38 INFO - PROCESS | 23450 | RSS: Main: 220164096 22:31:38 INFO - PROCESS | 23450 | 22:34:41 INFO - PROCESS | 23450 | Cycle 1(1): loaded http://localhost:41655/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41655/tests/dromaeo/cssquery-yui.html) 22:34:41 INFO - PROCESS | 23450 | RSS: Main: 222691328 22:34:41 INFO - PROCESS | 23450 | 22:37:44 INFO - PROCESS | 23450 | Cycle 1(1): loaded http://localhost:41655/tests/dromaeo/cssquery-yui.html (next: http://localhost:41655/tests/dromaeo/cssquery-dojo.html) 22:37:44 INFO - PROCESS | 23450 | RSS: Main: 269737984 22:37:44 INFO - PROCESS | 23450 | 22:37:44 INFO - PROCESS | 23450 | __start_tp_report 22:37:44 INFO - PROCESS | 23450 | _x_x_mozilla_page_load 22:37:44 INFO - PROCESS | 23450 | _x_x_mozilla_page_load_details 22:37:44 INFO - PROCESS | 23450 | |i|pagename|runs| 22:37:44 INFO - PROCESS | 23450 | |0;dojo.html;3021.6978302169787;3039.6960303969618;3067.6472205696336;3080.938381232374;3136.6392864820555;5186.170212765958;5199.870003249921;5208.401033881105;5230.241614965832;5253.3170687810625;5353.143497040474;5360.3299587551555;5374.865628359293;5411.431799661028;5415.404305526399;4719.882002949919;4750.738709370983;4778.880527986794;4796.856094317176;4946.629002824802;4873.707577545341;4895.902081958358;4903.436104847952;4929.014197160564;4997.475265097149;4762.761861906891;4838.201696720054;4883.0233953209145;4899.5835353995135;4934.975325123387;4874.415070191564;4885.5358740919555;4904.239842824368;4909.459959404463;4926.802927882881;4697.342372067913;4850.005748821483;4875.24433712775;4895.632827537949;4926.950730492721;5215.139501982168;5293.550048245904;5298.205269209611;5299.099153143975;5325.760340784674;5610.859728506779;5624.690642014688;5642.802501912413;5646.18130371098;5646.971765141189;5508.779648814043;5640.887182256373;5648.209250704905;5662.09406494963;5667.659940403548;5223.477652234784;5231.764570594332;5249.921251181236;5250.8687282817855;5298.231756395339;5723.341815691166;5725.141228815711;5728.169415434739;5731.656100633975;5737.684427356536;5503.889922201533;5518.392976772552;5522.088855338824;5528.917066244009;5606.85982850432;5605.915911261334;5611.298587676541;5618.157276408571;5634.1830434586755;5674.120511320752;5571.387147413781;5577.414371491016;5582.86042848932;5586.888262234733;5588.6646801192055;5499.972500137474;5552.833414997475;5586.245856809279;5618.4662457066515;5645.915311270334;4268.423762792046;4271.67962402821;4271.9960809209815;4281.807318670667;4305.182015417061;3822.1591249924973;3846.9807650961566;3853.9614603854166;3868.941965870514;3882.902927426837;5227.764750586232;5343.332083489564;5360.517553420133;5400.675959442446;5447.727613619303;5700.914486282709;5707.3721890592005;5709.400512946164;5717.17101020358;5724.742386592613;5367.570594352443;5370.677759334452;5378.2739330189925;5388.137897936312;5410.810621628303;4684.063187362541;4760.381150450488;4794.184988551954;4822.107910036654;4832.081904438145;5884.764609415575;5892.234009578728;5893.823185304448;5895.086261629454;5924.851878702981;5551.195076713934;5697.743601537858;5724.771009159754;5735.082386818089;5737.885242295048;5859.824205273849;5890.587658863838;5909.468147866713;5919.141724450017;5952.821415357546;5623.634463759842;5624.887502250014;5627.043402621646;5629.211910332639;5631.465010823965;5478.068728316116;5630.8029218977135;5710.942890571041;5725.685087320071;5726.398728133486;5541.141123125922;5588.161775733673;5590.7763689453595;5612.887742245214;5651.039323314964;5501.394846566955;5548.750306236309;5549.972250138723;5553.916691249554;5569.220309156641;5399.649022813504;5426.104692725656;5428.294321738149;5455.481729235875;5544.556435485071;5503.422140675331;5503.6697798130635;5528.557715382679;5529.474699903502;5567.5545956322585;5364.865878353073;5374.838754837361;5400.864978375572;5404.918926216189;5407.594430417813 22:37:44 INFO - PROCESS | 23450 | |1;ext.html;565.0725672138947;568.7554351628798;580.2311936683893;598.1476396135507;614.0727501472777;29677.554836677467;37771.433428498596;38686.613133868654;38718;38736.418953715714;41425;42105.15789684204;42205.7889710551;42214.36678449818;42249.7887510562;7649;8678.132186781319;8836.513991730451;8866.290696744278;8869;7699.653515591784;7805.960970195141;10541.209409294295;10774.892251077506;10820.891791082067;10501.579936802518;10589.364638121737;10589.78820423591;10590.311629744081;10590.682279531626;10350.327228730108;10468.476576171199;10475.319104258275;10480.266381353309;10480.94759526205;10284.43435611041;10416.218783591261;10433.582656693723;10436.32163909351;10436.634717784917;38060.429093563616;38371.616283837364;41274;41300.38049429231;41351.58648413508;1686.5362025442978;3439.2433664594;3487.337405892872;3506.333796578642;3608.0799396154075;32869.67130328714;33067.83466082678;33307.833460832786;33442;33626.83186584051;4328.156009578133;4365.738055716667;4388.297872340442;4402.581754733295;4477.126960242754;336822;340519;341171;342011;342175;63514.68242658757;64142;64153;64173;64219.67890160519;69187;69799.65100174467;70413;70458.2954170462;70490;16205.270762815702;16359.591010224602;16378.508644740677;16382;16437.58906027359;11449.599264025886;11465.025472834903;11466.656000320003;11470.426478676032;11498.770024599462;21140.260090896743;21376.465588360414;21645.783542164376;21701.240456583942;22452.887735561217;8404.28563572091;8547.529885856338;8575.742727718054;8657.783555411164;8693.695720649874;1128.3906690387264;1143.1241084874487;1156.7686462707493;1171.5840876488724;1251.3993283223922;32914.8354258232;33453.83273083668;33466.330673386394;33524.66475335264;34027.829860850536;1089.477051015517;1111.8054340490382;1143.937083460401;1190.6844686158174;1279.9360031998363;16517.174141292886;17276.13619319029;17317.30730770755;17347.21937512815;17424.39014634507;399396;402271;406831;408023;409132;57372.71313643405;57536.71231643815;57715.711421442626;57815.421845781006;57853.42146578564;1125.3979121170134;1237.7524495100836;1313.7372525494939;1330.0689517337903;1330.7471580399886;29983.85008075033;30998.496285676323;31256.68743312538;32252.516212256367;32527.349453010334;46242;53357.46642533525;54175.45824541704;54224;54345.72827135839;400518;401311;406610;406804;406882;37958.24083518369;45681.54318456906;46501.53498464972;46933.53066469292;47785.52214477811;43818.56181438272;47465;47567;47934;48022.27966580574;39312.803435983784;40284.1943161141;41059.1788164241;41234;41912.790436047624;38551.42172867353;39553.406698898965;40348.59651403566;41207.1758564821;41602.37596436116;40261.59738402579;41081.79459102685;41134.588654113075;41310.38034429546;41375.58624413717;34760.65239347574;36118.638813612575;36260.81869590635;36665.45001824921;36881.44677829781;28011.43977120487;28228.294292642848;28307.716922831332;28328.57507137436;28454.43091138124 22:37:44 INFO - PROCESS | 23450 | |2;jquery.html;359.5757006732055;365.18017051718897;365.28768900643746;371.79737043311394;373.4305184593496;17668.82331176688;18176.54558636035;18178.181981810816;18486.075696215168;18488.949323361663;17097.31610735569;17485.825141748577;18056;18058.27766889326;18083.638327233446;5529.447055294469;5654.547636189095;5668.404817494165;5696.9745445819735;5710.71446427677;4047.494063242095;5641.8589535261535;5905.350411454737;6120.693965301717;6126.050462178369;6099.57302988791;6111.144439778434;6112.541559383042;6129.264488261392;6147.231596050494;6012.18835457212;6035.788747393842;6110.694465276719;6114.938850611481;6115.938840611581;3679.4296883982756;5245.370555533361;5405.459454054602;5486.890262194734;5489;21433.785662143335;21941.670874936888;21966.560668786693;22562.661560076613;22628.54742905149;2079.8960051997337;2433.6592876997233;2528.8356256843244;2792.3856751514636;2884.6538415390078;13866;14130.293485325692;14163.858361416356;14495;14583;1969.0745349685767;1976.2589029114083;2000.7198992141111;2007.3777129090029;2050.3643870400224;73608;73988.26011739922;74325;74355.62822185854;75137.62431187808;9964.551595178234;10120.544575494121;10216;10514.894851051391;10673.306235094695;13203.47186112564;13345.466181352636;13455.645262079097;13469.932650336686;13482.932585337207;7626.656800443993;7640.121386040676;7674.386049116058;8013.078495972921;8265.917340826514;7361.192154046463;8195.098539160688;8233.670653173805;8343.916560834314;8405.285550728257;6281.3404592518045;6345;6373.458256048288;6415.877221486221;6499.1876015498065;1650.2821272746394;1751.833575810296;1759.7360395940711;1799.1184319683523;1830.9633807323778;1029.9588016479406;1128.3906690387264;1139.4587570903755;1166.731651720109;1172.7537217184315;17421.564460888578;17721.645567088843;17850.821491785176;18193.181306841223;18277;978.6427953796955;997.9550920208608;1022.6369638778127;1059.443792009186;1088.8638920134983;10889.237753357189;11186.664400068012;11187.832182517268;11214.439278036065;11217.158713096387;511736;513358;514175;514340;517642;74341.6282918582;75374;76399;76446;77189.22810771933;1080.8324709670014;1107.7950579143046;1140.3955903371227;1155.7919574476675;1158.9362585057734;17060.23228954675;17110.914445427694;17124.40064597733;17197.484075477754;17233.310667573158;36151.45772813357;36449.63550364569;37220.25559488741;38050.2389952205;38696.41955370615;49801.25298120458;49960;50063.749681251364;50200.74899625625;50823.745881270355;7969.282764551218;8156.796080097808;8177.304929081095;8180.304674102768;8184.83630327402;12500.124991250525;12557;12562.623121306375;12705;12727.87272127304;10411.427371494641;11050.392228427514;11260;11453.312801231952;11773.705657358634;11366.886331136913;11370.94314528422;11422.31466112036;11635.941820290844;11795.764084718428;11554.537818487166;11661.883381166079;11818.172727908965;11937.940310298392;12162.695932601755;8353.33173346143;8374.246317831425;8387.790305242417;8407.159284071544;8506.78733031679;10297.639582614573;11713.121515886172;11739.765204696028;11923.463444145207;11942.820857686967 22:37:44 INFO - PROCESS | 23450 | |3;mootools.html;1335.069522398336;1511.7959075524805;1522.5584580471664;1699.3542453867528;1831.7985021647617;7869.645865936032;8056.2749352558185;8090.919090809098;8098.392620553453;8103.068147163078;7811.414143939213;8006.639701213445;8006.959965200166;8009.639566219519;8009.839803203947;1969.4190213886939;2022.5247066939257;2237.966430503544;2296.5636529059466;2322.84901481404;2315.6642286868396;2327.93016209514;2328.988355058222;2329.7087864017;2332.568474832153;2247.449374903143;2276.055436993646;2286.862788232703;2289.3246492284734;2289.473421113145;2234.8882555872224;2260.7400148982915;2271.1256166375897;2281.4866655002493;2282.2696737044153;2243.9214627488122;2245.360072379364;2253.504229069602;2256.142665787007;2256.435891027243;8106.675732970674;8144.877826832602;8149.511029338259;8150.796230094235;8160.469569477965;4879.926801097987;4966.379202599675;4969.130402179604;5011.922436676132;5012.298278241049;3216.7776245026976;3244.707976282146;3304.619968703606;3365.882194123194;3391.423458012119;1049.8792638846478;1056.002078036256;1065.7282392989816;1097.9945100274447;1105.8230683090667;11616.419179041015;11672.416379181092;11681.649550513413;11696.47365868538;11696.6548846882;4243.830246790156;4390.53899340571;4435.955640443619;4442.755648439367;4450.621697155778;9772.755681107887;9793.755156121155;9843.704688859345;9843.75390615226;9846.704598862045;4996.400431948116;5023.748812559357;5038.823641172541;5042.268871013755;5043.142665746832;3890.727649064595;4465.0623369092855;4518.118966801442;4551.249043907718;4563.95436045642;3789.412641040643;3866.3040652682225;3875.8255878485534;3903.4535165076913;3911.78485183312;1154.8729639739622;1193.8746431624727;1198.2391181599746;1198.5205917632843;1216.7566486702694;1384.4531410092957;1411.7105993271355;1411.745885740556;1422.49501426994;1429.0639631041684;7753.263439973193;7904.762857114296;7939.801504962422;7946.7615971520945;7955.323797477164;1160.3791971295486;1165.5745652836822;1186.833843261944;1195.3485350484007;1201.5253974679952;6113.633182009094;6155.630662160284;6209.5032397408095;6219.595726277777;6237.937620623827;9491.240700743923;9850;9941.403515789076;9974.301798874154;10123.645672401577;9769.902300976899;10065.345752526062;10081;10101.797964040677;10103.7474063149;7845.5684937329;7936.761897143095;7982.121966583787;8008.599570021592;8019.83960320802;7576.659050342858;7610.733624323122;7635.42734294919;7646.273604007611;7702.229777022477;8785.297176226015;8924.152205540464;9012.864807027769;9117.5441227937;9118.726438206864;9308.95345523268;9314;9334.439933604006;9371;9478.763030924281;5981.431763982415;6633.3698298663485;6784.21981472137;6952.339527744856;7036.014957905795;7795.844083118192;7806;7819.374450043869;7842.843143136991;7855.489393189425;6968.0941477607585;7128.607926563881;7150;7176.856462870818;7272.127344718668;7002.474814389043;7019.333163349474;7045.542039767399;7131.0729605151;7143.535670181422;7378.778636640909;7600.619969001417;7600.771976840703;7628.237176282328;7634.198409167179;7048.330408611174;7075.327843854826;7084.326988936043;7087.291270872872;7107.786766397016;7041.788746337618;7099.43204543625;7116.928830711834;7129.180144283474;7135.643217838983 22:37:44 INFO - PROCESS | 23450 | |4;prototype.html;332.8782004644348;335.88076232937306;336.8534687410975;339.74519110667;340.13435805874064;6077.088436734481;6127.417895299945;6128.846778830526;6137.048757442598;6161.7535298588;6104.328523862383;6115.41903519166;6115.571909966293;6122.0816877468405;6127.050307202379;4428.313611390224;4563.406757121569;4607.216773148572;4669.626429885601;4686.4844867064685;4654;4655.837045703401;4680.25115981443;4680.695754775928;4687.390639216897;4654.138984287901;4667.533246675339;4674.298855171734;4682;4683.180443422404;4440.400545926291;4545.181867263875;4647.512011238805;4660.044690838404;4675.368825208588;4078.3066878630702;4078.9796051019853;4087.182563487285;4089.9386509202386;4090.2637525245445;5910.881782364371;5916.165988543522;5918.852028699274;5920.230370051909;5928.822135335947;5369.731513424353;5376.596755243372;5377.8117765878005;5380.300560927094;5383.300170977787;6358;6360.0459931010255;6361.8409539761415;6364.968175159141;6370.235571731422;4230.76730779807;4346.261135606955;4347.065380943112;4352.216601011816;4502.909941801146;6628.867422651569;6662.6668666566475;6691.364320389555;6695.966520167417;6696.799096027127;4444.155610434007;4445.022095139064;4445.466544014739;4454.732716036983;4458.219811532968;4508.0533088051225;4511.3458548510935;4511.661625378044;4517.322401639714;4519.9774001130445;5266.236395722675;5273.156294992783;5274.393444753826;5276.287701160294;5278;6279.488204718058;6403.231612206565;6442.516811239176;6442.903356449657;6488.578242414228;1588.1424031023118;1596.0423745752687;1601.639631082997;1604.478544473051;1610.3800036985845;996.5067291690659;1042.3641578637025;1049.6063976008998;1062.3466568060587;1066.424130969268;6047.879042419127;6085.995810691186;6094.177286066413;6094.299155597075;6115.296740874767;6445.097686323918;6619.338066193439;6619.933800662028;6620.668966551653;6621.172353455818;6171.506279497629;6175.96912015446;6179.938200617937;6180.505559555225;6183.350748171377;3531.152523394418;3562.447820587813;3574.8927532174075;3575.0883524701035;3577.338192434408;6655.767048153291;6810.62541560219;6816.250212476623;6822.9424439212;6887.86476192382;6669.933300667029;6703.698333575001;6704.899426508607;6719.496037797087;6723.831904202434;6861.4853885957755;6881.243063263037;6881.380675739208;6882.692288465176;6883.414909732729;6604.867902642017;6610.867782644416;6614.470842332698;6618.271990080991;6618.801435956929;6359.459445946961;6499.707513162014;6513.055606937062;6516.413522782972;6522.15212022434;6846.623435711083;6858.794236172923;6868.7252509901045;6875.965620171867;6881.277465866212;4493.932591011072;4499.5275496072445;4505.324201369821;4505.752183629801;4506.526814684542;6568.6058836469965;6572.441342485751;6572.76995305162;6582.572132811543;6588.736450541925;6262.311145774052;6401.135846660642;6403.903941440975;6404;6408.166938297992;6359.90460143089;6375.0874737577615;6377;6378.77674281398;6386.489080873612;6259.78090766821;6271.404216599416;6278;6286.717097730521;6289.308176100534;6356.872862542816;6404.775832845828;6405.3594640535575;6425.293217745951;6435.1312572803945;5914.822555323347;6036.336003039574;6190.690465476799;6257.186565746424;6263.185785847811 22:37:44 INFO - PROCESS | 23450 | |5;yui.html;725.6516871901487;833.5665453963935;844.0926004545112;856.7044369692458;884.911508849115;13710.177389356633;13904.930475347623;14345;14366.856331436682;14479.2760361982;12686.746265074693;13487.190768553894;13766.242856642906;13808;13821.308934553257;833.7707130539089;840.1052878684212;844.2612713875359;846.1284876577135;847.1020718038868;846.6571038729294;847.8431490174306;849.8682704180831;850.5109562001843;852.3862818770475;892.6875593542273;897.4391005621486;899.455829223317;900.1493588558815;902.3277658144691;887.9778005549913;888.2583043158937;888.2671795768484;888.5024386343669;890.9732708018737;649.636203725915;650.0411892458586;651.1795138125996;654.3554598720257;656.8850451171025;13107;13152.342382880914;13158.276294803782;13170.670733231746;13175.67060823487;12081.214721043105;12105.213161144586;12342.259464432163;12502.374881255992;12537.43581538833;10551.47242637865;10780.29928054674;10935.617253396093;11058.502367393407;11198.272112312674;3862.9227415451815;3872.9225415491533;3889.3388124018984;4034.7579145251084;4048.9797551012352;45948.54051459476;47328;51727;52385.2142217867;52746.47253527454;11256.943715281535;11294.94352528232;11310.491027903765;11482.253653512495;11702.239354441934;16829.242684079247;18749.625007499773;19015.524611884535;19086.904565477085;19097.427077187705;8829.293656507463;8842.778930526789;8994;9009.414388064755;9128.58921348541;4883.072216278895;4942.678725882878;5009.44896061433;5028.798848046037;5029.823956161516;3448.2241495663275;3502.124468882779;3503.964960350364;3504.5794504659602;3515.8066306353394;643.996780016097;645.6223109480912;646.2793984707112;655.3839390972471;660.4254298760013;775.1512094256892;776.5690042026729;790.1426951757293;802.4583406200791;807.858624740668;9117.498537580497;9143.54282285883;9159.496227707406;9221.49281789508;9548.522573871278;742.6806473216461;745.0554053919267;748.1882157858785;777.0752804163141;797.6051854332143;4253.532111467736;4326.329418940069;4361.781910904442;4407.958508629035;4431.689781715249;65792.34207657863;66177.33822661809;66280.33719662837;66451.66774166099;66561.33438665551;55026.44973550213;56083.43916560864;56769.71615141898;57006.7149664249;57776;48275.75862120667;49044;49130.50869491331;49214.50785492171;49532.009359813324;9313.487758173365;9352.205062569758;9452.43285402878;9716.174125199155;9837.114659680663;36034.63965360418;36676.63323366732;37065.629343707296;37505.2498950025;42058.57941420669;46289.76855115703;46612.06775864532;46804.7659761699;46853.2972005427;47236;11714.648560543197;12432.627021189379;12615.621531354074;12621.74756504883;12825.166364186298;13137.737245255232;13398;13738.65653358674;14367.85632143707;14547.27263636835;12411.069169812119;12486.500539978299;12704.936475317565;12955.222686638455;13747.793783093062;13157.342132893125;13177.47290108385;13813.861861381258;14086.084404513675;14186.787198191829;12145.514179433078;12500.812487812509;12518.186317889307;13103.475860965455;13959.720805584035;11099.667009989713;11127;11199.552017919192;11351.659450216506;11568.80367485527;10991.780164396827;11096.278741882075;11223.10215182767;11251.831222531504;11281.435928203393 22:37:44 INFO - PROCESS | 23450 | __end_tp_report 22:37:44 INFO - PROCESS | 23450 | __start_cc_report 22:37:44 INFO - PROCESS | 23450 | _x_x_mozilla_cycle_collect,787 22:37:44 INFO - PROCESS | 23450 | __end_cc_report 22:37:44 INFO - PROCESS | 23450 | __startTimestamp1458106664562__endTimestamp 22:37:44 INFO - PROCESS | 23450 | 22:37:44 INFO - PROCESS | 23450 | ------- Summary: start ------- 22:37:44 INFO - PROCESS | 23450 | Number of tests: 6 22:37:44 INFO - PROCESS | 23450 | 22:37:44 INFO - PROCESS | 23450 | [#0] dojo.html Cycles:165 Average:5257.63 Median:5447.73 stddev:594.38 (10.9%) stddev-sans-first:569.73 22:37:44 INFO - PROCESS | 23450 | Values: 3021.7 3039.7 3067.6 3080.9 3136.6 5186.2 5199.9 5208.4 5230.2 5253.3 5353.1 5360.3 5374.9 5411.4 5415.4 4719.9 4750.7 4778.9 4796.9 4946.6 4873.7 4895.9 4903.4 4929.0 4997.5 4762.8 4838.2 4883.0 4899.6 4935.0 4874.4 4885.5 4904.2 4909.5 4926.8 4697.3 4850.0 4875.2 4895.6 4927.0 5215.1 5293.6 5298.2 5299.1 5325.8 5610.9 5624.7 5642.8 5646.2 5647.0 5508.8 5640.9 5648.2 5662.1 5667.7 5223.5 5231.8 5249.9 5250.9 5298.2 5723.3 5725.1 5728.2 5731.7 5737.7 5503.9 5518.4 5522.1 5528.9 5606.9 5605.9 5611.3 5618.2 5634.2 5674.1 5571.4 5577.4 5582.9 5586.9 5588.7 5500.0 5552.8 5586.2 5618.5 5645.9 4268.4 4271.7 4272.0 4281.8 4305.2 3822.2 3847.0 3854.0 3868.9 3882.9 5227.8 5343.3 5360.5 5400.7 5447.7 5700.9 5707.4 5709.4 5717.2 5724.7 5367.6 5370.7 5378.3 5388.1 5410.8 4684.1 4760.4 4794.2 4822.1 4832.1 5884.8 5892.2 5893.8 5895.1 5924.9 5551.2 5697.7 5724.8 5735.1 5737.9 5859.8 5890.6 5909.5 5919.1 5952.8 5623.6 5624.9 5627.0 5629.2 5631.5 5478.1 5630.8 5710.9 5725.7 5726.4 5541.1 5588.2 5590.8 5612.9 5651.0 5501.4 5548.8 5550.0 5553.9 5569.2 5399.6 5426.1 5428.3 5455.5 5544.6 5503.4 5503.7 5528.6 5529.5 5567.6 5364.9 5374.8 5400.9 5404.9 5407.6 22:37:44 INFO - PROCESS | 23450 | 22:37:44 INFO - PROCESS | 23450 | [#1] ext.html Cycles:180 Average:56282.92 Median:38009.33 stddev:101080.29 (265.9%) stddev-sans-first:101277.28 22:37:44 INFO - PROCESS | 23450 | Values: 565.1 568.8 580.2 598.1 614.1 29677.6 37771.4 38686.6 38718.0 38736.4 41425.0 42105.2 42205.8 42214.4 42249.8 7649.0 8678.1 8836.5 8866.3 8869.0 7699.7 7806.0 10541.2 10774.9 10820.9 10501.6 10589.4 10589.8 10590.3 10590.7 10350.3 10468.5 10475.3 10480.3 10480.9 10284.4 10416.2 10433.6 10436.3 10436.6 38060.4 38371.6 41274.0 41300.4 41351.6 1686.5 3439.2 3487.3 3506.3 3608.1 32869.7 33067.8 33307.8 33442.0 33626.8 4328.2 4365.7 4388.3 4402.6 4477.1 336822.0 340519.0 341171.0 342011.0 342175.0 63514.7 64142.0 64153.0 64173.0 64219.7 69187.0 69799.7 70413.0 70458.3 70490.0 16205.3 16359.6 16378.5 16382.0 16437.6 11449.6 11465.0 11466.7 11470.4 11498.8 21140.3 21376.5 21645.8 21701.2 22452.9 8404.3 8547.5 8575.7 8657.8 8693.7 1128.4 1143.1 1156.8 1171.6 1251.4 32914.8 33453.8 33466.3 33524.7 34027.8 1089.5 1111.8 1143.9 1190.7 1279.9 16517.2 17276.1 17317.3 17347.2 17424.4 399396.0 402271.0 406831.0 408023.0 409132.0 57372.7 57536.7 57715.7 57815.4 57853.4 1125.4 1237.8 1313.7 1330.1 1330.7 29983.9 30998.5 31256.7 32252.5 32527.3 46242.0 53357.5 54175.5 54224.0 54345.7 400518.0 401311.0 406610.0 406804.0 406882.0 37958.2 45681.5 46501.5 46933.5 47785.5 43818.6 47465.0 47567.0 47934.0 48022.3 39312.8 40284.2 41059.2 41234.0 41912.8 38551.4 39553.4 40348.6 41207.2 41602.4 40261.6 41081.8 41134.6 41310.4 41375.6 34760.7 36118.6 36260.8 36665.5 36881.4 28011.4 28228.3 28307.7 28328.6 28454.4 22:37:44 INFO - PROCESS | 23450 | 22:37:44 INFO - PROCESS | 23450 | [#2] jquery.html Cycles:180 Average:28614.50 Median:22264.61 stddev:84184.85 (378.1%) stddev-sans-first:84394.27 22:37:44 INFO - PROCESS | 23450 | Values: 359.6 365.2 365.3 371.8 373.4 17668.8 18176.5 18178.2 18486.1 18488.9 17097.3 17485.8 18056.0 18058.3 18083.6 5529.4 5654.5 5668.4 5697.0 5710.7 4047.5 5641.9 5905.4 6120.7 6126.1 6099.6 6111.1 6112.5 6129.3 6147.2 6012.2 6035.8 6110.7 6114.9 6115.9 3679.4 5245.4 5405.5 5486.9 5489.0 21433.8 21941.7 21966.6 22562.7 22628.5 2079.9 2433.7 2528.8 2792.4 2884.7 13866.0 14130.3 14163.9 14495.0 14583.0 1969.1 1976.3 2000.7 2007.4 2050.4 73608.0 73988.3 74325.0 74355.6 75137.6 9964.6 10120.5 10216.0 10514.9 10673.3 13203.5 13345.5 13455.6 13469.9 13482.9 7626.7 7640.1 7674.4 8013.1 8265.9 7361.2 8195.1 8233.7 8343.9 8405.3 6281.3 6345.0 6373.5 6415.9 6499.2 1650.3 1751.8 1759.7 1799.1 1831.0 1030.0 1128.4 1139.5 1166.7 1172.8 17421.6 17721.6 17850.8 18193.2 18277.0 978.6 998.0 1022.6 1059.4 1088.9 10889.2 11186.7 11187.8 11214.4 11217.2 511736.0 513358.0 514175.0 514340.0 517642.0 74341.6 75374.0 76399.0 76446.0 77189.2 1080.8 1107.8 1140.4 1155.8 1158.9 17060.2 17110.9 17124.4 17197.5 17233.3 36151.5 36449.6 37220.3 38050.2 38696.4 49801.3 49960.0 50063.7 50200.7 50823.7 7969.3 8156.8 8177.3 8180.3 8184.8 12500.1 12557.0 12562.6 12705.0 12727.9 10411.4 11050.4 11260.0 11453.3 11773.7 11366.9 11370.9 11422.3 11635.9 11795.8 11554.5 11661.9 11818.2 11937.9 12162.7 8353.3 8374.2 8387.8 8407.2 8506.8 10297.6 11713.1 11739.8 11923.5 11942.8 22:37:44 INFO - PROCESS | 23450 | 22:37:44 INFO - PROCESS | 23450 | [#3] mootools.html Cycles:180 Average:5770.53 Median:6047.53 stddev:3039.61 (50.3%) stddev-sans-first:3029.85 22:37:44 INFO - PROCESS | 23450 | Values: 1335.1 1511.8 1522.6 1699.4 1831.8 7869.6 8056.3 8090.9 8098.4 8103.1 7811.4 8006.6 8007.0 8009.6 8009.8 1969.4 2022.5 2238.0 2296.6 2322.8 2315.7 2327.9 2329.0 2329.7 2332.6 2247.4 2276.1 2286.9 2289.3 2289.5 2234.9 2260.7 2271.1 2281.5 2282.3 2243.9 2245.4 2253.5 2256.1 2256.4 8106.7 8144.9 8149.5 8150.8 8160.5 4879.9 4966.4 4969.1 5011.9 5012.3 3216.8 3244.7 3304.6 3365.9 3391.4 1049.9 1056.0 1065.7 1098.0 1105.8 11616.4 11672.4 11681.6 11696.5 11696.7 4243.8 4390.5 4436.0 4442.8 4450.6 9772.8 9793.8 9843.7 9843.8 9846.7 4996.4 5023.7 5038.8 5042.3 5043.1 3890.7 4465.1 4518.1 4551.2 4564.0 3789.4 3866.3 3875.8 3903.5 3911.8 1154.9 1193.9 1198.2 1198.5 1216.8 1384.5 1411.7 1411.7 1422.5 1429.1 7753.3 7904.8 7939.8 7946.8 7955.3 1160.4 1165.6 1186.8 1195.3 1201.5 6113.6 6155.6 6209.5 6219.6 6237.9 9491.2 9850.0 9941.4 9974.3 10123.6 9769.9 10065.3 10081.0 10101.8 10103.7 7845.6 7936.8 7982.1 8008.6 8019.8 7576.7 7610.7 7635.4 7646.3 7702.2 8785.3 8924.2 9012.9 9117.5 9118.7 9309.0 9314.0 9334.4 9371.0 9478.8 5981.4 6633.4 6784.2 6952.3 7036.0 7795.8 7806.0 7819.4 7842.8 7855.5 6968.1 7128.6 7150.0 7176.9 7272.1 7002.5 7019.3 7045.5 7131.1 7143.5 7378.8 7600.6 7600.8 7628.2 7634.2 7048.3 7075.3 7084.3 7087.3 7107.8 7041.8 7099.4 7116.9 7129.2 7135.6 22:37:44 INFO - PROCESS | 23450 | 22:37:44 INFO - PROCESS | 23450 | [#4] prototype.html Cycles:180 Average:5349.44 Median:6124.57 stddev:1617.88 (26.4%) stddev-sans-first:1578.00 22:37:44 INFO - PROCESS | 23450 | Values: 332.9 335.9 336.9 339.7 340.1 6077.1 6127.4 6128.8 6137.0 6161.8 6104.3 6115.4 6115.6 6122.1 6127.1 4428.3 4563.4 4607.2 4669.6 4686.5 4654.0 4655.8 4680.3 4680.7 4687.4 4654.1 4667.5 4674.3 4682.0 4683.2 4440.4 4545.2 4647.5 4660.0 4675.4 4078.3 4079.0 4087.2 4089.9 4090.3 5910.9 5916.2 5918.9 5920.2 5928.8 5369.7 5376.6 5377.8 5380.3 5383.3 6358.0 6360.0 6361.8 6365.0 6370.2 4230.8 4346.3 4347.1 4352.2 4502.9 6628.9 6662.7 6691.4 6696.0 6696.8 4444.2 4445.0 4445.5 4454.7 4458.2 4508.1 4511.3 4511.7 4517.3 4520.0 5266.2 5273.2 5274.4 5276.3 5278.0 6279.5 6403.2 6442.5 6442.9 6488.6 1588.1 1596.0 1601.6 1604.5 1610.4 996.5 1042.4 1049.6 1062.3 1066.4 6047.9 6086.0 6094.2 6094.3 6115.3 6445.1 6619.3 6619.9 6620.7 6621.2 6171.5 6176.0 6179.9 6180.5 6183.4 3531.2 3562.4 3574.9 3575.1 3577.3 6655.8 6810.6 6816.3 6822.9 6887.9 6669.9 6703.7 6704.9 6719.5 6723.8 6861.5 6881.2 6881.4 6882.7 6883.4 6604.9 6610.9 6614.5 6618.3 6618.8 6359.5 6499.7 6513.1 6516.4 6522.2 6846.6 6858.8 6868.7 6876.0 6881.3 4493.9 4499.5 4505.3 4505.8 4506.5 6568.6 6572.4 6572.8 6582.6 6588.7 6262.3 6401.1 6403.9 6404.0 6408.2 6359.9 6375.1 6377.0 6378.8 6386.5 6259.8 6271.4 6278.0 6286.7 6289.3 6356.9 6404.8 6405.4 6425.3 6435.1 5914.8 6036.3 6190.7 6257.2 6263.2 22:37:44 INFO - PROCESS | 23450 | 22:37:44 INFO - PROCESS | 23450 | [#5] yui.html Cycles:180 Average:15007.43 Median:46119.15 stddev:17346.57 (37.6%) stddev-sans-first:17362.08 22:37:44 INFO - PROCESS | 23450 | Values: 725.7 833.6 844.1 856.7 884.9 13710.2 13904.9 14345.0 14366.9 14479.3 12686.7 13487.2 13766.2 13808.0 13821.3 833.8 840.1 844.3 846.1 847.1 846.7 847.8 849.9 850.5 852.4 892.7 897.4 899.5 900.1 902.3 888.0 888.3 888.3 888.5 891.0 649.6 650.0 651.2 654.4 656.9 13107.0 13152.3 13158.3 13170.7 13175.7 12081.2 12105.2 12342.3 12502.4 12537.4 10551.5 10780.3 10935.6 11058.5 11198.3 3862.9 3872.9 3889.3 4034.8 4049.0 45948.5 47328.0 51727.0 52385.2 52746.5 11256.9 11294.9 11310.5 11482.3 11702.2 16829.2 18749.6 19015.5 19086.9 19097.4 8829.3 8842.8 8994.0 9009.4 9128.6 4883.1 4942.7 5009.4 5028.8 5029.8 3448.2 3502.1 3504.0 3504.6 3515.8 644.0 645.6 646.3 655.4 660.4 775.2 776.6 790.1 802.5 807.9 9117.5 9143.5 9159.5 9221.5 9548.5 742.7 745.1 748.2 777.1 797.6 4253.5 4326.3 4361.8 4408.0 4431.7 65792.3 66177.3 66280.3 66451.7 66561.3 55026.4 56083.4 56769.7 57006.7 57776.0 48275.8 49044.0 49130.5 49214.5 49532.0 9313.5 9352.2 9452.4 9716.2 9837.1 36034.6 36676.6 37065.6 37505.2 42058.6 46289.8 46612.1 46804.8 46853.3 47236.0 11714.6 12432.6 12615.6 12621.7 12825.2 13137.7 13398.0 13738.7 14367.9 14547.3 12411.1 12486.5 12704.9 12955.2 13747.8 13157.3 13177.5 13813.9 14086.1 14186.8 12145.5 12500.8 12518.2 13103.5 13959.7 11099.7 11127.0 11199.6 11351.7 11568.8 10991.8 11096.3 11223.1 11251.8 11281.4 22:37:44 INFO - PROCESS | 23450 | -------- Summary: end -------- 22:37:44 INFO - PROCESS | 23450 | 22:37:45 INFO - TEST-INFO | 23450: exit 0 22:37:45 INFO - TEST-OK | dromaeo_css | took 1111245ms 22:37:45 INFO - TEST-START | kraken 22:37:45 INFO - operating with platform_type : linux_ 22:37:45 INFO - Initialising browser for kraken test... 22:37:45 INFO - TEST-INFO | started process 23637 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpExUKUX/profile http://localhost:41655/getInfo.html) 22:37:49 INFO - PROCESS | 23637 | __metrics Screen width/height:1600/1200 22:37:49 INFO - PROCESS | 23637 | colorDepth:24 22:37:49 INFO - PROCESS | 23637 | Browser inner width/height: 1024/697 22:37:49 INFO - PROCESS | 23637 | __metrics 22:37:50 ERROR - PROCESS | 23637 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:37:50 INFO - PROCESS | 23637 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 22:37:51 INFO - TEST-INFO | 23637: exit 0 22:37:51 INFO - Browser initialized. 22:37:51 INFO - Running cycle 1/1 for kraken test... 22:37:51 INFO - TEST-INFO | started process 23718 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpExUKUX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:38:03 INFO - PROCESS | 23718 | RSS: Main: 152621056 22:38:03 INFO - PROCESS | 23718 | 22:38:05 INFO - PROCESS | 23718 | Cycle 1(1): loaded http://localhost:41655/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41655/tests/kraken/driver.html?testName=audio-beat-detection) 22:38:06 INFO - PROCESS | 23718 | RSS: Main: 193404928 22:38:06 INFO - PROCESS | 23718 | 22:38:08 INFO - PROCESS | 23718 | Cycle 1(1): loaded http://localhost:41655/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41655/tests/kraken/driver.html?testName=audio-dft) 22:38:09 INFO - PROCESS | 23718 | RSS: Main: 184692736 22:38:09 INFO - PROCESS | 23718 | 22:38:12 INFO - PROCESS | 23718 | Cycle 1(1): loaded http://localhost:41655/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41655/tests/kraken/driver.html?testName=audio-fft) 22:38:12 INFO - PROCESS | 23718 | RSS: Main: 168775680 22:38:12 INFO - PROCESS | 23718 | 22:38:14 INFO - PROCESS | 23718 | Cycle 1(1): loaded http://localhost:41655/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41655/tests/kraken/driver.html?testName=audio-oscillator) 22:38:15 INFO - PROCESS | 23718 | RSS: Main: 172802048 22:38:15 INFO - PROCESS | 23718 | 22:38:17 INFO - PROCESS | 23718 | Cycle 1(1): loaded http://localhost:41655/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41655/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:38:18 INFO - PROCESS | 23718 | RSS: Main: 173846528 22:38:18 INFO - PROCESS | 23718 | 22:38:21 INFO - PROCESS | 23718 | Cycle 1(1): loaded http://localhost:41655/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41655/tests/kraken/driver.html?testName=imaging-darkroom) 22:38:21 INFO - PROCESS | 23718 | RSS: Main: 173871104 22:38:21 INFO - PROCESS | 23718 | 22:38:25 INFO - PROCESS | 23718 | Cycle 1(1): loaded http://localhost:41655/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41655/tests/kraken/driver.html?testName=imaging-desaturate) 22:38:25 INFO - PROCESS | 23718 | RSS: Main: 175169536 22:38:25 INFO - PROCESS | 23718 | 22:38:28 INFO - PROCESS | 23718 | Cycle 1(1): loaded http://localhost:41655/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41655/tests/kraken/driver.html?testName=json-parse-financial) 22:38:28 INFO - PROCESS | 23718 | RSS: Main: 176140288 22:38:28 INFO - PROCESS | 23718 | 22:38:30 INFO - PROCESS | 23718 | Cycle 1(1): loaded http://localhost:41655/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41655/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:38:31 INFO - PROCESS | 23718 | RSS: Main: 186097664 22:38:31 INFO - PROCESS | 23718 | 22:38:32 INFO - PROCESS | 23718 | Cycle 1(1): loaded http://localhost:41655/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41655/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:38:33 INFO - PROCESS | 23718 | RSS: Main: 181981184 22:38:33 INFO - PROCESS | 23718 | 22:38:35 INFO - PROCESS | 23718 | Cycle 1(1): loaded http://localhost:41655/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41655/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:38:35 INFO - PROCESS | 23718 | RSS: Main: 192561152 22:38:35 INFO - PROCESS | 23718 | 22:38:38 INFO - PROCESS | 23718 | Cycle 1(1): loaded http://localhost:41655/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41655/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:38:38 INFO - PROCESS | 23718 | RSS: Main: 197591040 22:38:38 INFO - PROCESS | 23718 | 22:38:41 INFO - PROCESS | 23718 | Cycle 1(1): loaded http://localhost:41655/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41655/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:38:42 INFO - PROCESS | 23718 | RSS: Main: 197586944 22:38:42 INFO - PROCESS | 23718 | 22:38:43 INFO - PROCESS | 23718 | Cycle 1(1): loaded http://localhost:41655/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41655/tests/kraken/driver.html?testName=ai-astar) 22:38:43 INFO - PROCESS | 23718 | RSS: Main: 257507328 22:38:43 INFO - PROCESS | 23718 | 22:38:43 INFO - PROCESS | 23718 | __start_tp_report 22:38:43 INFO - PROCESS | 23718 | _x_x_mozilla_page_load 22:38:43 INFO - PROCESS | 23718 | _x_x_mozilla_page_load_details 22:38:43 INFO - PROCESS | 23718 | |i|pagename|runs| 22:38:43 INFO - PROCESS | 23718 | |0;ai-astar;110;110;106;108;109;109;99;109;110;108 22:38:43 INFO - PROCESS | 23718 | |1;audio-beat-detection;152;126;152;171;124;152;155;125;173;125 22:38:43 INFO - PROCESS | 23718 | |2;audio-dft;162;162;161;160;160;161;160;164;162;161 22:38:43 INFO - PROCESS | 23718 | |3;audio-fft;72;72;93;96;73;72;76;113;108;72 22:38:43 INFO - PROCESS | 23718 | |4;audio-oscillator;94;93;147;94;94;95;148;93;93;148 22:38:43 INFO - PROCESS | 23718 | |5;imaging-gaussian-blur;117;116;116;116;116;117;116;117;117;116 22:38:43 INFO - PROCESS | 23718 | |6;imaging-darkroom;145;144;145;144;146;145;147;146;147;146 22:38:43 INFO - PROCESS | 23718 | |7;imaging-desaturate;95;95;95;96;95;96;95;95;95;95 22:38:43 INFO - PROCESS | 23718 | |8;json-parse-financial;56;55;55;54;55;54;56;63;53;53 22:38:43 INFO - PROCESS | 23718 | |9;json-stringify-tinderbox;60;59;59;60;59;60;60;60;59;60 22:38:43 INFO - PROCESS | 23718 | |10;stanford-crypto-aes;85;80;80;77;78;78;79;79;79;77 22:38:43 INFO - PROCESS | 23718 | |11;stanford-crypto-ccm;112;110;115;113;114;125;115;111;118;109 22:38:43 INFO - PROCESS | 23718 | |12;stanford-crypto-pbkdf2;148;130;141;134;143;144;145;145;157;143 22:38:43 INFO - PROCESS | 23718 | |13;stanford-crypto-sha256-iterative;65;65;64;63;63;62;66;66;64;62 22:38:43 INFO - PROCESS | 23718 | __end_tp_report 22:38:43 INFO - PROCESS | 23718 | __start_cc_report 22:38:43 INFO - PROCESS | 23718 | _x_x_mozilla_cycle_collect,1034 22:38:43 INFO - PROCESS | 23718 | __end_cc_report 22:38:43 INFO - PROCESS | 23718 | __startTimestamp1458106723908__endTimestamp 22:38:43 INFO - PROCESS | 23718 | 22:38:43 INFO - PROCESS | 23718 | ------- Summary: start ------- 22:38:43 INFO - PROCESS | 23718 | Number of tests: 14 22:38:43 INFO - PROCESS | 23718 | 22:38:43 INFO - PROCESS | 23718 | [#0] ai-astar Cycles:10 Average:107.80 Median:109.50 stddev:3.33 (3.0%) stddev-sans-first:3.43 22:38:43 INFO - PROCESS | 23718 | Values: 110.0 110.0 106.0 108.0 109.0 109.0 99.0 109.0 110.0 108.0 22:38:43 INFO - PROCESS | 23718 | 22:38:43 INFO - PROCESS | 23718 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:152.00 stddev:19.17 (12.6%) stddev-sans-first:20.19 22:38:43 INFO - PROCESS | 23718 | Values: 152.0 126.0 152.0 171.0 124.0 152.0 155.0 125.0 173.0 125.0 22:38:43 INFO - PROCESS | 23718 | 22:38:43 INFO - PROCESS | 23718 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.30 22:38:43 INFO - PROCESS | 23718 | Values: 162.0 162.0 161.0 160.0 160.0 161.0 160.0 164.0 162.0 161.0 22:38:43 INFO - PROCESS | 23718 | 22:38:43 INFO - PROCESS | 23718 | [#3] audio-fft Cycles:10 Average:84.70 Median:72.50 stddev:16.32 (22.5%) stddev-sans-first:16.65 22:38:43 INFO - PROCESS | 23718 | Values: 72.0 72.0 93.0 96.0 73.0 72.0 76.0 113.0 108.0 72.0 22:38:43 INFO - PROCESS | 23718 | 22:38:43 INFO - PROCESS | 23718 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:93.50 stddev:26.07 (27.9%) stddev-sans-first:27.01 22:38:43 INFO - PROCESS | 23718 | Values: 94.0 93.0 147.0 94.0 94.0 95.0 148.0 93.0 93.0 148.0 22:38:43 INFO - PROCESS | 23718 | 22:38:43 INFO - PROCESS | 23718 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 22:38:43 INFO - PROCESS | 23718 | Values: 117.0 116.0 116.0 116.0 116.0 117.0 116.0 117.0 117.0 116.0 22:38:43 INFO - PROCESS | 23718 | 22:38:43 INFO - PROCESS | 23718 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 22:38:43 INFO - PROCESS | 23718 | Values: 145.0 144.0 145.0 144.0 146.0 145.0 147.0 146.0 147.0 146.0 22:38:43 INFO - PROCESS | 23718 | 22:38:43 INFO - PROCESS | 23718 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:38:43 INFO - PROCESS | 23718 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 22:38:43 INFO - PROCESS | 23718 | 22:38:43 INFO - PROCESS | 23718 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:2.88 (5.2%) stddev-sans-first:3.04 22:38:43 INFO - PROCESS | 23718 | Values: 56.0 55.0 55.0 54.0 55.0 54.0 56.0 63.0 53.0 53.0 22:38:43 INFO - PROCESS | 23718 | 22:38:43 INFO - PROCESS | 23718 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.52 (0.9%) stddev-sans-first:0.53 22:38:43 INFO - PROCESS | 23718 | Values: 60.0 59.0 59.0 60.0 59.0 60.0 60.0 60.0 59.0 60.0 22:38:43 INFO - PROCESS | 23718 | 22:38:43 INFO - PROCESS | 23718 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:79.00 stddev:2.30 (2.9%) stddev-sans-first:1.13 22:38:43 INFO - PROCESS | 23718 | Values: 85.0 80.0 80.0 77.0 78.0 78.0 79.0 79.0 79.0 77.0 22:38:43 INFO - PROCESS | 23718 | 22:38:43 INFO - PROCESS | 23718 | [#11] stanford-crypto-ccm Cycles:10 Average:114.20 Median:114.50 stddev:4.64 (4.1%) stddev-sans-first:4.85 22:38:43 INFO - PROCESS | 23718 | Values: 112.0 110.0 115.0 113.0 114.0 125.0 115.0 111.0 118.0 109.0 22:38:43 INFO - PROCESS | 23718 | 22:38:43 INFO - PROCESS | 23718 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.00 Median:144.50 stddev:7.33 (5.1%) stddev-sans-first:7.55 22:38:43 INFO - PROCESS | 23718 | Values: 148.0 130.0 141.0 134.0 143.0 144.0 145.0 145.0 157.0 143.0 22:38:43 INFO - PROCESS | 23718 | 22:38:43 INFO - PROCESS | 23718 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.50 stddev:1.49 (2.3%) stddev-sans-first:1.54 22:38:43 INFO - PROCESS | 23718 | Values: 65.0 65.0 64.0 63.0 63.0 62.0 66.0 66.0 64.0 62.0 22:38:43 INFO - PROCESS | 23718 | -------- Summary: end -------- 22:38:43 INFO - PROCESS | 23718 | 22:38:44 INFO - TEST-INFO | 23718: exit 0 22:38:44 INFO - TEST-OK | kraken | took 59491ms 22:38:44 INFO - SUITE-END | took 1170s 22:38:45 INFO - Completed test suite (00:19:30) 22:38:45 INFO - javascript benchmark 22:38:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3021.6978302169787, 3039.6960303969618, 3067.6472205696336, 3080.938381232374, 3136.6392864820555, 5186.170212765958, 5199.870003249921, 5208.401033881105, 5230.241614965832, 5253.3170687810625, 5353.143497040474, 5360.3299587551555, 5374.865628359293, 5411.431799661028, 5415.404305526399, 4719.882002949919, 4750.738709370983, 4778.880527986794, 4796.856094317176, 4946.629002824802, 4873.707577545341, 4895.902081958358, 4903.436104847952, 4929.014197160564, 4997.475265097149, 4762.761861906891, 4838.201696720054, 4883.0233953209145, 4899.5835353995135, 4934.975325123387, 4874.415070191564, 4885.5358740919555, 4904.239842824368, 4909.459959404463, 4926.802927882881, 4697.342372067913, 4850.005748821483, 4875.24433712775, 4895.632827537949, 4926.950730492721, 5215.139501982168, 5293.550048245904, 5298.205269209611, 5299.099153143975, 5325.760340784674, 5610.859728506779, 5624.690642014688, 5642.802501912413, 5646.18130371098, 5646.971765141189, 5508.779648814043, 5640.887182256373, 5648.209250704905, 5662.09406494963, 5667.659940403548, 5223.477652234784, 5231.764570594332, 5249.921251181236, 5250.8687282817855, 5298.231756395339, 5723.341815691166, 5725.141228815711, 5728.169415434739, 5731.656100633975, 5737.684427356536, 5503.889922201533, 5518.392976772552, 5522.088855338824, 5528.917066244009, 5606.85982850432, 5605.915911261334, 5611.298587676541, 5618.157276408571, 5634.1830434586755, 5674.120511320752, 5571.387147413781, 5577.414371491016, 5582.86042848932, 5586.888262234733, 5588.6646801192055, 5499.972500137474, 5552.833414997475, 5586.245856809279, 5618.4662457066515, 5645.915311270334, 4268.423762792046, 4271.67962402821, 4271.9960809209815, 4281.807318670667, 4305.182015417061, 3822.1591249924973, 3846.9807650961566, 3853.9614603854166, 3868.941965870514, 3882.902927426837, 5227.764750586232, 5343.332083489564, 5360.517553420133, 5400.675959442446, 5447.727613619303, 5700.914486282709, 5707.3721890592005, 5709.400512946164, 5717.17101020358, 5724.742386592613, 5367.570594352443, 5370.677759334452, 5378.2739330189925, 5388.137897936312, 5410.810621628303, 4684.063187362541, 4760.381150450488, 4794.184988551954, 4822.107910036654, 4832.081904438145, 5884.764609415575, 5892.234009578728, 5893.823185304448, 5895.086261629454, 5924.851878702981, 5551.195076713934, 5697.743601537858, 5724.771009159754, 5735.082386818089, 5737.885242295048, 5859.824205273849, 5890.587658863838, 5909.468147866713, 5919.141724450017, 5952.821415357546, 5623.634463759842, 5624.887502250014, 5627.043402621646, 5629.211910332639, 5631.465010823965, 5478.068728316116, 5630.8029218977135, 5710.942890571041, 5725.685087320071, 5726.398728133486, 5541.141123125922, 5588.161775733673, 5590.7763689453595, 5612.887742245214, 5651.039323314964, 5501.394846566955, 5548.750306236309, 5549.972250138723, 5553.916691249554, 5569.220309156641, 5399.649022813504, 5426.104692725656, 5428.294321738149, 5455.481729235875, 5544.556435485071, 5503.422140675331, 5503.6697798130635, 5528.557715382679, 5529.474699903502, 5567.5545956322585, 5364.865878353073, 5374.838754837361, 5400.864978375572, 5404.918926216189, 5407.594430417813], "unit": "score", "name": "dojo.html", "value": 5217.540309288845}, {"lowerIsBetter": false, "replicates": [565.0725672138947, 568.7554351628798, 580.2311936683893, 598.1476396135507, 614.0727501472777, 29677.554836677467, 37771.433428498596, 38686.613133868654, 38718.0, 38736.418953715714, 41425.0, 42105.15789684204, 42205.7889710551, 42214.36678449818, 42249.7887510562, 7649.0, 8678.132186781319, 8836.513991730451, 8866.290696744278, 8869.0, 7699.653515591784, 7805.960970195141, 10541.209409294295, 10774.892251077506, 10820.891791082067, 10501.579936802518, 10589.364638121737, 10589.78820423591, 10590.311629744081, 10590.682279531626, 10350.327228730108, 10468.476576171199, 10475.319104258275, 10480.266381353309, 10480.94759526205, 10284.43435611041, 10416.218783591261, 10433.582656693723, 10436.32163909351, 10436.634717784917, 38060.429093563616, 38371.616283837364, 41274.0, 41300.38049429231, 41351.58648413508, 1686.5362025442978, 3439.2433664594, 3487.337405892872, 3506.333796578642, 3608.0799396154075, 32869.67130328714, 33067.83466082678, 33307.833460832786, 33442.0, 33626.83186584051, 4328.156009578133, 4365.738055716667, 4388.297872340442, 4402.581754733295, 4477.126960242754, 336822.0, 340519.0, 341171.0, 342011.0, 342175.0, 63514.68242658757, 64142.0, 64153.0, 64173.0, 64219.67890160519, 69187.0, 69799.65100174467, 70413.0, 70458.2954170462, 70490.0, 16205.270762815702, 16359.591010224602, 16378.508644740677, 16382.0, 16437.58906027359, 11449.599264025886, 11465.025472834903, 11466.656000320003, 11470.426478676032, 11498.770024599462, 21140.260090896743, 21376.465588360414, 21645.783542164376, 21701.240456583942, 22452.887735561217, 8404.28563572091, 8547.529885856338, 8575.742727718054, 8657.783555411164, 8693.695720649874, 1128.3906690387264, 1143.1241084874487, 1156.7686462707493, 1171.5840876488724, 1251.3993283223922, 32914.8354258232, 33453.83273083668, 33466.330673386394, 33524.66475335264, 34027.829860850536, 1089.477051015517, 1111.8054340490382, 1143.937083460401, 1190.6844686158174, 1279.9360031998363, 16517.174141292886, 17276.13619319029, 17317.30730770755, 17347.21937512815, 17424.39014634507, 399396.0, 402271.0, 406831.0, 408023.0, 409132.0, 57372.71313643405, 57536.71231643815, 57715.711421442626, 57815.421845781006, 57853.42146578564, 1125.3979121170134, 1237.7524495100836, 1313.7372525494939, 1330.0689517337903, 1330.7471580399886, 29983.85008075033, 30998.496285676323, 31256.68743312538, 32252.516212256367, 32527.349453010334, 46242.0, 53357.46642533525, 54175.45824541704, 54224.0, 54345.72827135839, 400518.0, 401311.0, 406610.0, 406804.0, 406882.0, 37958.24083518369, 45681.54318456906, 46501.53498464972, 46933.53066469292, 47785.52214477811, 43818.56181438272, 47465.0, 47567.0, 47934.0, 48022.27966580574, 39312.803435983784, 40284.1943161141, 41059.1788164241, 41234.0, 41912.790436047624, 38551.42172867353, 39553.406698898965, 40348.59651403566, 41207.1758564821, 41602.37596436116, 40261.59738402579, 41081.79459102685, 41134.588654113075, 41310.38034429546, 41375.58624413717, 34760.65239347574, 36118.638813612575, 36260.81869590635, 36665.45001824921, 36881.44677829781, 28011.43977120487, 28228.294292642848, 28307.716922831332, 28328.57507137436, 28454.43091138124], "unit": "score", "name": "ext.html", "value": 20565.483657292836}, {"lowerIsBetter": false, "replicates": [359.5757006732055, 365.18017051718897, 365.28768900643746, 371.79737043311394, 373.4305184593496, 17668.82331176688, 18176.54558636035, 18178.181981810816, 18486.075696215168, 18488.949323361663, 17097.31610735569, 17485.825141748577, 18056.0, 18058.27766889326, 18083.638327233446, 5529.447055294469, 5654.547636189095, 5668.404817494165, 5696.9745445819735, 5710.71446427677, 4047.494063242095, 5641.8589535261535, 5905.350411454737, 6120.693965301717, 6126.050462178369, 6099.57302988791, 6111.144439778434, 6112.541559383042, 6129.264488261392, 6147.231596050494, 6012.18835457212, 6035.788747393842, 6110.694465276719, 6114.938850611481, 6115.938840611581, 3679.4296883982756, 5245.370555533361, 5405.459454054602, 5486.890262194734, 5489.0, 21433.785662143335, 21941.670874936888, 21966.560668786693, 22562.661560076613, 22628.54742905149, 2079.8960051997337, 2433.6592876997233, 2528.8356256843244, 2792.3856751514636, 2884.6538415390078, 13866.0, 14130.293485325692, 14163.858361416356, 14495.0, 14583.0, 1969.0745349685767, 1976.2589029114083, 2000.7198992141111, 2007.3777129090029, 2050.3643870400224, 73608.0, 73988.26011739922, 74325.0, 74355.62822185854, 75137.62431187808, 9964.551595178234, 10120.544575494121, 10216.0, 10514.894851051391, 10673.306235094695, 13203.47186112564, 13345.466181352636, 13455.645262079097, 13469.932650336686, 13482.932585337207, 7626.656800443993, 7640.121386040676, 7674.386049116058, 8013.078495972921, 8265.917340826514, 7361.192154046463, 8195.098539160688, 8233.670653173805, 8343.916560834314, 8405.285550728257, 6281.3404592518045, 6345.0, 6373.458256048288, 6415.877221486221, 6499.1876015498065, 1650.2821272746394, 1751.833575810296, 1759.7360395940711, 1799.1184319683523, 1830.9633807323778, 1029.9588016479406, 1128.3906690387264, 1139.4587570903755, 1166.731651720109, 1172.7537217184315, 17421.564460888578, 17721.645567088843, 17850.821491785176, 18193.181306841223, 18277.0, 978.6427953796955, 997.9550920208608, 1022.6369638778127, 1059.443792009186, 1088.8638920134983, 10889.237753357189, 11186.664400068012, 11187.832182517268, 11214.439278036065, 11217.158713096387, 511736.0, 513358.0, 514175.0, 514340.0, 517642.0, 74341.6282918582, 75374.0, 76399.0, 76446.0, 77189.22810771933, 1080.8324709670014, 1107.7950579143046, 1140.3955903371227, 1155.7919574476675, 1158.9362585057734, 17060.23228954675, 17110.914445427694, 17124.40064597733, 17197.484075477754, 17233.310667573158, 36151.45772813357, 36449.63550364569, 37220.25559488741, 38050.2389952205, 38696.41955370615, 49801.25298120458, 49960.0, 50063.749681251364, 50200.74899625625, 50823.745881270355, 7969.282764551218, 8156.796080097808, 8177.304929081095, 8180.304674102768, 8184.83630327402, 12500.124991250525, 12557.0, 12562.623121306375, 12705.0, 12727.87272127304, 10411.427371494641, 11050.392228427514, 11260.0, 11453.312801231952, 11773.705657358634, 11366.886331136913, 11370.94314528422, 11422.31466112036, 11635.941820290844, 11795.764084718428, 11554.537818487166, 11661.883381166079, 11818.172727908965, 11937.940310298392, 12162.695932601755, 8353.33173346143, 8374.246317831425, 8387.790305242417, 8407.159284071544, 8506.78733031679, 10297.639582614573, 11713.121515886172, 11739.765204696028, 11923.463444145207, 11942.820857686967], "unit": "score", "name": "jquery.html", "value": 9151.405995228795}, {"lowerIsBetter": false, "replicates": [1335.069522398336, 1511.7959075524805, 1522.5584580471664, 1699.3542453867528, 1831.7985021647617, 7869.645865936032, 8056.2749352558185, 8090.919090809098, 8098.392620553453, 8103.068147163078, 7811.414143939213, 8006.639701213445, 8006.959965200166, 8009.639566219519, 8009.839803203947, 1969.4190213886939, 2022.5247066939257, 2237.966430503544, 2296.5636529059466, 2322.84901481404, 2315.6642286868396, 2327.93016209514, 2328.988355058222, 2329.7087864017, 2332.568474832153, 2247.449374903143, 2276.055436993646, 2286.862788232703, 2289.3246492284734, 2289.473421113145, 2234.8882555872224, 2260.7400148982915, 2271.1256166375897, 2281.4866655002493, 2282.2696737044153, 2243.9214627488122, 2245.360072379364, 2253.504229069602, 2256.142665787007, 2256.435891027243, 8106.675732970674, 8144.877826832602, 8149.511029338259, 8150.796230094235, 8160.469569477965, 4879.926801097987, 4966.379202599675, 4969.130402179604, 5011.922436676132, 5012.298278241049, 3216.7776245026976, 3244.707976282146, 3304.619968703606, 3365.882194123194, 3391.423458012119, 1049.8792638846478, 1056.002078036256, 1065.7282392989816, 1097.9945100274447, 1105.8230683090667, 11616.419179041015, 11672.416379181092, 11681.649550513413, 11696.47365868538, 11696.6548846882, 4243.830246790156, 4390.53899340571, 4435.955640443619, 4442.755648439367, 4450.621697155778, 9772.755681107887, 9793.755156121155, 9843.704688859345, 9843.75390615226, 9846.704598862045, 4996.400431948116, 5023.748812559357, 5038.823641172541, 5042.268871013755, 5043.142665746832, 3890.727649064595, 4465.0623369092855, 4518.118966801442, 4551.249043907718, 4563.95436045642, 3789.412641040643, 3866.3040652682225, 3875.8255878485534, 3903.4535165076913, 3911.78485183312, 1154.8729639739622, 1193.8746431624727, 1198.2391181599746, 1198.5205917632843, 1216.7566486702694, 1384.4531410092957, 1411.7105993271355, 1411.745885740556, 1422.49501426994, 1429.0639631041684, 7753.263439973193, 7904.762857114296, 7939.801504962422, 7946.7615971520945, 7955.323797477164, 1160.3791971295486, 1165.5745652836822, 1186.833843261944, 1195.3485350484007, 1201.5253974679952, 6113.633182009094, 6155.630662160284, 6209.5032397408095, 6219.595726277777, 6237.937620623827, 9491.240700743923, 9850.0, 9941.403515789076, 9974.301798874154, 10123.645672401577, 9769.902300976899, 10065.345752526062, 10081.0, 10101.797964040677, 10103.7474063149, 7845.5684937329, 7936.761897143095, 7982.121966583787, 8008.599570021592, 8019.83960320802, 7576.659050342858, 7610.733624323122, 7635.42734294919, 7646.273604007611, 7702.229777022477, 8785.297176226015, 8924.152205540464, 9012.864807027769, 9117.5441227937, 9118.726438206864, 9308.95345523268, 9314.0, 9334.439933604006, 9371.0, 9478.763030924281, 5981.431763982415, 6633.3698298663485, 6784.21981472137, 6952.339527744856, 7036.014957905795, 7795.844083118192, 7806.0, 7819.374450043869, 7842.843143136991, 7855.489393189425, 6968.0941477607585, 7128.607926563881, 7150.0, 7176.856462870818, 7272.127344718668, 7002.474814389043, 7019.333163349474, 7045.542039767399, 7131.0729605151, 7143.535670181422, 7378.778636640909, 7600.619969001417, 7600.771976840703, 7628.237176282328, 7634.198409167179, 7048.330408611174, 7075.327843854826, 7084.326988936043, 7087.291270872872, 7107.786766397016, 7041.788746337618, 7099.43204543625, 7116.928830711834, 7129.180144283474, 7135.643217838983], "unit": "score", "name": "mootools.html", "value": 4719.698458285468}, {"lowerIsBetter": false, "replicates": [332.8782004644348, 335.88076232937306, 336.8534687410975, 339.74519110667, 340.13435805874064, 6077.088436734481, 6127.417895299945, 6128.846778830526, 6137.048757442598, 6161.7535298588, 6104.328523862383, 6115.41903519166, 6115.571909966293, 6122.0816877468405, 6127.050307202379, 4428.313611390224, 4563.406757121569, 4607.216773148572, 4669.626429885601, 4686.4844867064685, 4654.0, 4655.837045703401, 4680.25115981443, 4680.695754775928, 4687.390639216897, 4654.138984287901, 4667.533246675339, 4674.298855171734, 4682.0, 4683.180443422404, 4440.400545926291, 4545.181867263875, 4647.512011238805, 4660.044690838404, 4675.368825208588, 4078.3066878630702, 4078.9796051019853, 4087.182563487285, 4089.9386509202386, 4090.2637525245445, 5910.881782364371, 5916.165988543522, 5918.852028699274, 5920.230370051909, 5928.822135335947, 5369.731513424353, 5376.596755243372, 5377.8117765878005, 5380.300560927094, 5383.300170977787, 6358.0, 6360.0459931010255, 6361.8409539761415, 6364.968175159141, 6370.235571731422, 4230.76730779807, 4346.261135606955, 4347.065380943112, 4352.216601011816, 4502.909941801146, 6628.867422651569, 6662.6668666566475, 6691.364320389555, 6695.966520167417, 6696.799096027127, 4444.155610434007, 4445.022095139064, 4445.466544014739, 4454.732716036983, 4458.219811532968, 4508.0533088051225, 4511.3458548510935, 4511.661625378044, 4517.322401639714, 4519.9774001130445, 5266.236395722675, 5273.156294992783, 5274.393444753826, 5276.287701160294, 5278.0, 6279.488204718058, 6403.231612206565, 6442.516811239176, 6442.903356449657, 6488.578242414228, 1588.1424031023118, 1596.0423745752687, 1601.639631082997, 1604.478544473051, 1610.3800036985845, 996.5067291690659, 1042.3641578637025, 1049.6063976008998, 1062.3466568060587, 1066.424130969268, 6047.879042419127, 6085.995810691186, 6094.177286066413, 6094.299155597075, 6115.296740874767, 6445.097686323918, 6619.338066193439, 6619.933800662028, 6620.668966551653, 6621.172353455818, 6171.506279497629, 6175.96912015446, 6179.938200617937, 6180.505559555225, 6183.350748171377, 3531.152523394418, 3562.447820587813, 3574.8927532174075, 3575.0883524701035, 3577.338192434408, 6655.767048153291, 6810.62541560219, 6816.250212476623, 6822.9424439212, 6887.86476192382, 6669.933300667029, 6703.698333575001, 6704.899426508607, 6719.496037797087, 6723.831904202434, 6861.4853885957755, 6881.243063263037, 6881.380675739208, 6882.692288465176, 6883.414909732729, 6604.867902642017, 6610.867782644416, 6614.470842332698, 6618.271990080991, 6618.801435956929, 6359.459445946961, 6499.707513162014, 6513.055606937062, 6516.413522782972, 6522.15212022434, 6846.623435711083, 6858.794236172923, 6868.7252509901045, 6875.965620171867, 6881.277465866212, 4493.932591011072, 4499.5275496072445, 4505.324201369821, 4505.752183629801, 4506.526814684542, 6568.6058836469965, 6572.441342485751, 6572.76995305162, 6582.572132811543, 6588.736450541925, 6262.311145774052, 6401.135846660642, 6403.903941440975, 6404.0, 6408.166938297992, 6359.90460143089, 6375.0874737577615, 6377.0, 6378.77674281398, 6386.489080873612, 6259.78090766821, 6271.404216599416, 6278.0, 6286.717097730521, 6289.308176100534, 6356.872862542816, 6404.775832845828, 6405.3594640535575, 6425.293217745951, 6435.1312572803945, 5914.822555323347, 6036.336003039574, 6190.690465476799, 6257.186565746424, 6263.185785847811], "unit": "score", "name": "prototype.html", "value": 4818.557322842597}, {"lowerIsBetter": false, "replicates": [725.6516871901487, 833.5665453963935, 844.0926004545112, 856.7044369692458, 884.911508849115, 13710.177389356633, 13904.930475347623, 14345.0, 14366.856331436682, 14479.2760361982, 12686.746265074693, 13487.190768553894, 13766.242856642906, 13808.0, 13821.308934553257, 833.7707130539089, 840.1052878684212, 844.2612713875359, 846.1284876577135, 847.1020718038868, 846.6571038729294, 847.8431490174306, 849.8682704180831, 850.5109562001843, 852.3862818770475, 892.6875593542273, 897.4391005621486, 899.455829223317, 900.1493588558815, 902.3277658144691, 887.9778005549913, 888.2583043158937, 888.2671795768484, 888.5024386343669, 890.9732708018737, 649.636203725915, 650.0411892458586, 651.1795138125996, 654.3554598720257, 656.8850451171025, 13107.0, 13152.342382880914, 13158.276294803782, 13170.670733231746, 13175.67060823487, 12081.214721043105, 12105.213161144586, 12342.259464432163, 12502.374881255992, 12537.43581538833, 10551.47242637865, 10780.29928054674, 10935.617253396093, 11058.502367393407, 11198.272112312674, 3862.9227415451815, 3872.9225415491533, 3889.3388124018984, 4034.7579145251084, 4048.9797551012352, 45948.54051459476, 47328.0, 51727.0, 52385.2142217867, 52746.47253527454, 11256.943715281535, 11294.94352528232, 11310.491027903765, 11482.253653512495, 11702.239354441934, 16829.242684079247, 18749.625007499773, 19015.524611884535, 19086.904565477085, 19097.427077187705, 8829.293656507463, 8842.778930526789, 8994.0, 9009.414388064755, 9128.58921348541, 4883.072216278895, 4942.678725882878, 5009.44896061433, 5028.798848046037, 5029.823956161516, 3448.2241495663275, 3502.124468882779, 3503.964960350364, 3504.5794504659602, 3515.8066306353394, 643.996780016097, 645.6223109480912, 646.2793984707112, 655.3839390972471, 660.4254298760013, 775.1512094256892, 776.5690042026729, 790.1426951757293, 802.4583406200791, 807.858624740668, 9117.498537580497, 9143.54282285883, 9159.496227707406, 9221.49281789508, 9548.522573871278, 742.6806473216461, 745.0554053919267, 748.1882157858785, 777.0752804163141, 797.6051854332143, 4253.532111467736, 4326.329418940069, 4361.781910904442, 4407.958508629035, 4431.689781715249, 65792.34207657863, 66177.33822661809, 66280.33719662837, 66451.66774166099, 66561.33438665551, 55026.44973550213, 56083.43916560864, 56769.71615141898, 57006.7149664249, 57776.0, 48275.75862120667, 49044.0, 49130.50869491331, 49214.50785492171, 49532.009359813324, 9313.487758173365, 9352.205062569758, 9452.43285402878, 9716.174125199155, 9837.114659680663, 36034.63965360418, 36676.63323366732, 37065.629343707296, 37505.2498950025, 42058.57941420669, 46289.76855115703, 46612.06775864532, 46804.7659761699, 46853.2972005427, 47236.0, 11714.648560543197, 12432.627021189379, 12615.621531354074, 12621.74756504883, 12825.166364186298, 13137.737245255232, 13398.0, 13738.65653358674, 14367.85632143707, 14547.27263636835, 12411.069169812119, 12486.500539978299, 12704.936475317565, 12955.222686638455, 13747.793783093062, 13157.342132893125, 13177.47290108385, 13813.861861381258, 14086.084404513675, 14186.787198191829, 12145.514179433078, 12500.812487812509, 12518.186317889307, 13103.475860965455, 13959.720805584035, 11099.667009989713, 11127.0, 11199.552017919192, 11351.659450216506, 11568.80367485527, 10991.780164396827, 11096.278741882075, 11223.10215182767, 11251.831222531504, 11281.435928203393], "unit": "score", "name": "yui.html", "value": 6907.486734113139}], "name": "dromaeo_css", "value": 7323.423550685617}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 106.0, 108.0, 109.0, 109.0, 99.0, 109.0, 110.0, 108.0], "unit": "score", "name": "ai-astar", "value": 107.8}, {"lowerIsBetter": true, "replicates": [152.0, 126.0, 152.0, 171.0, 124.0, 152.0, 155.0, 125.0, 173.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 145.5}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 160.0, 160.0, 161.0, 160.0, 164.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 93.0, 96.0, 73.0, 72.0, 76.0, 113.0, 108.0, 72.0], "unit": "score", "name": "audio-fft", "value": 84.7}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 147.0, 94.0, 94.0, 95.0, 148.0, 93.0, 93.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 109.9}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.4}, {"lowerIsBetter": true, "replicates": [145.0, 144.0, 145.0, 144.0, 146.0, 145.0, 147.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 55.0, 54.0, 55.0, 54.0, 56.0, 63.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.4}, {"lowerIsBetter": true, "replicates": [60.0, 59.0, 59.0, 60.0, 59.0, 60.0, 60.0, 60.0, 59.0, 60.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 59.6}, {"lowerIsBetter": true, "replicates": [85.0, 80.0, 80.0, 77.0, 78.0, 78.0, 79.0, 79.0, 79.0, 77.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.2}, {"lowerIsBetter": true, "replicates": [112.0, 110.0, 115.0, 113.0, 114.0, 125.0, 115.0, 111.0, 118.0, 109.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.2}, {"lowerIsBetter": true, "replicates": [148.0, 130.0, 141.0, 134.0, 143.0, 144.0, 145.0, 145.0, 157.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.0}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 64.0, 63.0, 63.0, 62.0, 66.0, 66.0, 64.0, 62.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.0}], "name": "kraken", "value": 1481.7}]} 22:38:45 INFO - Return code: 0 22:38:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:38:45 ERROR - # TBPL SUCCESS # 22:38:45 INFO - Running post-action listener: _resource_record_post_action 22:38:45 INFO - Running post-run listener: _resource_record_post_run 22:38:46 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536821760; Read time: 16; Write time: 570800 22:38:46 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 252809216; Read time: 0; Write time: 320220 22:38:46 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283897856; Read time: 16; Write time: 250580 22:38:46 INFO - Running post-run listener: _upload_blobber_files 22:38:46 INFO - Blob upload gear active. 22:38:46 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:38:46 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 22:38:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:38:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:38:46 INFO - (blobuploader) - INFO - Open directory for files ... 22:38:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:38:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:38:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:38:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:38:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:38:47 INFO - (blobuploader) - INFO - Done attempting. 22:38:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:38:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:38:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:38:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:38:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:38:48 INFO - (blobuploader) - INFO - Done attempting. 22:38:48 INFO - (blobuploader) - INFO - Iteration through files over. 22:38:48 INFO - Return code: 0 22:38:48 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:38:48 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:38:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/653bc322a27f3e22c1aa2af6af91babe5f7e749ebada030c6807c5727eefef9444b965bf546392a525779ceea781177dcfc917cf775d599632c64870ae265297", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c958811be6fdd674d3ed1ebeae8c27ae8c0562faf56270be5e9b7b88e22ce6196fd9f42ac256eaf82c098a7a1df01964824455358a3e67df5469fa26e8dec386"} 22:38:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:38:48 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:38:48 INFO - Contents: 22:38:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/653bc322a27f3e22c1aa2af6af91babe5f7e749ebada030c6807c5727eefef9444b965bf546392a525779ceea781177dcfc917cf775d599632c64870ae265297", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c958811be6fdd674d3ed1ebeae8c27ae8c0562faf56270be5e9b7b88e22ce6196fd9f42ac256eaf82c098a7a1df01964824455358a3e67df5469fa26e8dec386"} 22:38:48 INFO - Running post-run listener: copy_logs_to_upload_dir 22:38:48 INFO - Copying logs to upload dir... 22:38:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:38:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.293814 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-03-15 22:38:47.972437) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-15 22:38:47.975773) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1458102853.599975-766418463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/653bc322a27f3e22c1aa2af6af91babe5f7e749ebada030c6807c5727eefef9444b965bf546392a525779ceea781177dcfc917cf775d599632c64870ae265297", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c958811be6fdd674d3ed1ebeae8c27ae8c0562faf56270be5e9b7b88e22ce6196fd9f42ac256eaf82c098a7a1df01964824455358a3e67df5469fa26e8dec386"} build_url:https://queue.taskcluster.net/v1/task/CBHuFhFRRK-nKYCTZtivvQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011340 build_url: 'https://queue.taskcluster.net/v1/task/CBHuFhFRRK-nKYCTZtivvQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/653bc322a27f3e22c1aa2af6af91babe5f7e749ebada030c6807c5727eefef9444b965bf546392a525779ceea781177dcfc917cf775d599632c64870ae265297", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c958811be6fdd674d3ed1ebeae8c27ae8c0562faf56270be5e9b7b88e22ce6196fd9f42ac256eaf82c098a7a1df01964824455358a3e67df5469fa26e8dec386"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-15 22:38:48.001049) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 22:38:48.001429) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1458102853.599975-766418463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 22:38:48.086621) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 22:38:48.087005) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 22:38:48.087355) ========= ========= Total master_lag: 0.30 =========