builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1457469513.85 results: success (0) buildid: 20160308004005 builduid: 910d3bff56774b48867b4e7b0f6eff08 revision: ce9a5e723e4b21ce0dac5ede64e156023bb70534 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 12:38:33.846727) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 12:38:33.847166) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-08 12:38:33.847452) ========= 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=6dbc10da6d83fee962c624be000001a8-1457469513.201587-1152426323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005371 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-08 12:38:33.865843) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-08 12:38:33.866130) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-08 12:38:33.881311) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 12:38:33.881631) ========= 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=6dbc10da6d83fee962c624be000001a8-1457469513.201587-1152426323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.027221 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 12:38:33.976184) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 12:38:33.976546) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 12:38:33.976914) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 12:38:33.977199) ========= 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=6dbc10da6d83fee962c624be000001a8-1457469513.201587-1152426323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-08 12:38:34-- 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% 214M=0s 2016-03-08 12:38:34 (214 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153637 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 12:38:34.192679) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 12:38:34.192992) ========= 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=6dbc10da6d83fee962c624be000001a8-1457469513.201587-1152426323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.095920 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 12:38:34.315903) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 12:38:34.316261) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ce9a5e723e4b21ce0dac5ede64e156023bb70534 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ce9a5e723e4b21ce0dac5ede64e156023bb70534 --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=6dbc10da6d83fee962c624be000001a8-1457469513.201587-1152426323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-08 12:38:34,563 truncating revision to first 12 chars 2016-03-08 12:38:34,563 Setting DEBUG logging. 2016-03-08 12:38:34,563 attempt 1/10 2016-03-08 12:38:34,563 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ce9a5e723e4b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-08 12:38:35,107 unpacking tar archive at: mozilla-aurora-ce9a5e723e4b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.837973 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 12:38:35.166485) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 12:38:35.166794) ========= echo ce9a5e723e4b21ce0dac5ede64e156023bb70534 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ce9a5e723e4b21ce0dac5ede64e156023bb70534'] 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=6dbc10da6d83fee962c624be000001a8-1457469513.201587-1152426323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ce9a5e723e4b21ce0dac5ede64e156023bb70534 program finished with exit code 0 elapsedTime=0.004453 script_repo_revision: 'ce9a5e723e4b21ce0dac5ede64e156023bb70534' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 12:38:35.219616) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-08 12:38:35.219921) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-08 12:38:35.231868) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 23 secs) (at 2016-03-08 12:38:35.232183) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1457469513.201587-1152426323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:38:35 INFO - MultiFileLogger online at 20160308 12:38:35 in /builds/slave/test-pgo 12:38:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 12:38:35 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:38:35 INFO - {'append_to_log': False, 12:38:35 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:38:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:38:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:38:35 INFO - 'branch': 'Mozilla-Aurora', 12:38:35 INFO - 'buildbot_json_path': 'buildprops.json', 12:38:35 INFO - 'config_files': ('talos/linux_config.py',), 12:38:35 INFO - 'default_actions': ('clobber', 12:38:35 INFO - 'read-buildbot-config', 12:38:35 INFO - 'download-and-extract', 12:38:35 INFO - 'populate-webroot', 12:38:35 INFO - 'create-virtualenv', 12:38:35 INFO - 'install', 12:38:35 INFO - 'run-tests'), 12:38:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:38:35 INFO - 'download_minidump_stackwalk': True, 12:38:35 INFO - 'download_symbols': 'ondemand', 12:38:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:38:35 INFO - 'tooltool.py': '/tools/tooltool.py', 12:38:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:38:35 INFO - '/tools/misc-python/virtualenv.py')}, 12:38:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:38:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:38:35 INFO - 'installer_path': 'installer.exe', 12:38:35 INFO - 'log_level': 'info', 12:38:35 INFO - 'log_name': 'talos', 12:38:35 INFO - 'log_to_console': True, 12:38:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:38:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:38:35 INFO - 'opt_config_files': (), 12:38:35 INFO - 'pip_index': False, 12:38:35 INFO - 'sps_profile': False, 12:38:35 INFO - 'sps_profile_interval': 0, 12:38:35 INFO - 'suite': 'dromaeojs-e10s', 12:38:35 INFO - 'system_bits': '32', 12:38:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:38:35 INFO - 'title': 'talos-linux64-ix-050', 12:38:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:38:35 INFO - 'use_talos_json': True, 12:38:35 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:38:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:38:35 INFO - 'work_dir': 'build'} 12:38:35 INFO - ##### 12:38:35 INFO - ##### Running clobber step. 12:38:35 INFO - ##### 12:38:35 INFO - Running pre-action listener: _resource_record_pre_action 12:38:35 INFO - Running main action method: clobber 12:38:35 INFO - rmtree: /builds/slave/test-pgo/build 12:38:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:38:36 INFO - Running post-action listener: _resource_record_post_action 12:38:36 INFO - ##### 12:38:36 INFO - ##### Running read-buildbot-config step. 12:38:37 INFO - ##### 12:38:37 INFO - Running pre-action listener: _resource_record_pre_action 12:38:37 INFO - Running main action method: read_buildbot_config 12:38:37 INFO - Using buildbot properties: 12:38:37 INFO - { 12:38:37 INFO - "project": "", 12:38:37 INFO - "product": "firefox", 12:38:37 INFO - "script_repo_revision": "production", 12:38:37 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 12:38:37 INFO - "repository": "", 12:38:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 12:38:37 INFO - "buildid": "20160308004005", 12:38:37 INFO - "stage_platform": "linux64-pgo", 12:38:37 INFO - "basedir": "/builds/slave/test-pgo", 12:38:37 INFO - "nightly_build": "True", 12:38:37 INFO - "buildnumber": 190, 12:38:37 INFO - "slavename": "talos-linux64-ix-050", 12:38:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:38:37 INFO - "platform": "ubuntu64_hw", 12:38:37 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 12:38:37 INFO - "branch": "mozilla-aurora", 12:38:37 INFO - "repo_path": "releases/mozilla-aurora", 12:38:37 INFO - "revision": "ce9a5e723e4b21ce0dac5ede64e156023bb70534", 12:38:37 INFO - "pgo_build": "True", 12:38:37 INFO - "builduid": "910d3bff56774b48867b4e7b0f6eff08", 12:38:37 INFO - "slavebuilddir": "test" 12:38:37 INFO - } 12:38:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 12:38:37 INFO - Running post-action listener: _resource_record_post_action 12:38:37 INFO - ##### 12:38:37 INFO - ##### Running download-and-extract step. 12:38:37 INFO - ##### 12:38:37 INFO - Running pre-action listener: _resource_record_pre_action 12:38:37 INFO - Running main action method: download_and_extract 12:38:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:38: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')]} 12:38:37 INFO - https://queue.taskcluster.net/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:38:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 12:38:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 12:38:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 12:38:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:38:37 INFO - Downloaded 1448 bytes. 12:38:37 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 12:38:37 INFO - Using the following test package requirements: 12:38:37 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 12:38:37 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:38:37 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 12:38:37 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:38:37 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 12:38:37 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:38:37 INFO - u'jsshell-linux-x86_64.zip'], 12:38:37 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:38:37 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 12:38:37 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 12:38:37 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:38:37 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 12:38:37 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:38:37 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 12:38:37 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:38:37 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 12:38:37 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 12:38:37 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:38:37 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 12:38:37 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:38: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')]} 12:38:37 INFO - https://queue.taskcluster.net/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:38:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 12:38:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 12:38:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 12:38:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:38:38 INFO - Downloaded 23305677 bytes. 12:38:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 12:38:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 12:38:39 INFO - Return code: 0 12:38:39 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:38: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')]} 12:38:39 INFO - https://queue.taskcluster.net/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:38:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 12:38:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 12:38:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 12:38:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:38:41 INFO - Downloaded 23305677 bytes. 12:38:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 12:38:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 12:38:42 INFO - Return code: 0 12:38:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:38:42 INFO - https://queue.taskcluster.net/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:38:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 12:38:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 12:38:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 12:38:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:38:43 INFO - Downloaded 10845161 bytes. 12:38:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 12:38:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 12:38:43 INFO - Return code: 0 12:38: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')]} 12:38:43 INFO - https://queue.taskcluster.net/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:38:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 12:38:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 12:38:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 12:38:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:38:45 INFO - Downloaded 60410196 bytes. 12:38:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 12:38:45 INFO - mkdir: /builds/slave/test-pgo/properties 12:38:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:38:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:38:45 INFO - Contents: 12:38:45 INFO - build_url:https://queue.taskcluster.net/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 12:38:46 INFO - Running post-action listener: _resource_record_post_action 12:38:46 INFO - Running post-action listener: set_extra_try_arguments 12:38:46 INFO - ##### 12:38:46 INFO - ##### Running populate-webroot step. 12:38:46 INFO - ##### 12:38:46 INFO - Running pre-action listener: _resource_record_pre_action 12:38:46 INFO - Running main action method: populate_webroot 12:38:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:38:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:38:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:38:46 INFO - '--tppagecycles', 12:38:46 INFO - '7'], 12:38:46 INFO - 'tests': ['tsvgm']}}, 12:38:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:38:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:38:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:38:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 12:38:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:38:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:38:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:38:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:46 INFO - 'talos_options': ['--e10s'], 12:38:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:38:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:46 INFO - 'tests': ['damp', 'tps']}, 12:38:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:46 INFO - 'talos_options': ['--e10s'], 12:38:46 INFO - 'tests': ['damp', 'tps']}, 12:38:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:38:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:38:46 INFO - 'other': {'tests': ['a11yr', 12:38:46 INFO - 'ts_paint', 12:38:46 INFO - 'tpaint', 12:38:46 INFO - 'sessionrestore', 12:38:46 INFO - 'sessionrestore_no_auto_restore', 12:38:46 INFO - 'tabpaint']}, 12:38:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:38:46 INFO - 'tests': ['a11yr', 12:38:46 INFO - 'ts_paint', 12:38:46 INFO - 'tpaint', 12:38:46 INFO - 'sessionrestore', 12:38:46 INFO - 'sessionrestore_no_auto_restore', 12:38:46 INFO - 'tabpaint']}, 12:38:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:38:46 INFO - 'tests': ['a11yr', 12:38:46 INFO - 'ts_paint', 12:38:46 INFO - 'tpaint', 12:38:46 INFO - 'sessionrestore', 12:38:46 INFO - 'sessionrestore_no_auto_restore', 12:38:46 INFO - 'tabpaint']}, 12:38:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:38:46 INFO - 'tests': ['a11yr', 12:38:46 INFO - 'ts_paint', 12:38:46 INFO - 'tpaint', 12:38:46 INFO - 'sessionrestore', 12:38:46 INFO - 'sessionrestore_no_auto_restore', 12:38:46 INFO - 'tabpaint']}, 12:38:46 INFO - 'other_l64': {'tests': ['a11yr', 12:38:46 INFO - 'ts_paint', 12:38:46 INFO - 'tpaint', 12:38:46 INFO - 'sessionrestore', 12:38:46 INFO - 'sessionrestore_no_auto_restore', 12:38:46 INFO - 'tabpaint']}, 12:38:46 INFO - 'other_nol64': {'tests': ['a11yr', 12:38:46 INFO - 'ts_paint', 12:38:46 INFO - 'tpaint', 12:38:46 INFO - 'sessionrestore', 12:38:46 INFO - 'sessionrestore_no_auto_restore', 12:38:46 INFO - 'tabpaint']}, 12:38:46 INFO - 'svgr': {'tests': ['tsvgx', 12:38:46 INFO - 'tsvgr_opacity', 12:38:46 INFO - 'tart', 12:38:46 INFO - 'tscrollx', 12:38:46 INFO - 'cart']}, 12:38:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:38:46 INFO - 'tests': ['tsvgx', 12:38:46 INFO - 'tsvgr_opacity', 12:38:46 INFO - 'tart', 12:38:46 INFO - 'tscrollx', 12:38:46 INFO - 'cart']}, 12:38:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:46 INFO - 'tests': ['tp5o']}, 12:38:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:46 INFO - 'talos_options': ['--e10s'], 12:38:46 INFO - 'tests': ['tp5o']}, 12:38:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:46 INFO - 'talos_options': ['--xperf_path', 12:38:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:38:46 INFO - 'tests': ['tp5n']}, 12:38:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:46 INFO - 'talos_options': ['--e10s', 12:38:46 INFO - '--xperf_path', 12:38:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:38:46 INFO - 'tests': ['tp5n']}}, 12:38:46 INFO - 'talos.zip': {'path': '', 12:38:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:38:46 INFO - Running post-action listener: _resource_record_post_action 12:38:46 INFO - ##### 12:38:46 INFO - ##### Running create-virtualenv step. 12:38:46 INFO - ##### 12:38:46 INFO - Running pre-action listener: _resource_record_pre_action 12:38:46 INFO - Running main action method: create_virtualenv 12:38:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:38:46 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 12:38:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:38:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:38:46 INFO - Using real prefix '/usr' 12:38:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:38:47 INFO - Installing distribute.............................................................................................................................................................................................done. 12:38:48 INFO - Installing pip.................done. 12:38:48 INFO - Return code: 0 12:38:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:38:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:38:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd81a711f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c9920>, '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 0x22ca820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cacb0>, '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': '6dbc10da6d83fee962c624be000001a8-1457469513.201587-1152426323', '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 12:38:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 12:38:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:38:48 INFO - Using env: {'DISPLAY': ':0', 12:38:48 INFO - 'HOME': '/home/cltbld', 12:38:48 INFO - 'LANG': 'en_US.UTF-8', 12:38:48 INFO - 'LANGUAGE': 'en_US:en', 12:38:48 INFO - 'LOGNAME': 'cltbld', 12:38:48 INFO - 'MAIL': '/var/mail/cltbld', 12:38:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:48 INFO - 'MOZ_NO_REMOTE': '1', 12:38:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:38:48 INFO - 'NO_EM_RESTART': '1', 12:38:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:38:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:38:48 INFO - 'PWD': '/builds/slave/test-pgo', 12:38:48 INFO - 'SHELL': '/bin/bash', 12:38:48 INFO - 'SHLVL': '1', 12:38:48 INFO - 'TERM': 'linux', 12:38:48 INFO - 'TMOUT': '86400', 12:38:48 INFO - 'USER': 'cltbld', 12:38:48 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1457469513.201587-1152426323', 12:38:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:48 INFO - '_': '/tools/buildbot/bin/python'} 12:38:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:49 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 12:38:49 INFO - Cleaning up... 12:38:49 INFO - Return code: 0 12:38:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:38:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:49 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 0x7fd81a711f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c9920>, '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 0x22ca820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cacb0>, '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': '6dbc10da6d83fee962c624be000001a8-1457469513.201587-1152426323', '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 12:38:49 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 12:38:49 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 12:38:49 INFO - Using env: {'DISPLAY': ':0', 12:38:49 INFO - 'HOME': '/home/cltbld', 12:38:49 INFO - 'LANG': 'en_US.UTF-8', 12:38:49 INFO - 'LANGUAGE': 'en_US:en', 12:38:49 INFO - 'LOGNAME': 'cltbld', 12:38:49 INFO - 'MAIL': '/var/mail/cltbld', 12:38:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:49 INFO - 'MOZ_NO_REMOTE': '1', 12:38:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:38:49 INFO - 'NO_EM_RESTART': '1', 12:38:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:38:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:38:49 INFO - 'PWD': '/builds/slave/test-pgo', 12:38:49 INFO - 'SHELL': '/bin/bash', 12:38:49 INFO - 'SHLVL': '1', 12:38:49 INFO - 'TERM': 'linux', 12:38:49 INFO - 'TMOUT': '86400', 12:38:49 INFO - 'USER': 'cltbld', 12:38:49 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1457469513.201587-1152426323', 12:38:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:49 INFO - '_': '/tools/buildbot/bin/python'} 12:38:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:49 INFO - Downloading/unpacking psutil>=0.7.1 12:38:49 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 12:38:49 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 12:38:49 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 12:38:49 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 12:38:49 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 12:38:49 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 12:38:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:38:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:38:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:38:51 INFO - Installing collected packages: psutil 12:38:51 INFO - Running setup.py install for psutil 12:38:51 INFO - building 'psutil._psutil_linux' extension 12:38:51 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 12:38:51 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 12:38:51 INFO - building 'psutil._psutil_posix' extension 12:38:51 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 12:38:51 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 12:38:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:38:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:38:51 INFO - Successfully installed psutil 12:38:51 INFO - Cleaning up... 12:38:51 INFO - Return code: 0 12:38:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:38:51 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')]} 12:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:51 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')]} 12:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:51 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 0x7fd81a711f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c9920>, '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 0x22ca820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cacb0>, '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': '6dbc10da6d83fee962c624be000001a8-1457469513.201587-1152426323', '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 12:38:51 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 12:38:51 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 12:38:51 INFO - Using env: {'DISPLAY': ':0', 12:38:51 INFO - 'HOME': '/home/cltbld', 12:38:51 INFO - 'LANG': 'en_US.UTF-8', 12:38:51 INFO - 'LANGUAGE': 'en_US:en', 12:38:51 INFO - 'LOGNAME': 'cltbld', 12:38:51 INFO - 'MAIL': '/var/mail/cltbld', 12:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:51 INFO - 'MOZ_NO_REMOTE': '1', 12:38:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:38:51 INFO - 'NO_EM_RESTART': '1', 12:38:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:38:51 INFO - 'PWD': '/builds/slave/test-pgo', 12:38:51 INFO - 'SHELL': '/bin/bash', 12:38:51 INFO - 'SHLVL': '1', 12:38:51 INFO - 'TERM': 'linux', 12:38:51 INFO - 'TMOUT': '86400', 12:38:51 INFO - 'USER': 'cltbld', 12:38:51 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1457469513.201587-1152426323', 12:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:51 INFO - '_': '/tools/buildbot/bin/python'} 12:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:38: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 12:38: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 12:38: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 12:38: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 12:38: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 12:38: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 12:38:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:38:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:38:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:38:53 INFO - Installing collected packages: mozsystemmonitor 12:38:53 INFO - Running setup.py install for mozsystemmonitor 12:38:54 INFO - Successfully installed mozsystemmonitor 12:38:54 INFO - Cleaning up... 12:38:54 INFO - Return code: 0 12:38:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:38:54 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')]} 12:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:54 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')]} 12:38:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:54 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 0x7fd81a711f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c9920>, '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 0x22ca820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cacb0>, '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': '6dbc10da6d83fee962c624be000001a8-1457469513.201587-1152426323', '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 12:38:54 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 12:38:54 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 12:38:54 INFO - Using env: {'DISPLAY': ':0', 12:38:54 INFO - 'HOME': '/home/cltbld', 12:38:54 INFO - 'LANG': 'en_US.UTF-8', 12:38:54 INFO - 'LANGUAGE': 'en_US:en', 12:38:54 INFO - 'LOGNAME': 'cltbld', 12:38:54 INFO - 'MAIL': '/var/mail/cltbld', 12:38:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:54 INFO - 'MOZ_NO_REMOTE': '1', 12:38:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:38:54 INFO - 'NO_EM_RESTART': '1', 12:38:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:38:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:38:54 INFO - 'PWD': '/builds/slave/test-pgo', 12:38:54 INFO - 'SHELL': '/bin/bash', 12:38:54 INFO - 'SHLVL': '1', 12:38:54 INFO - 'TERM': 'linux', 12:38:54 INFO - 'TMOUT': '86400', 12:38:54 INFO - 'USER': 'cltbld', 12:38:54 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1457469513.201587-1152426323', 12:38:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:54 INFO - '_': '/tools/buildbot/bin/python'} 12:38:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:54 INFO - Downloading/unpacking blobuploader==1.2.4 12:38:54 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 12:38:54 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 12:38:54 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 12:38:54 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 12:38:54 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 12:38:54 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 12:38:56 INFO - Downloading blobuploader-1.2.4.tar.gz 12:38:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:38:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:38:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:38:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:38:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:38:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:38:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:38:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:38:56 INFO - Downloading docopt-0.6.1.tar.gz 12:38:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:38:56 INFO - Installing collected packages: blobuploader, requests, docopt 12:38:56 INFO - Running setup.py install for blobuploader 12:38:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:38:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:38:56 INFO - Running setup.py install for requests 12:38:57 INFO - Running setup.py install for docopt 12:38:57 INFO - Successfully installed blobuploader requests docopt 12:38:57 INFO - Cleaning up... 12:38:57 INFO - Return code: 0 12:38:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:38:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:57 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 0x7fd81a711f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c9920>, '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 0x22ca820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cacb0>, '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': '6dbc10da6d83fee962c624be000001a8-1457469513.201587-1152426323', '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 12:38:57 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 12:38:57 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 12:38:57 INFO - Using env: {'DISPLAY': ':0', 12:38:57 INFO - 'HOME': '/home/cltbld', 12:38:57 INFO - 'LANG': 'en_US.UTF-8', 12:38:57 INFO - 'LANGUAGE': 'en_US:en', 12:38:57 INFO - 'LOGNAME': 'cltbld', 12:38:57 INFO - 'MAIL': '/var/mail/cltbld', 12:38:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:57 INFO - 'MOZ_NO_REMOTE': '1', 12:38:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:38:57 INFO - 'NO_EM_RESTART': '1', 12:38:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:38:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:38:57 INFO - 'PWD': '/builds/slave/test-pgo', 12:38:57 INFO - 'SHELL': '/bin/bash', 12:38:57 INFO - 'SHLVL': '1', 12:38:57 INFO - 'TERM': 'linux', 12:38:57 INFO - 'TMOUT': '86400', 12:38:57 INFO - 'USER': 'cltbld', 12:38:57 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1457469513.201587-1152426323', 12:38:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:57 INFO - '_': '/tools/buildbot/bin/python'} 12:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:38:57 INFO - Running setup.py (path:/tmp/pip-VOA1gx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:38:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:38:57 INFO - Running setup.py (path:/tmp/pip-IvvSMW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:38:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:38:57 INFO - Running setup.py (path:/tmp/pip-_UVDVO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:38:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:38:57 INFO - Running setup.py (path:/tmp/pip-iJehGi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:38:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:38:57 INFO - Running setup.py (path:/tmp/pip-alcCK0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:38:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:38:57 INFO - Running setup.py (path:/tmp/pip-lTxdN2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:38:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:38:58 INFO - Running setup.py (path:/tmp/pip-f1raoe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:38:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:38:58 INFO - Running setup.py (path:/tmp/pip-XL932x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:38:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:38:58 INFO - Running setup.py (path:/tmp/pip-jm0g7c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:38:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:38:58 INFO - Running setup.py (path:/tmp/pip-zuRvAI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:38:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:38:58 INFO - Running setup.py (path:/tmp/pip-Li7fOy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:38:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:38:58 INFO - Running setup.py (path:/tmp/pip-aL15JH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:38:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:38:58 INFO - Running setup.py (path:/tmp/pip-NnnUae-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:38:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:38:58 INFO - Running setup.py (path:/tmp/pip-PJ8Lyq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:38:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:38:58 INFO - Running setup.py (path:/tmp/pip-vEEU9j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:38:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:38:58 INFO - Running setup.py (path:/tmp/pip-tfGgtf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:38:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:38:58 INFO - Running setup.py (path:/tmp/pip-Eek5uZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:38:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:38:58 INFO - Running setup.py install for manifestparser 12:38:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:38:58 INFO - Running setup.py install for mozcrash 12:38:59 INFO - Running setup.py install for mozdebug 12:38:59 INFO - Running setup.py install for mozdevice 12:38:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:38:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:38:59 INFO - Running setup.py install for mozfile 12:38:59 INFO - Running setup.py install for mozhttpd 12:38:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:38:59 INFO - Running setup.py install for mozinfo 12:38:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:38:59 INFO - Running setup.py install for mozInstall 12:38:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:38:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:38:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:38:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:38:59 INFO - Running setup.py install for mozleak 12:38:59 INFO - Running setup.py install for mozlog 12:38:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:38:59 INFO - Running setup.py install for moznetwork 12:38:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:38:59 INFO - Running setup.py install for mozprocess 12:39:00 INFO - Running setup.py install for mozprofile 12:39:00 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:39:00 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:39:00 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:39:00 INFO - Running setup.py install for mozrunner 12:39:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:39:00 INFO - Running setup.py install for mozscreenshot 12:39:00 INFO - Running setup.py install for moztest 12:39:00 INFO - Running setup.py install for mozversion 12:39:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:39:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:39:00 INFO - Cleaning up... 12:39:00 INFO - Return code: 0 12:39:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:00 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 0x7fd81a711f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c9920>, '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 0x22ca820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cacb0>, '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': '6dbc10da6d83fee962c624be000001a8-1457469513.201587-1152426323', '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 12:39:00 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 12:39:00 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 12:39:00 INFO - Using env: {'DISPLAY': ':0', 12:39:00 INFO - 'HOME': '/home/cltbld', 12:39:00 INFO - 'LANG': 'en_US.UTF-8', 12:39:00 INFO - 'LANGUAGE': 'en_US:en', 12:39:00 INFO - 'LOGNAME': 'cltbld', 12:39:00 INFO - 'MAIL': '/var/mail/cltbld', 12:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:00 INFO - 'MOZ_NO_REMOTE': '1', 12:39:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:00 INFO - 'NO_EM_RESTART': '1', 12:39:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:39:00 INFO - 'PWD': '/builds/slave/test-pgo', 12:39:00 INFO - 'SHELL': '/bin/bash', 12:39:00 INFO - 'SHLVL': '1', 12:39:00 INFO - 'TERM': 'linux', 12:39:00 INFO - 'TMOUT': '86400', 12:39:00 INFO - 'USER': 'cltbld', 12:39:00 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1457469513.201587-1152426323', 12:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:00 INFO - '_': '/tools/buildbot/bin/python'} 12:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:39:00 INFO - Running setup.py (path:/tmp/pip-_rdvJ6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:39:00 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)) 12:39:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:39:00 INFO - Running setup.py (path:/tmp/pip-l75zel-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:39:00 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)) 12:39:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:39:00 INFO - Running setup.py (path:/tmp/pip-YrOlHV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:39:01 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)) 12:39:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:39:01 INFO - Running setup.py (path:/tmp/pip-ojs1Hj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:39:01 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)) 12:39:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:39:01 INFO - Running setup.py (path:/tmp/pip-gaTRxZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:39:01 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)) 12:39:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:39:01 INFO - Running setup.py (path:/tmp/pip-X8Q0f5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:39:01 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)) 12:39:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:39:01 INFO - Running setup.py (path:/tmp/pip-4KoqLi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:39:01 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)) 12:39:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:39:01 INFO - Running setup.py (path:/tmp/pip-pUdqJU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:39:01 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)) 12:39:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:39:01 INFO - Running setup.py (path:/tmp/pip-mOPSsT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:39:01 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)) 12:39:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:39:01 INFO - Running setup.py (path:/tmp/pip-XsN7tB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:39:01 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)) 12:39:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:39:01 INFO - Running setup.py (path:/tmp/pip-eiE9Je-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:39:01 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)) 12:39:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:39:01 INFO - Running setup.py (path:/tmp/pip-gkb7Mv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:39:01 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)) 12:39:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:39:01 INFO - Running setup.py (path:/tmp/pip-_dKNRm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:39:01 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)) 12:39:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:39:01 INFO - Running setup.py (path:/tmp/pip-UkJKAl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:39:01 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)) 12:39:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:39:01 INFO - Running setup.py (path:/tmp/pip-M1uF2S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:39:01 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)) 12:39:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:39:01 INFO - Running setup.py (path:/tmp/pip-OfYlj4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:39:02 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)) 12:39:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:39:02 INFO - Running setup.py (path:/tmp/pip-ytW0vG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:39:02 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)) 12:39:02 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)) 12:39:02 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)) 12:39:02 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)) 12:39:02 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)) 12:39:02 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)) 12:39:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:03 INFO - Downloading blessings-1.6.tar.gz 12:39:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:39:03 INFO - Installing collected packages: blessings 12:39:04 INFO - Running setup.py install for blessings 12:39:04 INFO - Successfully installed blessings 12:39:04 INFO - Cleaning up... 12:39:04 INFO - Return code: 0 12:39:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:39:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:39:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:39:04 INFO - Reading from file tmpfile_stdout 12:39:04 INFO - Current package versions: 12:39:04 INFO - argparse == 1.2.1 12:39:04 INFO - blessings == 1.6 12:39:04 INFO - blobuploader == 1.2.4 12:39:04 INFO - docopt == 0.6.1 12:39:04 INFO - manifestparser == 1.1 12:39:04 INFO - mozInstall == 1.12 12:39:04 INFO - mozcrash == 0.17 12:39:04 INFO - mozdebug == 0.1 12:39:04 INFO - mozdevice == 0.48 12:39:04 INFO - mozfile == 1.2 12:39:04 INFO - mozhttpd == 0.7 12:39:04 INFO - mozinfo == 0.9 12:39:04 INFO - mozleak == 0.1 12:39:04 INFO - mozlog == 3.1 12:39:04 INFO - moznetwork == 0.27 12:39:04 INFO - mozprocess == 0.22 12:39:04 INFO - mozprofile == 0.28 12:39:04 INFO - mozrunner == 6.11 12:39:04 INFO - mozscreenshot == 0.1 12:39:04 INFO - mozsystemmonitor == 0.0 12:39:04 INFO - moztest == 0.7 12:39:04 INFO - mozversion == 1.4 12:39:04 INFO - psutil == 3.1.1 12:39:04 INFO - requests == 1.2.3 12:39:04 INFO - wsgiref == 0.1.2 12:39:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fd81a711f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c9920>, '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 0x22ca820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cacb0>, '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': '6dbc10da6d83fee962c624be000001a8-1457469513.201587-1152426323', '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 12:39:04 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 12:39:04 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 12:39:04 INFO - Using env: {'DISPLAY': ':0', 12:39:04 INFO - 'HOME': '/home/cltbld', 12:39:04 INFO - 'LANG': 'en_US.UTF-8', 12:39:04 INFO - 'LANGUAGE': 'en_US:en', 12:39:04 INFO - 'LOGNAME': 'cltbld', 12:39:04 INFO - 'MAIL': '/var/mail/cltbld', 12:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:04 INFO - 'MOZ_NO_REMOTE': '1', 12:39:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:04 INFO - 'NO_EM_RESTART': '1', 12:39:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:39:04 INFO - 'PWD': '/builds/slave/test-pgo', 12:39:04 INFO - 'SHELL': '/bin/bash', 12:39:04 INFO - 'SHLVL': '1', 12:39:04 INFO - 'TERM': 'linux', 12:39:04 INFO - 'TMOUT': '86400', 12:39:04 INFO - 'USER': 'cltbld', 12:39:04 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1457469513.201587-1152426323', 12:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:04 INFO - '_': '/tools/buildbot/bin/python'} 12:39:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:04 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)) 12:39:04 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)) 12:39:04 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)) 12:39:04 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)) 12:39:04 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)) 12:39:04 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)) 12:39:04 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)) 12:39:04 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)) 12:39:04 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)) 12:39:04 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)) 12:39:04 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)) 12:39:04 INFO - Cleaning up... 12:39:04 INFO - Return code: 0 12:39:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 12:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:04 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 0x7fd81a711f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c9920>, '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 0x22ca820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cacb0>, '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': '6dbc10da6d83fee962c624be000001a8-1457469513.201587-1152426323', '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 12:39:04 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 12:39:04 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 12:39:04 INFO - Using env: {'DISPLAY': ':0', 12:39:04 INFO - 'HOME': '/home/cltbld', 12:39:04 INFO - 'LANG': 'en_US.UTF-8', 12:39:04 INFO - 'LANGUAGE': 'en_US:en', 12:39:04 INFO - 'LOGNAME': 'cltbld', 12:39:04 INFO - 'MAIL': '/var/mail/cltbld', 12:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:04 INFO - 'MOZ_NO_REMOTE': '1', 12:39:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:04 INFO - 'NO_EM_RESTART': '1', 12:39:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:39:04 INFO - 'PWD': '/builds/slave/test-pgo', 12:39:04 INFO - 'SHELL': '/bin/bash', 12:39:04 INFO - 'SHLVL': '1', 12:39:04 INFO - 'TERM': 'linux', 12:39:04 INFO - 'TMOUT': '86400', 12:39:04 INFO - 'USER': 'cltbld', 12:39:04 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1457469513.201587-1152426323', 12:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:04 INFO - '_': '/tools/buildbot/bin/python'} 12:39:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:04 INFO - Downloading/unpacking jsonschema 12:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:39:06 INFO - Downloading/unpacking functools32 (from jsonschema) 12:39:06 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 12:39:06 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 12:39:06 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 12:39:06 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 12:39:06 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 12:39:06 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 12:39:06 INFO - Downloading functools32-3.2.3-2.tar.gz 12:39:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 12:39:06 INFO - warning: no files found matching '*.txt' 12:39:06 INFO - no previously-included directories found matching 'build' 12:39:06 INFO - no previously-included directories found matching 'dist' 12:39:06 INFO - no previously-included directories found matching '.git*' 12:39:06 INFO - Installing collected packages: jsonschema, functools32 12:39:06 INFO - Running setup.py install for functools32 12:39:07 INFO - warning: no files found matching '*.txt' 12:39:07 INFO - no previously-included directories found matching 'build' 12:39:07 INFO - no previously-included directories found matching 'dist' 12:39:07 INFO - no previously-included directories found matching '.git*' 12:39:07 INFO - Successfully installed jsonschema functools32 12:39:07 INFO - Cleaning up... 12:39:07 INFO - Return code: 0 12:39:07 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 12:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd81a711f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c9920>, '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 0x22ca820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cacb0>, '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': '6dbc10da6d83fee962c624be000001a8-1457469513.201587-1152426323', '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 12:39:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 12:39:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:39:07 INFO - Using env: {'DISPLAY': ':0', 12:39:07 INFO - 'HOME': '/home/cltbld', 12:39:07 INFO - 'LANG': 'en_US.UTF-8', 12:39:07 INFO - 'LANGUAGE': 'en_US:en', 12:39:07 INFO - 'LOGNAME': 'cltbld', 12:39:07 INFO - 'MAIL': '/var/mail/cltbld', 12:39:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:07 INFO - 'MOZ_NO_REMOTE': '1', 12:39:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:07 INFO - 'NO_EM_RESTART': '1', 12:39:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:39:07 INFO - 'PWD': '/builds/slave/test-pgo', 12:39:07 INFO - 'SHELL': '/bin/bash', 12:39:07 INFO - 'SHLVL': '1', 12:39:07 INFO - 'TERM': 'linux', 12:39:07 INFO - 'TMOUT': '86400', 12:39:07 INFO - 'USER': 'cltbld', 12:39:07 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1457469513.201587-1152426323', 12:39:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:07 INFO - '_': '/tools/buildbot/bin/python'} 12:39:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:07 INFO - Downloading/unpacking flake8 12:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:39:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:39:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 12:39:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:39:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:39:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:39:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:39:09 INFO - no previously-included directories found matching 'docs/_build' 12:39:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:39:09 INFO - Running setup.py install for pep8 12:39:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:39:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:39:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:39:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:39:09 INFO - no previously-included directories found matching 'docs/_build' 12:39:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 12:39:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:39:09 INFO - Cleaning up... 12:39:10 INFO - Return code: 0 12:39:10 INFO - Running post-action listener: _resource_record_post_action 12:39:10 INFO - Running post-action listener: _start_resource_monitoring 12:39:10 INFO - Starting resource monitoring. 12:39:10 INFO - ##### 12:39:10 INFO - ##### Running install step. 12:39:10 INFO - ##### 12:39:10 INFO - Running pre-action listener: _resource_record_pre_action 12:39:10 INFO - Running main action method: install 12:39:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:39:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:39:10 INFO - Reading from file tmpfile_stdout 12:39:10 INFO - Detecting whether we're running mozinstall >=1.0... 12:39:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:39:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:39:10 INFO - Reading from file tmpfile_stdout 12:39:10 INFO - Output received: 12:39:10 INFO - Usage: mozinstall [options] installer 12:39:10 INFO - Options: 12:39:10 INFO - -h, --help show this help message and exit 12:39:10 INFO - -d DEST, --destination=DEST 12:39:10 INFO - Directory to install application into. [default: 12:39:10 INFO - "/builds/slave/test-pgo"] 12:39:10 INFO - --app=APP Application being installed. [default: firefox] 12:39:10 INFO - mkdir: /builds/slave/test-pgo/build/application 12:39:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 12:39:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 12:39:25 INFO - Reading from file tmpfile_stdout 12:39:25 INFO - Output received: 12:39:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:39:25 INFO - Running post-action listener: _resource_record_post_action 12:39:25 INFO - ##### 12:39:25 INFO - ##### Running run-tests step. 12:39:25 INFO - ##### 12:39:25 INFO - Running pre-action listener: _resource_record_pre_action 12:39:25 INFO - Running main action method: run_tests 12:39:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:39:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:39:25 INFO - Python 2.7.3 12:39:25 INFO - Return code: 0 12:39:25 INFO - grabbing minidump binary from tooltool 12:39: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')]} 12:39:25 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 0x22c9920>, '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 0x22ca820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cacb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:39:25 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 12:39:25 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 12:39:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:39:25 INFO - Return code: 0 12:39:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:39:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:39:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:39:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:39:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:39:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 12:39:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 12:39:26 INFO - Return code: 0 12:39:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 12:39:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:39:26 INFO - Using env: {'DISPLAY': ':0', 12:39:26 INFO - 'HOME': '/home/cltbld', 12:39:26 INFO - 'LANG': 'en_US.UTF-8', 12:39:26 INFO - 'LANGUAGE': 'en_US:en', 12:39:26 INFO - 'LOGNAME': 'cltbld', 12:39:26 INFO - 'MAIL': '/var/mail/cltbld', 12:39:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:39:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:39:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:26 INFO - 'MOZ_NO_REMOTE': '1', 12:39:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:39:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:26 INFO - 'NO_EM_RESTART': '1', 12:39:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:39:26 INFO - 'PWD': '/builds/slave/test-pgo', 12:39:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:39:26 INFO - 'SHELL': '/bin/bash', 12:39:26 INFO - 'SHLVL': '1', 12:39:26 INFO - 'TERM': 'linux', 12:39:26 INFO - 'TMOUT': '86400', 12:39:26 INFO - 'USER': 'cltbld', 12:39:26 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1457469513.201587-1152426323', 12:39:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:26 INFO - '_': '/tools/buildbot/bin/python'} 12:39:26 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:39:26 INFO - mozversion application_buildid: 20160308004005 12:39:26 INFO - mozversion application_changeset: ce9a5e723e4b21ce0dac5ede64e156023bb70534 12:39:26 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:39:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:39:26 INFO - mozversion application_name: Firefox 12:39:26 INFO - mozversion application_remotingname: firefox-dev 12:39:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:39:26 INFO - mozversion application_vendor: Mozilla 12:39:26 INFO - mozversion application_version: 47.0a2 12:39:26 INFO - mozversion platform_buildid: 20160308004005 12:39:26 INFO - mozversion platform_changeset: ce9a5e723e4b21ce0dac5ede64e156023bb70534 12:39:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:39:26 INFO - mozversion platform_version: 47.0a2 12:39:26 INFO - using testdate: 1457469566 12:39:26 INFO - actual date: 1457469566 12:39:26 INFO - starting webserver on 'localhost:33672' 12:39:26 INFO - SUITE-START | Running 2 tests 12:39:26 INFO - TEST-START | dromaeo_css 12:39:26 INFO - operating with platform_type : linux_ 12:39:26 INFO - Initialising browser for dromaeo_css test... 12:39:26 INFO - TEST-INFO | started process 18565 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXswqex/profile http://localhost:33672/getInfo.html) 12:39:30 INFO - PROCESS | 18565 | 12:39:30 INFO - PROCESS | 18565 | (process:18643): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:39:31 INFO - PROCESS | 18565 | __metrics Screen width/height:1600/1200 12:39:31 INFO - PROCESS | 18565 | colorDepth:24 12:39:31 INFO - PROCESS | 18565 | Browser inner width/height: 1024/697 12:39:31 INFO - PROCESS | 18565 | __metrics 12:39:31 ERROR - PROCESS | 18565 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 12:39:32 INFO - TEST-INFO | 18565: exit 0 12:39:32 INFO - Browser initialized. 12:39:32 INFO - Running cycle 1/1 for dromaeo_css test... 12:39:32 INFO - TEST-INFO | started process 18694 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXswqex/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:39:34 INFO - PROCESS | 18694 | 12:39:34 INFO - PROCESS | 18694 | (process:18762): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:39:44 INFO - PROCESS | 18694 | RSS: Main: 153890816 12:39:44 INFO - PROCESS | 18694 | 12:40:34 INFO - PROCESS | 18694 | 1457469634182 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] 12:42:42 INFO - PROCESS | 18694 | Cycle 1(1): loaded http://localhost:33672/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33672/tests/dromaeo/cssquery-ext.html) 12:42:43 INFO - PROCESS | 18694 | RSS: Main: 156786688 12:42:43 INFO - PROCESS | 18694 | 12:45:45 INFO - PROCESS | 18694 | Cycle 1(1): loaded http://localhost:33672/tests/dromaeo/cssquery-ext.html (next: http://localhost:33672/tests/dromaeo/cssquery-jquery.html) 12:45:45 INFO - PROCESS | 18694 | RSS: Main: 154734592 12:45:45 INFO - PROCESS | 18694 | 12:48:47 INFO - PROCESS | 18694 | Cycle 1(1): loaded http://localhost:33672/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33672/tests/dromaeo/cssquery-mootools.html) 12:48:47 INFO - PROCESS | 18694 | RSS: Main: 154329088 12:48:47 INFO - PROCESS | 18694 | 12:51:49 INFO - PROCESS | 18694 | Cycle 1(1): loaded http://localhost:33672/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33672/tests/dromaeo/cssquery-prototype.html) 12:51:50 INFO - PROCESS | 18694 | RSS: Main: 154050560 12:51:50 INFO - PROCESS | 18694 | 12:54:52 INFO - PROCESS | 18694 | Cycle 1(1): loaded http://localhost:33672/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33672/tests/dromaeo/cssquery-yui.html) 12:54:53 INFO - PROCESS | 18694 | RSS: Main: 155049984 12:54:53 INFO - PROCESS | 18694 | 12:57:55 INFO - PROCESS | 18694 | Cycle 1(1): loaded http://localhost:33672/tests/dromaeo/cssquery-yui.html (next: http://localhost:33672/tests/dromaeo/cssquery-dojo.html) 12:57:55 INFO - PROCESS | 18694 | RSS: Main: 158883840 12:57:55 INFO - PROCESS | 18694 | 12:57:55 INFO - PROCESS | 18694 | __start_tp_report 12:57:55 INFO - PROCESS | 18694 | _x_x_mozilla_page_load 12:57:55 INFO - PROCESS | 18694 | _x_x_mozilla_page_load_details 12:57:55 INFO - PROCESS | 18694 | |i|pagename|runs| 12:57:55 INFO - PROCESS | 18694 | |0;dojo.html;3348.4642457206846;3380.6281309056017;3410.9658903410973;3417.709494692951;3439.1917899293644;5498.285222921025;5536.4186760390085;5543;5579.246801681772;5587.41332160123;5601.103823388259;5638.492535671799;5639.746211420485;5665.886682266352;5679.062954612495;5098.5921126309995;5120.769565369549;5140.023395554833;5178.6892786432745;5252.6323157379;5080.974595127019;5176.715280659581;5266.5786737061135;5268.31511903452;5292.788288468457;5122.154844450662;5196.168613021917;5213.530782229599;5223.112070947948;5250.44870288618;5113.284140220372;5154.639175257734;5171.4311425743135;5172.19830926207;5198.402183748861;5041.974790126026;5076.746162691888;5105.897882042375;5144.382674079097;5145.588352931756;5394.406615272317;5403.297571315743;5434.184872269152;5435.864103397407;5444.3194600674915;5885.558583106242;5980.312264089642;6013.51891848651;6016.007358785795;6028.065649824241;6066.423689749467;6120.995022892694;6125.297889100503;6135.845176233296;6142.897836592492;5666.150077488369;5698.6580805151825;5700.429957004267;5709.543236541108;5712.428757124254;6046.909296360558;6122.663253521099;6161.7227224775;6233.844153896189;6248.250209974741;5955.285365756137;5963.194968679173;5965.28416590012;5965.343812180657;5966.970165149147;6000.669963152069;6067.302260240041;6075.817725468243;6079.270487541523;6081.483073938764;5919;6015.969920150371;6036.909446358308;6110.847228819315;6136.457808108435;5966.134910437962;5997.370276121032;6019;6024.1566180734735;6032.849178770566;4552.08958208353;4563.680542362003;4566.383538222364;4579.129965306581;4595.080983803253;4042.191561687674;4080.489938757655;4149.37759336102;4186.016286172747;4216.198922204771;5723.456271654186;5781.19063331134;5785;5814;5873.882522349614;6145.907811382744;6168.290646575611;6178.289496707846;6178.907316390258;6183.628982261079;5702.087665973508;5779.33537643168;5829.650220986754;5850.0932355484965;5897.882042359129;5203.687778733288;5214.817481388133;5233.058049551041;5255.08036093682;5255.947440525546;6115.51416190291;6286.779962701284;6287.49700023997;6289.7484100635465;6341.556091073673;6109.053096770008;6138.541671868523;6197;6209.59637623553;6218.751249950133;6120.540959427972;6188.566800323934;6204.348543402878;6211.09939058843;6230.470410015199;5867.5305975521005;5980.431858973565;5989.640402430382;6002.909956350571;6009.519238460825;6016.458518733335;6086.817395478142;6094.7562097517375;6097.451229389376;6120.08198770188;5845.09401042839;5877.941220587911;5881.9705901470215;5885.205497257815;5908.143319218603;5852.326982397079;5892.204552385373;5903.852403689943;5965.701714914324;6009.54928380382;5866.354700982974;5885.911711324248;5899.292084949662;5908.793192238251;5915.112733090071;5985.910211346746;5995.790147344822;6001.7599296027665;6033.728482218223;6050.152978582913;5750.424957504216;5833.708314584169;5884.823455296348;5891.1457838614015;5931.881362372815 12:57:55 INFO - PROCESS | 18694 | |1;ext.html;531.5428731291091;555.5583311267542;563.8308507447766;571.34010218198;578.3146970839558;37911.81044094779;38383;38599;38664.806675966654;38714.612853871455;40669.389959150634;41125.794371028176;41260.17479650405;41275.380869286986;41376.58623413765;8682.218600325985;8846.823063538724;8857.689980850671;8897.95551022244;8918.821623567525;8663.956680216621;8986.505742184178;9038.638454461814;9043.728688139367;9044.412113212653;9057.637694492212;9145.085491450835;9154.038825923282;9158.49628270445;9163.679271225508;9029.729108126767;9091.590878410487;9095.135962083592;9107.726768196964;9107.95446022769;8978.191962723386;9097.727068187965;9105.226055785266;9130.863037054449;9145.90249170104;39699;39905.40141897874;40260.798696006335;40345.39481907774;40371;3516.9472457913153;3664.157243833933;3698.389765688658;3717.8698745544048;3829.9617003829885;29010;29234;29242;29745.107646770415;29936.101916942527;3685.6682898538993;3727.2918145552258;3745.513083299181;3806.505154329947;3922;211261.99999999846;213419;214403;214939;215137;44892.3266151008;56797.7160114205;60490.39509604935;60862.087068694;61072.69463652742;43598.12803743908;43657;43698.563014370084;43804.78097609555;43882.780586096866;16120.113393763455;16134.031958082553;16204;16238.431654892021;16243.918780406022;13079.149855259378;13094.934525327313;13130.080894337305;13137.934310328386;13193.40629671667;15466.9226653866;15580;15607.765883511756;15644.608884777972;15724.371025158865;6195.721192546346;6214.9689251553455;6224.844378890564;6251.218597675291;6331.778387756406;1005.7787286796893;1027.5941003303653;1034.1519953638094;1134.6327675151588;1137.3801278303345;29859.552106718416;29976.400471990873;30571.847140764155;30696.84651576728;30921.536176957365;1153.8673052599058;1163.755611321615;1172.7126853920845;1195.49789088583;1275.2476039136955;15490.922545387426;15644;15728.68542629141;15908;16132.838671613134;368014;580727;585334;585720;902875;60468;60895.391046089855;60917.69541152354;60918.39081609216;61052.694736526035;1559.3606621285219;1568.294267579571;1575.1887777794445;1581.644130070748;1584.1920620483636;29727;30173.69826301709;30976.59466806851;31005.68994310028;31051.844740776152;51607.741961289954;52245.73877130742;52266.738666306424;52357.47642523526;52360;318093;318118;318388;318969;320037;36181.638183617826;36393.272134557694;49236.50763492462;49774;50016.499835002636;46285.948071128485;47782.283265751736;48281.75859120682;48339.75830120827;51529.45411637657;42645.573544265404;43000;43536.129277414904;43943.78028109839;44547;42587;43395.56604433915;43656.56343436525;43974;44060;41978;42767;42807.785961069996;42819.14361712686;43036.78481607572;35850.28299434049;36653.81673091617;37162.07094822651;37391.6260837399;38062;24912.12807551727;25116.49767004686;25121.623175652014;25178;25302.74697253004 12:57:55 INFO - PROCESS | 18694 | |2;jquery.html;393.10176247274984;395.56685429454757;397.8150160175518;403.69924406317296;408.7118581400113;14654.780178297307;16475.83524164758;17640.470785876412;18218.726719099206;18355.449336519894;16973.830261697378;17361.305547778073;17403.12984350784;17895.552611184696;17950.371736989207;5504.504594586497;5541.251930989325;5750.252467179261;5756;5775.249217601727;5605.355384130816;5662.716864156796;5672.404397538261;5674.943250567503;5713.914291285634;5590.888182236353;5652.660840349572;5658.60389772714;5669.886602267973;5703.486686198241;5368.516833484986;5518.255035570227;5546.417626149277;5569.805056823032;5572.721363931808;5296.841094767163;5350.732463376816;5352.116900711378;5368.516833484966;5417.918731219035;13900.860991390058;14272.14367137975;14293.213873236968;17548.38580649671;21629.891850540647;1009.7374682582508;2301.068067432676;2407.783299503036;2423.6364545318165;2458.864762438065;10168.59325626974;10661.573537058508;10948.562057517689;12254;13400.061995660308;1956.774970878353;1960.3432849995268;1974.299123811055;1997.3209108902897;2008.016072124663;66605.3339466604;69146.30853691448;69342.30657693409;69864.30135698579;69865;11056.281341712764;11257.887421125684;11297.943510282395;11382.829257561143;11499.827502587468;14273.14361138335;14525.201113938834;15212.771808422882;15275.083494990336;15299.694006119815;8063.153368896182;8134.511929284262;8158.102608713037;8181.918180818235;8460.450070745383;7416.332530072212;7631.618419079024;7718.305352518188;7738.380929525624;7826.530408175528;4850.296706977469;4906.1414252505665;4933.87665308363;4995.650304478651;5006.4743201964;1858.1452531835237;1998.560316730317;2031.4108908416395;2040.2655044184082;2073.232903825564;953.7091187187974;990.8315586350337;1002.9699109026741;1082.9928166804948;1095.9287646302964;17261.572783045147;17415.390461334046;17475.563110922074;17565.473035808947;17968.820311796713;989.2926557511414;1024.7540590258434;1033.075397519231;1052.8473371361263;1070.6895000449938;9743;10154.898451015395;10194.923503132224;10236.948815256024;10249.436281004617;441582;469681;480236;481474;481643;48985;57416.425835741946;58581;77703.61148194222;80324.59837700891;1064.7018834726289;1070.6092276319087;1072.3673032910465;1076.9138468922624;1080.0927221134284;15634.530964071097;15685.843141568439;15811.288492017657;15928;15973;23749.64375534334;23824.166154185215;26816.865915670296;32704.672953271114;33507;35861.82069089638;38592;38831.029224269616;38890.61109388983;38916;8095.83808323842;8260.586970651324;8263.669453221804;8282;8301.958490207511;8335.041470231;11178.329300242012;11522.53909843597;11680.357580333164;12205.755884882075;10175.542100605639;10215;10219.846702299323;10429.530671119666;10446.947765261126;10390.844137337795;10492.370457772558;10713;10902.836457452986;11131.554737810397;10524.473776311306;10666.520006599876;10742.40916749555;10793.892061079603;11070.892910708864;7942.08666003417;8088.919110809052;8150.9184908150155;8199.180081991753;8349.248567628943;10035.598576056876;10784.784304314027;10846.349219046882;10887.945560272148;10903.509342079467 12:57:55 INFO - PROCESS | 18694 | |3;mootools.html;1592.514283143641;1629.1284162972809;1894.6116046210527;1947.6786330255509;1986.2948653228104;7468.813279668011;8130.227628375294;8342.874856877152;8508.14918508149;8547.957260213698;8344.833103337929;8402.957985210065;8487.448315859465;8570.95714521428;8646.48121112732;2507.5235705215996;2530.860802655853;2534.619807028942;2553.399951011511;2559.321779728364;2486.1422809130822;2528.645989561463;2529.1148098165677;2532.607445845897;2539.961900571493;2484.962725559118;2512.459821138455;2528.30471620305;2534.1130604288537;2539.5174916765754;2516.8867400967;2541.301142185895;2543.3514453814346;2565.2047865161767;2566.217303722364;2404.218628945582;2553.59142537195;2558.322044658167;2570.049081839731;2574.6009368547907;8653.610587523577;8667.263282620921;8685.392022558424;8700.912990870074;8727.694530691395;5198.92201616976;5313;5352.973235133838;5353.785848566053;5369.5972802040005;3363.495475678668;3504.8247587620517;3537.575490941078;3544.167120726627;3559.804210768407;1068.2895874243695;1085.6580177244143;1097.0729733375285;1104.618906477264;1116.9106471482262;11855.644330670093;11864.110191735654;11903.880961190363;11950.462229199708;11986.280823150551;4740.265258884879;4773.976130119397;4802.927956080662;4806.95193048072;4872.707637541688;9393;9398.671046513477;9521.428714277166;9522.476263805556;9525.237980961507;5263.605229607795;5322.308099947059;5327.840164795062;5334;5334.653247538898;4298.290782020994;4703.459102203222;4771.117343291502;4787.0904528139545;4866.6106711463;4091.913124306625;4104.138130992465;4114.115465175002;4137.048478849882;4146.523149837747;1349.4332380400256;1352.5401363536446;1356.7829147336379;1356.925369104689;1357.2738584857054;1428.8785453236592;1443.7545617245094;1459.802926604916;1476.6160798192332;1495.5513345996158;8215.055268644062;8305.584720763938;8329.042160151661;8358.791030224293;8362.707305244287;568.5480043365534;570.3725901508391;577.6649543264896;579.9246098007233;581.7527550790982;6374.330695277022;6434.806955791334;6467;6484.5460817742305;6539.901901471481;10218.335808172445;10489.685309440729;10538.262321637565;10567.101796347397;10696.94651526753;10202.744931376776;10346.482675866177;10471.47642617866;10473.633422830164;10484.370937743759;8151.103378628346;8191.8771218431775;8277.172282771795;8279.172082791672;8290.792730181794;7752.341051010501;7872.134065252703;7895.763127106196;7934.880976785468;8024;8958.641654333753;9063.093690631147;9179.678711245342;9193.586288617162;9272.119148680864;9254.12085851843;9368.203702685349;9446.149846513847;9517.191038761783;9543;6611.801645950629;7112.751053713096;7311.268873112646;7313.926860731324;7403.740869069772;8179.427440079137;8184.508929464251;8197.467164634518;8204.917950820416;8211.38414618894;7100.680469378994;7160.928390716234;7334.339909408179;7365.558066516026;7507.962460187664;7144.142702875688;7254.709811607477;7292.270772922665;7307.5980821055355;7352.669129889275;7758.146603873683;7797.454178207471;7814.4529882907655;7921.564313962787;8016.959915200387;7174.641267936687;7286.890696639661;7329.377002954809;7333.523320984119;7354.77935661931;7325.597092159983;7366.447516436396;7368.042154519878;7369.226231245642;7375.741849035258 12:57:55 INFO - PROCESS | 18694 | |4;prototype.html;351.9384107781138;361.6184924904225;362.78414343465636;366.9137752628132;373.7290464413299;6450.967745161273;6456.677166141686;6488.837779055526;6489.383508566684;6499.220093588764;6345.524085693568;6378.776742814002;6384.776532821341;6387.968060159693;6391.392817682325;4706.058788242365;4820.614350851941;4834.564889159975;4836.661433699643;4889.755512224384;4801.423829140508;4821.566059054684;4833.782479788418;4835.15384807659;4841.6852904561265;4790.449098353682;4793.640476964224;4793.9520604794025;4797.832075877345;4802.135615589193;4793.041391721652;4799.6400269979895;4808.879778005543;4809.398825146856;4817.445993710733;4158.6465150462245;4167.249895018896;4177.3316269396755;4190.559991200941;4190.685698572619;5951.5238780897425;6079.604825686316;6083.665398403086;6085.208922840046;6100.054491553817;5592.356878958891;5592.692401917893;5598.216249725042;5616.943830561683;5623.437656234385;6696.83257918551;6726.529142959995;6726.798196054077;6755.3582409671;6758.155230596176;4597.42532183477;4600.125976064571;4603.148417542732;4609.469910960215;4610.101030299093;7031.7538886139255;7107.324804143598;7109.431245500347;7111.928880711178;7116.573005619679;4599.1721490132095;4730.7871145797835;4737.786799594027;4741;4747.406574178228;4755.262934245197;4755.476897541268;4755.595774359149;4795.280707893844;4807.591354734816;5609.775608975595;5613.158026296088;5617.634853734494;5620.971895140498;5623.240862483594;6845.589264644137;6851.2806155353965;6862.622555759481;6867.416269617139;6877.89683154753;1684.3767805911646;1702.8041775196011;1703.9062851543283;1707.7353010283425;1708.94899636725;1129.4522156753967;1136.2046567402851;1141.366541569437;1145.0782120393164;1175.9882401175878;6595.472362211011;6625.966870165618;6636.070950066995;6638.966805165944;6647.268800431949;7048.823779405556;7054.4003759681;7083.220845706968;7097.822554436078;7102.147742270858;6479.125318082093;6602.669866506655;6681.866362672719;6682.933170668328;6686.261571991317;3845.3462911305146;3863.6329548693393;3868.6324799144036;3868.7678739275734;3869.28418242626;7354.521956072838;7362.484626076231;7364.926350736531;7384.630768461556;7388.667509962064;7347.155077166088;7349.081364829396;7355.742549010866;7356.337929586363;7357.668904899292;7107.182673992454;7240.275972402823;7292.562446253241;7313.049303590499;7357.8160545986775;7092.574445533284;7104.928950710427;7121.786346409616;7134.464915131282;7140.428765698835;6954.513184077066;6995.895061574182;7006.159260888726;7007.439404847498;7010.088688470466;7274.854502910018;7279.963600181965;7305.488615796843;7330.010448589373;7330.5235159716585;4633.884152896069;4674.298855171615;4742.2175341069715;4747.382840230748;4773.164696178085;7015.228324884157;7025.262347453444;7039.436845052486;7057.117860267466;7071.151461824614;6846.110005699426;6849.212340580698;6851.246362899978;6851.897221541781;6879.793606191823;6808.693608787716;6854.074699915447;6854.931450685429;6855.965720171367;6882.827929301808;6604.603723776589;6675.132232809704;6812.659367031728;6834.829129271808;6850.314968503109;6929.757458488929;6960.23437421873;6966.059581956371;6966.198887127843;6967.198772141269;6734.932650673627;6744.831379215559;6792.524523283323;6802.591844489149;6803.387695107464 12:57:55 INFO - PROCESS | 18694 | |5;yui.html;733.7431898835405;844.7339088187217;890.0832142892823;905.9864102038471;915.8214148241092;14970.17664028478;15050.172240526766;15118.773218401719;15119;15180.772288415668;14347.71304573908;14895.106293622363;16005.439809606665;16068.035917844938;16108.516744497683;922.3866129024208;954.746992047108;956.6508224498077;960.6877764726457;961.7932144588912;926.1248120526105;935.0836180543072;939.8261321655482;940.4404379394249;941.3269512298705;985.990140098597;996.5615129343103;998.7752755629998;1002.3785253143061;1007.8992100789935;971.1502435369052;977.1986970684042;977.8337682593976;980.9264305177069;986.1124987511225;728.2862794461405;730.5543618392776;732.1251104929611;734.1960553194244;735.0664655886993;14198.787018194735;14224.502142424966;14275.928620356935;14674.63313417173;14964;14436.927815360856;14493.492727754583;14555.810932347293;14622.561323160322;14739.55781326562;11489.540418383338;11566.595169169039;11698.883011169864;11788.823167652492;11790.115741319349;3960.801959902022;3981.6217459341315;4045.4538637283886;4076.7757773322455;4084.101497670508;46793.53206467926;50112;50737;52435.47564524344;52731.47268527304;11265.26775759573;11366;11441.141914356456;11550.422478876022;11568.24806387582;19624;19627.705584416246;19751.209951601773;19790.50523736918;19851.30520431778;8104.432689711663;8247.175282471824;8299.543525106177;8332.458390204618;8336.333093352518;4751.976240118777;4772.809087636525;4868.756562171877;4897.632677549198;4910.508949105061;3339.5157702133056;3341.8830340937952;3356.2616224430585;3367.7642565020706;3367.983160084233;598.8951933411722;604.0938592111833;614.923134608174;622.0606883605788;626.5864529410567;630.1398590923357;657.907892894995;743.4498471131432;783.4437549339918;804.2962407893093;9034.36759426847;9059.773505662411;9144.588493517807;9510.09654082861;9593.088656577615;730.1347902735275;738.7266711316847;744.4714252880516;761.0942977856333;762.6110683551428;4099.467069280974;4262.978685106555;4370.54109318517;4406.471223453206;4471.195184866755;56890.715546422005;57474.425255747745;59002.114968274655;59522.40477595255;59532.70233648804;50028.74985625121;50044;51017;52256.47743522592;52566.73716631392;47722;51649;53119.73440132852;56262;56330.99999999918;9090.727278181665;9238.722838314861;9281.211097056826;9301.395409298373;9329.906700932905;36785.26429471449;37865;38023.239535209694;38542.80728596339;39186.608133919435;43920.56079439165;44331.55668443274;46822.53177468182;48127.278090829364;48395.75802121108;12736.872631273569;12881;12899.161554499304;12899.226046437243;12948.935255323662;13409;13498.797518037434;13532.323383830966;13596.728065438834;13727.794083088562;11436.199466037298;11880.073708850248;11974.401279935793;12097;12153.149279550347;11815.645530634094;11940.402979851146;12256.571020014257;12755.93622031884;12840.743185136433;12241.571544995883;12272.75454490923;12320.137590368946;12464.06519511022;12573.1198816082;10888.782224355311;10970.23208375438;11151.330920144817;11241.775164496828;11270.605528806453;10324.797594609932;10339.379637221791;10404.947975260378;10482.790344192921;10572.947135264274 12:57:55 INFO - PROCESS | 18694 | __end_tp_report 12:57:55 INFO - PROCESS | 18694 | __start_cc_report 12:57:55 INFO - PROCESS | 18694 | _x_x_mozilla_cycle_collect,328 12:57:55 INFO - PROCESS | 18694 | __end_cc_report 12:57:55 INFO - PROCESS | 18694 | __startTimestamp1457470675354__endTimestamp 12:57:55 INFO - PROCESS | 18694 | 12:57:55 INFO - PROCESS | 18694 | ------- Summary: start ------- 12:57:55 INFO - PROCESS | 18694 | Number of tests: 6 12:57:55 INFO - PROCESS | 18694 | 12:57:55 INFO - PROCESS | 18694 | [#0] dojo.html Cycles:165 Average:5632.33 Median:5884.82 stddev:630.76 (10.7%) stddev-sans-first:606.72 12:57:55 INFO - PROCESS | 18694 | Values: 3348.5 3380.6 3411.0 3417.7 3439.2 5498.3 5536.4 5543.0 5579.2 5587.4 5601.1 5638.5 5639.7 5665.9 5679.1 5098.6 5120.8 5140.0 5178.7 5252.6 5081.0 5176.7 5266.6 5268.3 5292.8 5122.2 5196.2 5213.5 5223.1 5250.4 5113.3 5154.6 5171.4 5172.2 5198.4 5042.0 5076.7 5105.9 5144.4 5145.6 5394.4 5403.3 5434.2 5435.9 5444.3 5885.6 5980.3 6013.5 6016.0 6028.1 6066.4 6121.0 6125.3 6135.8 6142.9 5666.2 5698.7 5700.4 5709.5 5712.4 6046.9 6122.7 6161.7 6233.8 6248.3 5955.3 5963.2 5965.3 5965.3 5967.0 6000.7 6067.3 6075.8 6079.3 6081.5 5919.0 6016.0 6036.9 6110.8 6136.5 5966.1 5997.4 6019.0 6024.2 6032.8 4552.1 4563.7 4566.4 4579.1 4595.1 4042.2 4080.5 4149.4 4186.0 4216.2 5723.5 5781.2 5785.0 5814.0 5873.9 6145.9 6168.3 6178.3 6178.9 6183.6 5702.1 5779.3 5829.7 5850.1 5897.9 5203.7 5214.8 5233.1 5255.1 5255.9 6115.5 6286.8 6287.5 6289.7 6341.6 6109.1 6138.5 6197.0 6209.6 6218.8 6120.5 6188.6 6204.3 6211.1 6230.5 5867.5 5980.4 5989.6 6002.9 6009.5 6016.5 6086.8 6094.8 6097.5 6120.1 5845.1 5877.9 5882.0 5885.2 5908.1 5852.3 5892.2 5903.9 5965.7 6009.5 5866.4 5885.9 5899.3 5908.8 5915.1 5985.9 5995.8 6001.8 6033.7 6050.2 5750.4 5833.7 5884.8 5891.1 5931.9 12:57:55 INFO - PROCESS | 18694 | 12:57:55 INFO - PROCESS | 18694 | [#1] ext.html Cycles:180 Average:54704.75 Median:40303.10 stddev:114185.88 (283.3%) stddev-sans-first:114433.76 12:57:55 INFO - PROCESS | 18694 | Values: 531.5 555.6 563.8 571.3 578.3 37911.8 38383.0 38599.0 38664.8 38714.6 40669.4 41125.8 41260.2 41275.4 41376.6 8682.2 8846.8 8857.7 8898.0 8918.8 8664.0 8986.5 9038.6 9043.7 9044.4 9057.6 9145.1 9154.0 9158.5 9163.7 9029.7 9091.6 9095.1 9107.7 9108.0 8978.2 9097.7 9105.2 9130.9 9145.9 39699.0 39905.4 40260.8 40345.4 40371.0 3516.9 3664.2 3698.4 3717.9 3830.0 29010.0 29234.0 29242.0 29745.1 29936.1 3685.7 3727.3 3745.5 3806.5 3922.0 211262.0 213419.0 214403.0 214939.0 215137.0 44892.3 56797.7 60490.4 60862.1 61072.7 43598.1 43657.0 43698.6 43804.8 43882.8 16120.1 16134.0 16204.0 16238.4 16243.9 13079.1 13094.9 13130.1 13137.9 13193.4 15466.9 15580.0 15607.8 15644.6 15724.4 6195.7 6215.0 6224.8 6251.2 6331.8 1005.8 1027.6 1034.2 1134.6 1137.4 29859.6 29976.4 30571.8 30696.8 30921.5 1153.9 1163.8 1172.7 1195.5 1275.2 15490.9 15644.0 15728.7 15908.0 16132.8 368014.0 580727.0 585334.0 585720.0 902875.0 60468.0 60895.4 60917.7 60918.4 61052.7 1559.4 1568.3 1575.2 1581.6 1584.2 29727.0 30173.7 30976.6 31005.7 31051.8 51607.7 52245.7 52266.7 52357.5 52360.0 318093.0 318118.0 318388.0 318969.0 320037.0 36181.6 36393.3 49236.5 49774.0 50016.5 46285.9 47782.3 48281.8 48339.8 51529.5 42645.6 43000.0 43536.1 43943.8 44547.0 42587.0 43395.6 43656.6 43974.0 44060.0 41978.0 42767.0 42807.8 42819.1 43036.8 35850.3 36653.8 37162.1 37391.6 38062.0 24912.1 25116.5 25121.6 25178.0 25302.7 12:57:55 INFO - PROCESS | 18694 | 12:57:55 INFO - PROCESS | 18694 | [#2] jquery.html Cycles:180 Average:25862.42 Median:11965.48 stddev:77012.25 (643.6%) stddev-sans-first:77204.55 12:57:55 INFO - PROCESS | 18694 | Values: 393.1 395.6 397.8 403.7 408.7 14654.8 16475.8 17640.5 18218.7 18355.4 16973.8 17361.3 17403.1 17895.6 17950.4 5504.5 5541.3 5750.3 5756.0 5775.2 5605.4 5662.7 5672.4 5674.9 5713.9 5590.9 5652.7 5658.6 5669.9 5703.5 5368.5 5518.3 5546.4 5569.8 5572.7 5296.8 5350.7 5352.1 5368.5 5417.9 13900.9 14272.1 14293.2 17548.4 21629.9 1009.7 2301.1 2407.8 2423.6 2458.9 10168.6 10661.6 10948.6 12254.0 13400.1 1956.8 1960.3 1974.3 1997.3 2008.0 66605.3 69146.3 69342.3 69864.3 69865.0 11056.3 11257.9 11297.9 11382.8 11499.8 14273.1 14525.2 15212.8 15275.1 15299.7 8063.2 8134.5 8158.1 8181.9 8460.5 7416.3 7631.6 7718.3 7738.4 7826.5 4850.3 4906.1 4933.9 4995.7 5006.5 1858.1 1998.6 2031.4 2040.3 2073.2 953.7 990.8 1003.0 1083.0 1095.9 17261.6 17415.4 17475.6 17565.5 17968.8 989.3 1024.8 1033.1 1052.8 1070.7 9743.0 10154.9 10194.9 10236.9 10249.4 441582.0 469681.0 480236.0 481474.0 481643.0 48985.0 57416.4 58581.0 77703.6 80324.6 1064.7 1070.6 1072.4 1076.9 1080.1 15634.5 15685.8 15811.3 15928.0 15973.0 23749.6 23824.2 26816.9 32704.7 33507.0 35861.8 38592.0 38831.0 38890.6 38916.0 8095.8 8260.6 8263.7 8282.0 8302.0 8335.0 11178.3 11522.5 11680.4 12205.8 10175.5 10215.0 10219.8 10429.5 10446.9 10390.8 10492.4 10713.0 10902.8 11131.6 10524.5 10666.5 10742.4 10793.9 11070.9 7942.1 8088.9 8150.9 8199.2 8349.2 10035.6 10784.8 10846.3 10887.9 10903.5 12:57:55 INFO - PROCESS | 18694 | 12:57:55 INFO - PROCESS | 18694 | [#3] mootools.html Cycles:180 Average:6006.94 Median:569.46 stddev:3103.08 (544.9%) stddev-sans-first:3094.04 12:57:55 INFO - PROCESS | 18694 | Values: 1592.5 1629.1 1894.6 1947.7 1986.3 7468.8 8130.2 8342.9 8508.1 8548.0 8344.8 8403.0 8487.4 8571.0 8646.5 2507.5 2530.9 2534.6 2553.4 2559.3 2486.1 2528.6 2529.1 2532.6 2540.0 2485.0 2512.5 2528.3 2534.1 2539.5 2516.9 2541.3 2543.4 2565.2 2566.2 2404.2 2553.6 2558.3 2570.0 2574.6 8653.6 8667.3 8685.4 8700.9 8727.7 5198.9 5313.0 5353.0 5353.8 5369.6 3363.5 3504.8 3537.6 3544.2 3559.8 1068.3 1085.7 1097.1 1104.6 1116.9 11855.6 11864.1 11903.9 11950.5 11986.3 4740.3 4774.0 4802.9 4807.0 4872.7 9393.0 9398.7 9521.4 9522.5 9525.2 5263.6 5322.3 5327.8 5334.0 5334.7 4298.3 4703.5 4771.1 4787.1 4866.6 4091.9 4104.1 4114.1 4137.0 4146.5 1349.4 1352.5 1356.8 1356.9 1357.3 1428.9 1443.8 1459.8 1476.6 1495.6 8215.1 8305.6 8329.0 8358.8 8362.7 568.5 570.4 577.7 579.9 581.8 6374.3 6434.8 6467.0 6484.5 6539.9 10218.3 10489.7 10538.3 10567.1 10696.9 10202.7 10346.5 10471.5 10473.6 10484.4 8151.1 8191.9 8277.2 8279.2 8290.8 7752.3 7872.1 7895.8 7934.9 8024.0 8958.6 9063.1 9179.7 9193.6 9272.1 9254.1 9368.2 9446.1 9517.2 9543.0 6611.8 7112.8 7311.3 7313.9 7403.7 8179.4 8184.5 8197.5 8204.9 8211.4 7100.7 7160.9 7334.3 7365.6 7508.0 7144.1 7254.7 7292.3 7307.6 7352.7 7758.1 7797.5 7814.5 7921.6 8017.0 7174.6 7286.9 7329.4 7333.5 7354.8 7325.6 7366.4 7368.0 7369.2 7375.7 12:57:55 INFO - PROCESS | 18694 | 12:57:55 INFO - PROCESS | 18694 | [#4] prototype.html Cycles:180 Average:5697.21 Median:6547.35 stddev:1751.67 (26.8%) stddev-sans-first:1710.02 12:57:55 INFO - PROCESS | 18694 | Values: 351.9 361.6 362.8 366.9 373.7 6451.0 6456.7 6488.8 6489.4 6499.2 6345.5 6378.8 6384.8 6388.0 6391.4 4706.1 4820.6 4834.6 4836.7 4889.8 4801.4 4821.6 4833.8 4835.2 4841.7 4790.4 4793.6 4794.0 4797.8 4802.1 4793.0 4799.6 4808.9 4809.4 4817.4 4158.6 4167.2 4177.3 4190.6 4190.7 5951.5 6079.6 6083.7 6085.2 6100.1 5592.4 5592.7 5598.2 5616.9 5623.4 6696.8 6726.5 6726.8 6755.4 6758.2 4597.4 4600.1 4603.1 4609.5 4610.1 7031.8 7107.3 7109.4 7111.9 7116.6 4599.2 4730.8 4737.8 4741.0 4747.4 4755.3 4755.5 4755.6 4795.3 4807.6 5609.8 5613.2 5617.6 5621.0 5623.2 6845.6 6851.3 6862.6 6867.4 6877.9 1684.4 1702.8 1703.9 1707.7 1708.9 1129.5 1136.2 1141.4 1145.1 1176.0 6595.5 6626.0 6636.1 6639.0 6647.3 7048.8 7054.4 7083.2 7097.8 7102.1 6479.1 6602.7 6681.9 6682.9 6686.3 3845.3 3863.6 3868.6 3868.8 3869.3 7354.5 7362.5 7364.9 7384.6 7388.7 7347.2 7349.1 7355.7 7356.3 7357.7 7107.2 7240.3 7292.6 7313.0 7357.8 7092.6 7104.9 7121.8 7134.5 7140.4 6954.5 6995.9 7006.2 7007.4 7010.1 7274.9 7280.0 7305.5 7330.0 7330.5 4633.9 4674.3 4742.2 4747.4 4773.2 7015.2 7025.3 7039.4 7057.1 7071.2 6846.1 6849.2 6851.2 6851.9 6879.8 6808.7 6854.1 6854.9 6856.0 6882.8 6604.6 6675.1 6812.7 6834.8 6850.3 6929.8 6960.2 6966.1 6966.2 6967.2 6734.9 6744.8 6792.5 6802.6 6803.4 12:57:55 INFO - PROCESS | 18694 | 12:57:55 INFO - PROCESS | 18694 | [#5] yui.html Cycles:180 Average:14875.46 Median:24163.52 stddev:16670.03 (69.0%) stddev-sans-first:16682.96 12:57:55 INFO - PROCESS | 18694 | Values: 733.7 844.7 890.1 906.0 915.8 14970.2 15050.2 15118.8 15119.0 15180.8 14347.7 14895.1 16005.4 16068.0 16108.5 922.4 954.7 956.7 960.7 961.8 926.1 935.1 939.8 940.4 941.3 986.0 996.6 998.8 1002.4 1007.9 971.2 977.2 977.8 980.9 986.1 728.3 730.6 732.1 734.2 735.1 14198.8 14224.5 14275.9 14674.6 14964.0 14436.9 14493.5 14555.8 14622.6 14739.6 11489.5 11566.6 11698.9 11788.8 11790.1 3960.8 3981.6 4045.5 4076.8 4084.1 46793.5 50112.0 50737.0 52435.5 52731.5 11265.3 11366.0 11441.1 11550.4 11568.2 19624.0 19627.7 19751.2 19790.5 19851.3 8104.4 8247.2 8299.5 8332.5 8336.3 4752.0 4772.8 4868.8 4897.6 4910.5 3339.5 3341.9 3356.3 3367.8 3368.0 598.9 604.1 614.9 622.1 626.6 630.1 657.9 743.4 783.4 804.3 9034.4 9059.8 9144.6 9510.1 9593.1 730.1 738.7 744.5 761.1 762.6 4099.5 4263.0 4370.5 4406.5 4471.2 56890.7 57474.4 59002.1 59522.4 59532.7 50028.7 50044.0 51017.0 52256.5 52566.7 47722.0 51649.0 53119.7 56262.0 56331.0 9090.7 9238.7 9281.2 9301.4 9329.9 36785.3 37865.0 38023.2 38542.8 39186.6 43920.6 44331.6 46822.5 48127.3 48395.8 12736.9 12881.0 12899.2 12899.2 12948.9 13409.0 13498.8 13532.3 13596.7 13727.8 11436.2 11880.1 11974.4 12097.0 12153.1 11815.6 11940.4 12256.6 12755.9 12840.7 12241.6 12272.8 12320.1 12464.1 12573.1 10888.8 10970.2 11151.3 11241.8 11270.6 10324.8 10339.4 10404.9 10482.8 10572.9 12:57:55 INFO - PROCESS | 18694 | -------- Summary: end -------- 12:57:55 INFO - PROCESS | 18694 | 12:57:55 INFO - TEST-INFO | 18694: exit 0 12:57:56 INFO - TEST-OK | dromaeo_css | took 1109250ms 12:57:56 INFO - TEST-START | kraken 12:57:56 INFO - operating with platform_type : linux_ 12:57:56 INFO - Initialising browser for kraken test... 12:57:56 INFO - TEST-INFO | started process 18935 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3S0Crm/profile http://localhost:33672/getInfo.html) 12:57:59 INFO - PROCESS | 18935 | 12:57:59 INFO - PROCESS | 18935 | (process:19012): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:58:00 INFO - PROCESS | 18935 | __metrics Screen width/height:1600/1200 12:58:00 INFO - PROCESS | 18935 | colorDepth:24 12:58:00 INFO - PROCESS | 18935 | Browser inner width/height: 1024/697 12:58:00 INFO - PROCESS | 18935 | __metrics 12:58:00 ERROR - PROCESS | 18935 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 12:58:01 INFO - TEST-INFO | 18935: exit 0 12:58:01 INFO - Browser initialized. 12:58:01 INFO - Running cycle 1/1 for kraken test... 12:58:01 INFO - TEST-INFO | started process 19063 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3S0Crm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:58:03 INFO - PROCESS | 19063 | 12:58:03 INFO - PROCESS | 19063 | (process:19133): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:58:13 INFO - PROCESS | 19063 | RSS: Main: 153092096 12:58:13 INFO - PROCESS | 19063 | 12:58:15 INFO - PROCESS | 19063 | Cycle 1(1): loaded http://localhost:33672/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33672/tests/kraken/driver.html?testName=audio-beat-detection) 12:58:16 INFO - PROCESS | 19063 | RSS: Main: 158101504 12:58:16 INFO - PROCESS | 19063 | 12:58:19 INFO - PROCESS | 19063 | Cycle 1(1): loaded http://localhost:33672/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33672/tests/kraken/driver.html?testName=audio-dft) 12:58:19 INFO - PROCESS | 19063 | RSS: Main: 157745152 12:58:19 INFO - PROCESS | 19063 | 12:58:22 INFO - PROCESS | 19063 | Cycle 1(1): loaded http://localhost:33672/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33672/tests/kraken/driver.html?testName=audio-fft) 12:58:23 INFO - PROCESS | 19063 | RSS: Main: 159870976 12:58:23 INFO - PROCESS | 19063 | 12:58:25 INFO - PROCESS | 19063 | Cycle 1(1): loaded http://localhost:33672/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33672/tests/kraken/driver.html?testName=audio-oscillator) 12:58:25 INFO - PROCESS | 19063 | RSS: Main: 159621120 12:58:25 INFO - PROCESS | 19063 | 12:58:28 INFO - PROCESS | 19063 | Cycle 1(1): loaded http://localhost:33672/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33672/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:58:28 INFO - PROCESS | 19063 | RSS: Main: 159612928 12:58:28 INFO - PROCESS | 19063 | 12:58:31 INFO - PROCESS | 19063 | Cycle 1(1): loaded http://localhost:33672/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33672/tests/kraken/driver.html?testName=imaging-darkroom) 12:58:32 INFO - PROCESS | 19063 | RSS: Main: 157732864 12:58:32 INFO - PROCESS | 19063 | 12:58:35 INFO - PROCESS | 19063 | Cycle 1(1): loaded http://localhost:33672/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33672/tests/kraken/driver.html?testName=imaging-desaturate) 12:58:36 INFO - PROCESS | 19063 | RSS: Main: 158007296 12:58:36 INFO - PROCESS | 19063 | 12:58:39 INFO - PROCESS | 19063 | Cycle 1(1): loaded http://localhost:33672/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33672/tests/kraken/driver.html?testName=json-parse-financial) 12:58:39 INFO - PROCESS | 19063 | RSS: Main: 157958144 12:58:39 INFO - PROCESS | 19063 | 12:58:41 INFO - PROCESS | 19063 | Cycle 1(1): loaded http://localhost:33672/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33672/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:58:41 INFO - PROCESS | 19063 | RSS: Main: 158711808 12:58:41 INFO - PROCESS | 19063 | 12:58:43 INFO - PROCESS | 19063 | Cycle 1(1): loaded http://localhost:33672/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33672/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:58:44 INFO - PROCESS | 19063 | RSS: Main: 159346688 12:58:44 INFO - PROCESS | 19063 | 12:58:46 INFO - PROCESS | 19063 | Cycle 1(1): loaded http://localhost:33672/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33672/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:58:46 INFO - PROCESS | 19063 | RSS: Main: 159748096 12:58:46 INFO - PROCESS | 19063 | 12:58:49 INFO - PROCESS | 19063 | Cycle 1(1): loaded http://localhost:33672/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33672/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:58:49 INFO - PROCESS | 19063 | RSS: Main: 159453184 12:58:49 INFO - PROCESS | 19063 | 12:58:52 INFO - PROCESS | 19063 | Cycle 1(1): loaded http://localhost:33672/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33672/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:58:53 INFO - PROCESS | 19063 | RSS: Main: 159244288 12:58:53 INFO - PROCESS | 19063 | 12:58:54 INFO - PROCESS | 19063 | Cycle 1(1): loaded http://localhost:33672/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33672/tests/kraken/driver.html?testName=ai-astar) 12:58:55 INFO - PROCESS | 19063 | RSS: Main: 160604160 12:58:55 INFO - PROCESS | 19063 | 12:58:55 INFO - PROCESS | 19063 | __start_tp_report 12:58:55 INFO - PROCESS | 19063 | _x_x_mozilla_page_load 12:58:55 INFO - PROCESS | 19063 | _x_x_mozilla_page_load_details 12:58:55 INFO - PROCESS | 19063 | |i|pagename|runs| 12:58:55 INFO - PROCESS | 19063 | |0;ai-astar;113;104;111;110;110;120;112;112;112;111 12:58:55 INFO - PROCESS | 19063 | |1;audio-beat-detection;151;127;157;170;133;159;149;127;165;125 12:58:55 INFO - PROCESS | 19063 | |2;audio-dft;168;162;162;162;163;162;162;162;165;162 12:58:55 INFO - PROCESS | 19063 | |3;audio-fft;76;74;75;164;76;76;76;76;151;76 12:58:55 INFO - PROCESS | 19063 | |4;audio-oscillator;93;93;147;92;93;93;145;93;95;135 12:58:55 INFO - PROCESS | 19063 | |5;imaging-gaussian-blur;117;117;117;117;118;117;118;117;117;117 12:58:55 INFO - PROCESS | 19063 | |6;imaging-darkroom;147;147;146;147;146;147;147;150;147;147 12:58:55 INFO - PROCESS | 19063 | |7;imaging-desaturate;96;96;96;96;98;97;96;96;96;97 12:58:55 INFO - PROCESS | 19063 | |8;json-parse-financial;56;57;56;57;57;57;58;62;56;56 12:58:55 INFO - PROCESS | 19063 | |9;json-stringify-tinderbox;64;64;64;64;66;64;64;63;65;64 12:58:55 INFO - PROCESS | 19063 | |10;stanford-crypto-aes;78;79;79;80;79;79;79;80;87;79 12:58:55 INFO - PROCESS | 19063 | |11;stanford-crypto-ccm;112;119;114;121;127;113;114;116;111;120 12:58:55 INFO - PROCESS | 19063 | |12;stanford-crypto-pbkdf2;139;158;147;146;151;142;152;155;137;149 12:58:55 INFO - PROCESS | 19063 | |13;stanford-crypto-sha256-iterative;67;66;69;66;68;68;67;67;67;69 12:58:55 INFO - PROCESS | 19063 | __end_tp_report 12:58:55 INFO - PROCESS | 19063 | __start_cc_report 12:58:55 INFO - PROCESS | 19063 | _x_x_mozilla_cycle_collect,824 12:58:55 INFO - PROCESS | 19063 | __end_cc_report 12:58:55 INFO - PROCESS | 19063 | __startTimestamp1457470735002__endTimestamp 12:58:55 INFO - PROCESS | 19063 | 12:58:55 INFO - PROCESS | 19063 | ------- Summary: start ------- 12:58:55 INFO - PROCESS | 19063 | Number of tests: 14 12:58:55 INFO - PROCESS | 19063 | 12:58:55 INFO - PROCESS | 19063 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:3.89 (3.5%) stddev-sans-first:4.09 12:58:55 INFO - PROCESS | 19063 | Values: 113.0 104.0 111.0 110.0 110.0 120.0 112.0 112.0 112.0 111.0 12:58:55 INFO - PROCESS | 19063 | 12:58:55 INFO - PROCESS | 19063 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:154.00 stddev:16.97 (11.0%) stddev-sans-first:17.91 12:58:55 INFO - PROCESS | 19063 | Values: 151.0 127.0 157.0 170.0 133.0 159.0 149.0 127.0 165.0 125.0 12:58:55 INFO - PROCESS | 19063 | 12:58:55 INFO - PROCESS | 19063 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.00 stddev:2.00 (1.2%) stddev-sans-first:1.01 12:58:55 INFO - PROCESS | 19063 | Values: 168.0 162.0 162.0 162.0 163.0 162.0 162.0 162.0 165.0 162.0 12:58:55 INFO - PROCESS | 19063 | 12:58:55 INFO - PROCESS | 19063 | [#3] audio-fft Cycles:10 Average:92.00 Median:76.00 stddev:34.66 (45.6%) stddev-sans-first:36.28 12:58:55 INFO - PROCESS | 19063 | Values: 76.0 74.0 75.0 164.0 76.0 76.0 76.0 76.0 151.0 76.0 12:58:55 INFO - PROCESS | 19063 | 12:58:55 INFO - PROCESS | 19063 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:93.00 stddev:23.97 (25.8%) stddev-sans-first:24.80 12:58:55 INFO - PROCESS | 19063 | Values: 93.0 93.0 147.0 92.0 93.0 93.0 145.0 93.0 95.0 135.0 12:58:55 INFO - PROCESS | 19063 | 12:58:55 INFO - PROCESS | 19063 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:58:55 INFO - PROCESS | 19063 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 12:58:55 INFO - PROCESS | 19063 | 12:58:55 INFO - PROCESS | 19063 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 12:58:55 INFO - PROCESS | 19063 | Values: 147.0 147.0 146.0 147.0 146.0 147.0 147.0 150.0 147.0 147.0 12:58:55 INFO - PROCESS | 19063 | 12:58:55 INFO - PROCESS | 19063 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 12:58:55 INFO - PROCESS | 19063 | Values: 96.0 96.0 96.0 96.0 98.0 97.0 96.0 96.0 96.0 97.0 12:58:55 INFO - PROCESS | 19063 | 12:58:55 INFO - PROCESS | 19063 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.00 stddev:1.81 (3.2%) stddev-sans-first:1.87 12:58:55 INFO - PROCESS | 19063 | Values: 56.0 57.0 56.0 57.0 57.0 57.0 58.0 62.0 56.0 56.0 12:58:55 INFO - PROCESS | 19063 | 12:58:55 INFO - PROCESS | 19063 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 12:58:55 INFO - PROCESS | 19063 | Values: 64.0 64.0 64.0 64.0 66.0 64.0 64.0 63.0 65.0 64.0 12:58:55 INFO - PROCESS | 19063 | 12:58:55 INFO - PROCESS | 19063 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:79.00 stddev:2.56 (3.2%) stddev-sans-first:2.62 12:58:55 INFO - PROCESS | 19063 | Values: 78.0 79.0 79.0 80.0 79.0 79.0 79.0 80.0 87.0 79.0 12:58:55 INFO - PROCESS | 19063 | 12:58:55 INFO - PROCESS | 19063 | [#11] stanford-crypto-ccm Cycles:10 Average:116.70 Median:117.50 stddev:4.99 (4.2%) stddev-sans-first:4.99 12:58:55 INFO - PROCESS | 19063 | Values: 112.0 119.0 114.0 121.0 127.0 113.0 114.0 116.0 111.0 120.0 12:58:55 INFO - PROCESS | 19063 | 12:58:55 INFO - PROCESS | 19063 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.60 Median:150.00 stddev:6.80 (4.5%) stddev-sans-first:6.46 12:58:55 INFO - PROCESS | 19063 | Values: 139.0 158.0 147.0 146.0 151.0 142.0 152.0 155.0 137.0 149.0 12:58:55 INFO - PROCESS | 19063 | 12:58:55 INFO - PROCESS | 19063 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:1.07 (1.6%) stddev-sans-first:1.13 12:58:55 INFO - PROCESS | 19063 | Values: 67.0 66.0 69.0 66.0 68.0 68.0 67.0 67.0 67.0 69.0 12:58:55 INFO - PROCESS | 19063 | -------- Summary: end -------- 12:58:55 INFO - PROCESS | 19063 | 12:58:56 INFO - TEST-INFO | 19063: exit 0 12:58:56 INFO - TEST-OK | kraken | took 60043ms 12:58:56 INFO - SUITE-END | took 1169s 12:58:56 INFO - Completed test suite (00:19:29) 12:58:56 INFO - javascript benchmark 12:58:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3348.4642457206846, 3380.6281309056017, 3410.9658903410973, 3417.709494692951, 3439.1917899293644, 5498.285222921025, 5536.4186760390085, 5543.0, 5579.246801681772, 5587.41332160123, 5601.103823388259, 5638.492535671799, 5639.746211420485, 5665.886682266352, 5679.062954612495, 5098.5921126309995, 5120.769565369549, 5140.023395554833, 5178.6892786432745, 5252.6323157379, 5080.974595127019, 5176.715280659581, 5266.5786737061135, 5268.31511903452, 5292.788288468457, 5122.154844450662, 5196.168613021917, 5213.530782229599, 5223.112070947948, 5250.44870288618, 5113.284140220372, 5154.639175257734, 5171.4311425743135, 5172.19830926207, 5198.402183748861, 5041.974790126026, 5076.746162691888, 5105.897882042375, 5144.382674079097, 5145.588352931756, 5394.406615272317, 5403.297571315743, 5434.184872269152, 5435.864103397407, 5444.3194600674915, 5885.558583106242, 5980.312264089642, 6013.51891848651, 6016.007358785795, 6028.065649824241, 6066.423689749467, 6120.995022892694, 6125.297889100503, 6135.845176233296, 6142.897836592492, 5666.150077488369, 5698.6580805151825, 5700.429957004267, 5709.543236541108, 5712.428757124254, 6046.909296360558, 6122.663253521099, 6161.7227224775, 6233.844153896189, 6248.250209974741, 5955.285365756137, 5963.194968679173, 5965.28416590012, 5965.343812180657, 5966.970165149147, 6000.669963152069, 6067.302260240041, 6075.817725468243, 6079.270487541523, 6081.483073938764, 5919.0, 6015.969920150371, 6036.909446358308, 6110.847228819315, 6136.457808108435, 5966.134910437962, 5997.370276121032, 6019.0, 6024.1566180734735, 6032.849178770566, 4552.08958208353, 4563.680542362003, 4566.383538222364, 4579.129965306581, 4595.080983803253, 4042.191561687674, 4080.489938757655, 4149.37759336102, 4186.016286172747, 4216.198922204771, 5723.456271654186, 5781.19063331134, 5785.0, 5814.0, 5873.882522349614, 6145.907811382744, 6168.290646575611, 6178.289496707846, 6178.907316390258, 6183.628982261079, 5702.087665973508, 5779.33537643168, 5829.650220986754, 5850.0932355484965, 5897.882042359129, 5203.687778733288, 5214.817481388133, 5233.058049551041, 5255.08036093682, 5255.947440525546, 6115.51416190291, 6286.779962701284, 6287.49700023997, 6289.7484100635465, 6341.556091073673, 6109.053096770008, 6138.541671868523, 6197.0, 6209.59637623553, 6218.751249950133, 6120.540959427972, 6188.566800323934, 6204.348543402878, 6211.09939058843, 6230.470410015199, 5867.5305975521005, 5980.431858973565, 5989.640402430382, 6002.909956350571, 6009.519238460825, 6016.458518733335, 6086.817395478142, 6094.7562097517375, 6097.451229389376, 6120.08198770188, 5845.09401042839, 5877.941220587911, 5881.9705901470215, 5885.205497257815, 5908.143319218603, 5852.326982397079, 5892.204552385373, 5903.852403689943, 5965.701714914324, 6009.54928380382, 5866.354700982974, 5885.911711324248, 5899.292084949662, 5908.793192238251, 5915.112733090071, 5985.910211346746, 5995.790147344822, 6001.7599296027665, 6033.728482218223, 6050.152978582913, 5750.424957504216, 5833.708314584169, 5884.823455296348, 5891.1457838614015, 5931.881362372815], "unit": "score", "name": "dojo.html", "value": 5590.947751290692}, {"lowerIsBetter": false, "replicates": [531.5428731291091, 555.5583311267542, 563.8308507447766, 571.34010218198, 578.3146970839558, 37911.81044094779, 38383.0, 38599.0, 38664.806675966654, 38714.612853871455, 40669.389959150634, 41125.794371028176, 41260.17479650405, 41275.380869286986, 41376.58623413765, 8682.218600325985, 8846.823063538724, 8857.689980850671, 8897.95551022244, 8918.821623567525, 8663.956680216621, 8986.505742184178, 9038.638454461814, 9043.728688139367, 9044.412113212653, 9057.637694492212, 9145.085491450835, 9154.038825923282, 9158.49628270445, 9163.679271225508, 9029.729108126767, 9091.590878410487, 9095.135962083592, 9107.726768196964, 9107.95446022769, 8978.191962723386, 9097.727068187965, 9105.226055785266, 9130.863037054449, 9145.90249170104, 39699.0, 39905.40141897874, 40260.798696006335, 40345.39481907774, 40371.0, 3516.9472457913153, 3664.157243833933, 3698.389765688658, 3717.8698745544048, 3829.9617003829885, 29010.0, 29234.0, 29242.0, 29745.107646770415, 29936.101916942527, 3685.6682898538993, 3727.2918145552258, 3745.513083299181, 3806.505154329947, 3922.0, 211261.99999999846, 213419.0, 214403.0, 214939.0, 215137.0, 44892.3266151008, 56797.7160114205, 60490.39509604935, 60862.087068694, 61072.69463652742, 43598.12803743908, 43657.0, 43698.563014370084, 43804.78097609555, 43882.780586096866, 16120.113393763455, 16134.031958082553, 16204.0, 16238.431654892021, 16243.918780406022, 13079.149855259378, 13094.934525327313, 13130.080894337305, 13137.934310328386, 13193.40629671667, 15466.9226653866, 15580.0, 15607.765883511756, 15644.608884777972, 15724.371025158865, 6195.721192546346, 6214.9689251553455, 6224.844378890564, 6251.218597675291, 6331.778387756406, 1005.7787286796893, 1027.5941003303653, 1034.1519953638094, 1134.6327675151588, 1137.3801278303345, 29859.552106718416, 29976.400471990873, 30571.847140764155, 30696.84651576728, 30921.536176957365, 1153.8673052599058, 1163.755611321615, 1172.7126853920845, 1195.49789088583, 1275.2476039136955, 15490.922545387426, 15644.0, 15728.68542629141, 15908.0, 16132.838671613134, 368014.0, 580727.0, 585334.0, 585720.0, 902875.0, 60468.0, 60895.391046089855, 60917.69541152354, 60918.39081609216, 61052.694736526035, 1559.3606621285219, 1568.294267579571, 1575.1887777794445, 1581.644130070748, 1584.1920620483636, 29727.0, 30173.69826301709, 30976.59466806851, 31005.68994310028, 31051.844740776152, 51607.741961289954, 52245.73877130742, 52266.738666306424, 52357.47642523526, 52360.0, 318093.0, 318118.0, 318388.0, 318969.0, 320037.0, 36181.638183617826, 36393.272134557694, 49236.50763492462, 49774.0, 50016.499835002636, 46285.948071128485, 47782.283265751736, 48281.75859120682, 48339.75830120827, 51529.45411637657, 42645.573544265404, 43000.0, 43536.129277414904, 43943.78028109839, 44547.0, 42587.0, 43395.56604433915, 43656.56343436525, 43974.0, 44060.0, 41978.0, 42767.0, 42807.785961069996, 42819.14361712686, 43036.78481607572, 35850.28299434049, 36653.81673091617, 37162.07094822651, 37391.6260837399, 38062.0, 24912.12807551727, 25116.49767004686, 25121.623175652014, 25178.0, 25302.74697253004], "unit": "score", "name": "ext.html", "value": 19506.296334721537}, {"lowerIsBetter": false, "replicates": [393.10176247274984, 395.56685429454757, 397.8150160175518, 403.69924406317296, 408.7118581400113, 14654.780178297307, 16475.83524164758, 17640.470785876412, 18218.726719099206, 18355.449336519894, 16973.830261697378, 17361.305547778073, 17403.12984350784, 17895.552611184696, 17950.371736989207, 5504.504594586497, 5541.251930989325, 5750.252467179261, 5756.0, 5775.249217601727, 5605.355384130816, 5662.716864156796, 5672.404397538261, 5674.943250567503, 5713.914291285634, 5590.888182236353, 5652.660840349572, 5658.60389772714, 5669.886602267973, 5703.486686198241, 5368.516833484986, 5518.255035570227, 5546.417626149277, 5569.805056823032, 5572.721363931808, 5296.841094767163, 5350.732463376816, 5352.116900711378, 5368.516833484966, 5417.918731219035, 13900.860991390058, 14272.14367137975, 14293.213873236968, 17548.38580649671, 21629.891850540647, 1009.7374682582508, 2301.068067432676, 2407.783299503036, 2423.6364545318165, 2458.864762438065, 10168.59325626974, 10661.573537058508, 10948.562057517689, 12254.0, 13400.061995660308, 1956.774970878353, 1960.3432849995268, 1974.299123811055, 1997.3209108902897, 2008.016072124663, 66605.3339466604, 69146.30853691448, 69342.30657693409, 69864.30135698579, 69865.0, 11056.281341712764, 11257.887421125684, 11297.943510282395, 11382.829257561143, 11499.827502587468, 14273.14361138335, 14525.201113938834, 15212.771808422882, 15275.083494990336, 15299.694006119815, 8063.153368896182, 8134.511929284262, 8158.102608713037, 8181.918180818235, 8460.450070745383, 7416.332530072212, 7631.618419079024, 7718.305352518188, 7738.380929525624, 7826.530408175528, 4850.296706977469, 4906.1414252505665, 4933.87665308363, 4995.650304478651, 5006.4743201964, 1858.1452531835237, 1998.560316730317, 2031.4108908416395, 2040.2655044184082, 2073.232903825564, 953.7091187187974, 990.8315586350337, 1002.9699109026741, 1082.9928166804948, 1095.9287646302964, 17261.572783045147, 17415.390461334046, 17475.563110922074, 17565.473035808947, 17968.820311796713, 989.2926557511414, 1024.7540590258434, 1033.075397519231, 1052.8473371361263, 1070.6895000449938, 9743.0, 10154.898451015395, 10194.923503132224, 10236.948815256024, 10249.436281004617, 441582.0, 469681.0, 480236.0, 481474.0, 481643.0, 48985.0, 57416.425835741946, 58581.0, 77703.61148194222, 80324.59837700891, 1064.7018834726289, 1070.6092276319087, 1072.3673032910465, 1076.9138468922624, 1080.0927221134284, 15634.530964071097, 15685.843141568439, 15811.288492017657, 15928.0, 15973.0, 23749.64375534334, 23824.166154185215, 26816.865915670296, 32704.672953271114, 33507.0, 35861.82069089638, 38592.0, 38831.029224269616, 38890.61109388983, 38916.0, 8095.83808323842, 8260.586970651324, 8263.669453221804, 8282.0, 8301.958490207511, 8335.041470231, 11178.329300242012, 11522.53909843597, 11680.357580333164, 12205.755884882075, 10175.542100605639, 10215.0, 10219.846702299323, 10429.530671119666, 10446.947765261126, 10390.844137337795, 10492.370457772558, 10713.0, 10902.836457452986, 11131.554737810397, 10524.473776311306, 10666.520006599876, 10742.40916749555, 10793.892061079603, 11070.892910708864, 7942.08666003417, 8088.919110809052, 8150.9184908150155, 8199.180081991753, 8349.248567628943, 10035.598576056876, 10784.784304314027, 10846.349219046882, 10887.945560272148, 10903.509342079467], "unit": "score", "name": "jquery.html", "value": 8551.624441422604}, {"lowerIsBetter": false, "replicates": [1592.514283143641, 1629.1284162972809, 1894.6116046210527, 1947.6786330255509, 1986.2948653228104, 7468.813279668011, 8130.227628375294, 8342.874856877152, 8508.14918508149, 8547.957260213698, 8344.833103337929, 8402.957985210065, 8487.448315859465, 8570.95714521428, 8646.48121112732, 2507.5235705215996, 2530.860802655853, 2534.619807028942, 2553.399951011511, 2559.321779728364, 2486.1422809130822, 2528.645989561463, 2529.1148098165677, 2532.607445845897, 2539.961900571493, 2484.962725559118, 2512.459821138455, 2528.30471620305, 2534.1130604288537, 2539.5174916765754, 2516.8867400967, 2541.301142185895, 2543.3514453814346, 2565.2047865161767, 2566.217303722364, 2404.218628945582, 2553.59142537195, 2558.322044658167, 2570.049081839731, 2574.6009368547907, 8653.610587523577, 8667.263282620921, 8685.392022558424, 8700.912990870074, 8727.694530691395, 5198.92201616976, 5313.0, 5352.973235133838, 5353.785848566053, 5369.5972802040005, 3363.495475678668, 3504.8247587620517, 3537.575490941078, 3544.167120726627, 3559.804210768407, 1068.2895874243695, 1085.6580177244143, 1097.0729733375285, 1104.618906477264, 1116.9106471482262, 11855.644330670093, 11864.110191735654, 11903.880961190363, 11950.462229199708, 11986.280823150551, 4740.265258884879, 4773.976130119397, 4802.927956080662, 4806.95193048072, 4872.707637541688, 9393.0, 9398.671046513477, 9521.428714277166, 9522.476263805556, 9525.237980961507, 5263.605229607795, 5322.308099947059, 5327.840164795062, 5334.0, 5334.653247538898, 4298.290782020994, 4703.459102203222, 4771.117343291502, 4787.0904528139545, 4866.6106711463, 4091.913124306625, 4104.138130992465, 4114.115465175002, 4137.048478849882, 4146.523149837747, 1349.4332380400256, 1352.5401363536446, 1356.7829147336379, 1356.925369104689, 1357.2738584857054, 1428.8785453236592, 1443.7545617245094, 1459.802926604916, 1476.6160798192332, 1495.5513345996158, 8215.055268644062, 8305.584720763938, 8329.042160151661, 8358.791030224293, 8362.707305244287, 568.5480043365534, 570.3725901508391, 577.6649543264896, 579.9246098007233, 581.7527550790982, 6374.330695277022, 6434.806955791334, 6467.0, 6484.5460817742305, 6539.901901471481, 10218.335808172445, 10489.685309440729, 10538.262321637565, 10567.101796347397, 10696.94651526753, 10202.744931376776, 10346.482675866177, 10471.47642617866, 10473.633422830164, 10484.370937743759, 8151.103378628346, 8191.8771218431775, 8277.172282771795, 8279.172082791672, 8290.792730181794, 7752.341051010501, 7872.134065252703, 7895.763127106196, 7934.880976785468, 8024.0, 8958.641654333753, 9063.093690631147, 9179.678711245342, 9193.586288617162, 9272.119148680864, 9254.12085851843, 9368.203702685349, 9446.149846513847, 9517.191038761783, 9543.0, 6611.801645950629, 7112.751053713096, 7311.268873112646, 7313.926860731324, 7403.740869069772, 8179.427440079137, 8184.508929464251, 8197.467164634518, 8204.917950820416, 8211.38414618894, 7100.680469378994, 7160.928390716234, 7334.339909408179, 7365.558066516026, 7507.962460187664, 7144.142702875688, 7254.709811607477, 7292.270772922665, 7307.5980821055355, 7352.669129889275, 7758.146603873683, 7797.454178207471, 7814.4529882907655, 7921.564313962787, 8016.959915200387, 7174.641267936687, 7286.890696639661, 7329.377002954809, 7333.523320984119, 7354.77935661931, 7325.597092159983, 7366.447516436396, 7368.042154519878, 7369.226231245642, 7375.741849035258], "unit": "score", "name": "mootools.html", "value": 4886.099272416312}, {"lowerIsBetter": false, "replicates": [351.9384107781138, 361.6184924904225, 362.78414343465636, 366.9137752628132, 373.7290464413299, 6450.967745161273, 6456.677166141686, 6488.837779055526, 6489.383508566684, 6499.220093588764, 6345.524085693568, 6378.776742814002, 6384.776532821341, 6387.968060159693, 6391.392817682325, 4706.058788242365, 4820.614350851941, 4834.564889159975, 4836.661433699643, 4889.755512224384, 4801.423829140508, 4821.566059054684, 4833.782479788418, 4835.15384807659, 4841.6852904561265, 4790.449098353682, 4793.640476964224, 4793.9520604794025, 4797.832075877345, 4802.135615589193, 4793.041391721652, 4799.6400269979895, 4808.879778005543, 4809.398825146856, 4817.445993710733, 4158.6465150462245, 4167.249895018896, 4177.3316269396755, 4190.559991200941, 4190.685698572619, 5951.5238780897425, 6079.604825686316, 6083.665398403086, 6085.208922840046, 6100.054491553817, 5592.356878958891, 5592.692401917893, 5598.216249725042, 5616.943830561683, 5623.437656234385, 6696.83257918551, 6726.529142959995, 6726.798196054077, 6755.3582409671, 6758.155230596176, 4597.42532183477, 4600.125976064571, 4603.148417542732, 4609.469910960215, 4610.101030299093, 7031.7538886139255, 7107.324804143598, 7109.431245500347, 7111.928880711178, 7116.573005619679, 4599.1721490132095, 4730.7871145797835, 4737.786799594027, 4741.0, 4747.406574178228, 4755.262934245197, 4755.476897541268, 4755.595774359149, 4795.280707893844, 4807.591354734816, 5609.775608975595, 5613.158026296088, 5617.634853734494, 5620.971895140498, 5623.240862483594, 6845.589264644137, 6851.2806155353965, 6862.622555759481, 6867.416269617139, 6877.89683154753, 1684.3767805911646, 1702.8041775196011, 1703.9062851543283, 1707.7353010283425, 1708.94899636725, 1129.4522156753967, 1136.2046567402851, 1141.366541569437, 1145.0782120393164, 1175.9882401175878, 6595.472362211011, 6625.966870165618, 6636.070950066995, 6638.966805165944, 6647.268800431949, 7048.823779405556, 7054.4003759681, 7083.220845706968, 7097.822554436078, 7102.147742270858, 6479.125318082093, 6602.669866506655, 6681.866362672719, 6682.933170668328, 6686.261571991317, 3845.3462911305146, 3863.6329548693393, 3868.6324799144036, 3868.7678739275734, 3869.28418242626, 7354.521956072838, 7362.484626076231, 7364.926350736531, 7384.630768461556, 7388.667509962064, 7347.155077166088, 7349.081364829396, 7355.742549010866, 7356.337929586363, 7357.668904899292, 7107.182673992454, 7240.275972402823, 7292.562446253241, 7313.049303590499, 7357.8160545986775, 7092.574445533284, 7104.928950710427, 7121.786346409616, 7134.464915131282, 7140.428765698835, 6954.513184077066, 6995.895061574182, 7006.159260888726, 7007.439404847498, 7010.088688470466, 7274.854502910018, 7279.963600181965, 7305.488615796843, 7330.010448589373, 7330.5235159716585, 4633.884152896069, 4674.298855171615, 4742.2175341069715, 4747.382840230748, 4773.164696178085, 7015.228324884157, 7025.262347453444, 7039.436845052486, 7057.117860267466, 7071.151461824614, 6846.110005699426, 6849.212340580698, 6851.246362899978, 6851.897221541781, 6879.793606191823, 6808.693608787716, 6854.074699915447, 6854.931450685429, 6855.965720171367, 6882.827929301808, 6604.603723776589, 6675.132232809704, 6812.659367031728, 6834.829129271808, 6850.314968503109, 6929.757458488929, 6960.23437421873, 6966.059581956371, 6966.198887127843, 6967.198772141269, 6734.932650673627, 6744.831379215559, 6792.524523283323, 6802.591844489149, 6803.387695107464], "unit": "score", "name": "prototype.html", "value": 5128.617773362057}, {"lowerIsBetter": false, "replicates": [733.7431898835405, 844.7339088187217, 890.0832142892823, 905.9864102038471, 915.8214148241092, 14970.17664028478, 15050.172240526766, 15118.773218401719, 15119.0, 15180.772288415668, 14347.71304573908, 14895.106293622363, 16005.439809606665, 16068.035917844938, 16108.516744497683, 922.3866129024208, 954.746992047108, 956.6508224498077, 960.6877764726457, 961.7932144588912, 926.1248120526105, 935.0836180543072, 939.8261321655482, 940.4404379394249, 941.3269512298705, 985.990140098597, 996.5615129343103, 998.7752755629998, 1002.3785253143061, 1007.8992100789935, 971.1502435369052, 977.1986970684042, 977.8337682593976, 980.9264305177069, 986.1124987511225, 728.2862794461405, 730.5543618392776, 732.1251104929611, 734.1960553194244, 735.0664655886993, 14198.787018194735, 14224.502142424966, 14275.928620356935, 14674.63313417173, 14964.0, 14436.927815360856, 14493.492727754583, 14555.810932347293, 14622.561323160322, 14739.55781326562, 11489.540418383338, 11566.595169169039, 11698.883011169864, 11788.823167652492, 11790.115741319349, 3960.801959902022, 3981.6217459341315, 4045.4538637283886, 4076.7757773322455, 4084.101497670508, 46793.53206467926, 50112.0, 50737.0, 52435.47564524344, 52731.47268527304, 11265.26775759573, 11366.0, 11441.141914356456, 11550.422478876022, 11568.24806387582, 19624.0, 19627.705584416246, 19751.209951601773, 19790.50523736918, 19851.30520431778, 8104.432689711663, 8247.175282471824, 8299.543525106177, 8332.458390204618, 8336.333093352518, 4751.976240118777, 4772.809087636525, 4868.756562171877, 4897.632677549198, 4910.508949105061, 3339.5157702133056, 3341.8830340937952, 3356.2616224430585, 3367.7642565020706, 3367.983160084233, 598.8951933411722, 604.0938592111833, 614.923134608174, 622.0606883605788, 626.5864529410567, 630.1398590923357, 657.907892894995, 743.4498471131432, 783.4437549339918, 804.2962407893093, 9034.36759426847, 9059.773505662411, 9144.588493517807, 9510.09654082861, 9593.088656577615, 730.1347902735275, 738.7266711316847, 744.4714252880516, 761.0942977856333, 762.6110683551428, 4099.467069280974, 4262.978685106555, 4370.54109318517, 4406.471223453206, 4471.195184866755, 56890.715546422005, 57474.425255747745, 59002.114968274655, 59522.40477595255, 59532.70233648804, 50028.74985625121, 50044.0, 51017.0, 52256.47743522592, 52566.73716631392, 47722.0, 51649.0, 53119.73440132852, 56262.0, 56330.99999999918, 9090.727278181665, 9238.722838314861, 9281.211097056826, 9301.395409298373, 9329.906700932905, 36785.26429471449, 37865.0, 38023.239535209694, 38542.80728596339, 39186.608133919435, 43920.56079439165, 44331.55668443274, 46822.53177468182, 48127.278090829364, 48395.75802121108, 12736.872631273569, 12881.0, 12899.161554499304, 12899.226046437243, 12948.935255323662, 13409.0, 13498.797518037434, 13532.323383830966, 13596.728065438834, 13727.794083088562, 11436.199466037298, 11880.073708850248, 11974.401279935793, 12097.0, 12153.149279550347, 11815.645530634094, 11940.402979851146, 12256.571020014257, 12755.93622031884, 12840.743185136433, 12241.571544995883, 12272.75454490923, 12320.137590368946, 12464.06519511022, 12573.1198816082, 10888.782224355311, 10970.23208375438, 11151.330920144817, 11241.775164496828, 11270.605528806453, 10324.797594609932, 10339.379637221791, 10404.947975260378, 10482.790344192921, 10572.947135264274], "unit": "score", "name": "yui.html", "value": 6985.930738946822}], "name": "dromaeo_css", "value": 7393.015650159748}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 104.0, 111.0, 110.0, 110.0, 120.0, 112.0, 112.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [151.0, 127.0, 157.0, 170.0, 133.0, 159.0, 149.0, 127.0, 165.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 146.3}, {"lowerIsBetter": true, "replicates": [168.0, 162.0, 162.0, 162.0, 163.0, 162.0, 162.0, 162.0, 165.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.0}, {"lowerIsBetter": true, "replicates": [76.0, 74.0, 75.0, 164.0, 76.0, 76.0, 76.0, 76.0, 151.0, 76.0], "unit": "score", "name": "audio-fft", "value": 92.0}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 147.0, 92.0, 93.0, 93.0, 145.0, 93.0, 95.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 107.9}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.2}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 150.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 98.0, 97.0, 96.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 56.0, 57.0, 57.0, 57.0, 58.0, 62.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 66.0, 64.0, 64.0, 63.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.2}, {"lowerIsBetter": true, "replicates": [78.0, 79.0, 79.0, 80.0, 79.0, 79.0, 79.0, 80.0, 87.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.9}, {"lowerIsBetter": true, "replicates": [112.0, 119.0, 114.0, 121.0, 127.0, 113.0, 114.0, 116.0, 111.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.7}, {"lowerIsBetter": true, "replicates": [139.0, 158.0, 147.0, 146.0, 151.0, 142.0, 152.0, 155.0, 137.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.6}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 69.0, 66.0, 68.0, 68.0, 67.0, 67.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1514.4}]} 12:58:56 INFO - Return code: 0 12:58:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 12:58:56 ERROR - # TBPL SUCCESS # 12:58:56 INFO - Running post-action listener: _resource_record_post_action 12:58:56 INFO - Running post-run listener: _resource_record_post_run 12:58:57 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 278528; Write bytes: 499822592; Read time: 52; Write time: 436496 12:58:57 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 244264960; Read time: 0; Write time: 275368 12:58:57 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 278528; Write bytes: 254959616; Read time: 52; Write time: 161128 12:58:57 INFO - Running post-run listener: _upload_blobber_files 12:58:57 INFO - Blob upload gear active. 12:58:57 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 12:58:57 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 12:58:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 12:58:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 12:58:57 INFO - (blobuploader) - INFO - Open directory for files ... 12:58:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:58:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:58:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:58:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:58:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:58:58 INFO - (blobuploader) - INFO - Done attempting. 12:58:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:58:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:58:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:58:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:58:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:58:59 INFO - (blobuploader) - INFO - Done attempting. 12:58:59 INFO - (blobuploader) - INFO - Iteration through files over. 12:58:59 INFO - Return code: 0 12:58:59 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 12:58:59 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 12:58:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e67b967bd4d3fe30eca280c079c55d382bc3b18302f18a01fd5ae13d2c62413d0fbfd842d25dfb08ad6f3eea33b46a599ed334296756857baf206cdad7c6726", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39209b1bbd47ffd16c76f0cfd7716bf608a7fc8c1b93fb40cce572b91a08de48fd1f3d0087aa0c7c9100df22d63d9761c3d8606a866223b0398c97d0b243b963"} 12:58:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 12:58:59 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 12:58:59 INFO - Contents: 12:58:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e67b967bd4d3fe30eca280c079c55d382bc3b18302f18a01fd5ae13d2c62413d0fbfd842d25dfb08ad6f3eea33b46a599ed334296756857baf206cdad7c6726", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39209b1bbd47ffd16c76f0cfd7716bf608a7fc8c1b93fb40cce572b91a08de48fd1f3d0087aa0c7c9100df22d63d9761c3d8606a866223b0398c97d0b243b963"} 12:58:59 INFO - Running post-run listener: copy_logs_to_upload_dir 12:58:59 INFO - Copying logs to upload dir... 12:58:59 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 12:58:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1223.931894 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 23 secs) (at 2016-03-08 12:58:59.185137) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-08 12:58:59.192357) ========= 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=6dbc10da6d83fee962c624be000001a8-1457469513.201587-1152426323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e67b967bd4d3fe30eca280c079c55d382bc3b18302f18a01fd5ae13d2c62413d0fbfd842d25dfb08ad6f3eea33b46a599ed334296756857baf206cdad7c6726", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39209b1bbd47ffd16c76f0cfd7716bf608a7fc8c1b93fb40cce572b91a08de48fd1f3d0087aa0c7c9100df22d63d9761c3d8606a866223b0398c97d0b243b963"} build_url:https://queue.taskcluster.net/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011220 build_url: 'https://queue.taskcluster.net/v1/task/bhIcvrmFQMamaY7krX2Z6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e67b967bd4d3fe30eca280c079c55d382bc3b18302f18a01fd5ae13d2c62413d0fbfd842d25dfb08ad6f3eea33b46a599ed334296756857baf206cdad7c6726", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39209b1bbd47ffd16c76f0cfd7716bf608a7fc8c1b93fb40cce572b91a08de48fd1f3d0087aa0c7c9100df22d63d9761c3d8606a866223b0398c97d0b243b963"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-08 12:58:59.219497) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 12:58:59.219815) ========= 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=6dbc10da6d83fee962c624be000001a8-1457469513.201587-1152426323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004634 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 12:58:59.301997) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-08 12:58:59.302303) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-08 12:58:59.302584) ========= ========= Total master_lag: 0.34 =========