builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1467463440.66 results: success (0) buildid: 20160702030219 builduid: 5e94ce95d87542d69b9e698cb6a7d425 revision: 39dffbba764210b25bfc1e749b4f16db77fa0d46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 05:44:00.662964) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 05:44:00.663440) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 05:44:00.663780) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 05:44:00.681700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 05:44:00.682117) ========= 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/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1467462932.148651-1816808426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-02 05:44:01-- 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% 226M=0s 2016-07-02 05:44:01 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124065 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 05:44:00.832669) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 05:44:00.832996) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1467462932.148651-1816808426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018240 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 05:44:00.890475) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 05:44:00.890840) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 39dffbba764210b25bfc1e749b4f16db77fa0d46 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 39dffbba764210b25bfc1e749b4f16db77fa0d46 --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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1467462932.148651-1816808426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-02 05:44:01,252 truncating revision to first 12 chars 2016-07-02 05:44:01,252 Setting DEBUG logging. 2016-07-02 05:44:01,252 attempt 1/10 2016-07-02 05:44:01,252 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/39dffbba7642?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-02 05:44:01,717 unpacking tar archive at: mozilla-central-39dffbba7642/testing/mozharness/ program finished with exit code 0 elapsedTime=0.782006 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 05:44:01.688808) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 05:44:01.689146) ========= script_repo_revision: 39dffbba764210b25bfc1e749b4f16db77fa0d46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 05:44:01.689870) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 05:44:01.690377) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 05:44:01.705175) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-02 05:44:01.705486) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1467462932.148651-1816808426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:44:02 INFO - MultiFileLogger online at 20160702 05:44:02 in /builds/slave/test 05:44:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:44:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:44:02 INFO - {'append_to_log': False, 05:44:02 INFO - 'base_work_dir': '/builds/slave/test', 05:44:02 INFO - 'blob_upload_branch': 'Firefox', 05:44:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:44:02 INFO - 'branch': 'Firefox', 05:44:02 INFO - 'buildbot_json_path': 'buildprops.json', 05:44:02 INFO - 'config_files': ('talos/linux_config.py',), 05:44:02 INFO - 'default_actions': ('clobber', 05:44:02 INFO - 'read-buildbot-config', 05:44:02 INFO - 'download-and-extract', 05:44:02 INFO - 'populate-webroot', 05:44:02 INFO - 'create-virtualenv', 05:44:02 INFO - 'install', 05:44:02 INFO - 'run-tests'), 05:44:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:44:02 INFO - 'download_minidump_stackwalk': True, 05:44:02 INFO - 'download_symbols': 'ondemand', 05:44:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:44:02 INFO - 'tooltool.py': '/tools/tooltool.py', 05:44:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:44:02 INFO - '/tools/misc-python/virtualenv.py')}, 05:44:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:44:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:44:02 INFO - 'installer_path': 'installer.exe', 05:44:02 INFO - 'log_level': 'info', 05:44:02 INFO - 'log_name': 'talos', 05:44:02 INFO - 'log_to_console': True, 05:44:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:44:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:44:02 INFO - 'opt_config_files': (), 05:44:02 INFO - 'pip_index': False, 05:44:02 INFO - 'sps_profile': False, 05:44:02 INFO - 'sps_profile_interval': 0, 05:44:02 INFO - 'suite': 'dromaeojs', 05:44:02 INFO - 'system_bits': '32', 05:44:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:44:02 INFO - 'title': 'talos-linux64-ix-041', 05:44:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:44:02 INFO - 'use_talos_json': True, 05:44:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:44:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:44:02 INFO - 'work_dir': 'build'} 05:44:02 INFO - ##### 05:44:02 INFO - ##### Running clobber step. 05:44:02 INFO - ##### 05:44:02 INFO - Running pre-action listener: _resource_record_pre_action 05:44:02 INFO - Running main action method: clobber 05:44:02 INFO - rmtree: /builds/slave/test/build 05:44:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:44:03 INFO - Running post-action listener: _resource_record_post_action 05:44:03 INFO - ##### 05:44:03 INFO - ##### Finished clobber step (success) 05:44:03 INFO - ##### 05:44:03 INFO - ##### 05:44:03 INFO - ##### Running read-buildbot-config step. 05:44:03 INFO - ##### 05:44:03 INFO - Running pre-action listener: _resource_record_pre_action 05:44:03 INFO - Running main action method: read_buildbot_config 05:44:03 INFO - Using buildbot properties: 05:44:03 INFO - { 05:44:03 INFO - "project": "", 05:44:03 INFO - "product": "firefox", 05:44:03 INFO - "script_repo_revision": "production", 05:44:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:44:03 INFO - "repository": "", 05:44:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:44:03 INFO - "buildid": "20160702030219", 05:44:03 INFO - "stage_platform": "linux64-pgo", 05:44:03 INFO - "basedir": "/builds/slave/test", 05:44:03 INFO - "nightly_build": "True", 05:44:03 INFO - "buildnumber": 359, 05:44:03 INFO - "slavename": "talos-linux64-ix-041", 05:44:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:44:03 INFO - "platform": "ubuntu64_hw", 05:44:03 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:44:03 INFO - "branch": "mozilla-central", 05:44:03 INFO - "repo_path": "mozilla-central", 05:44:03 INFO - "revision": "39dffbba764210b25bfc1e749b4f16db77fa0d46", 05:44:03 INFO - "pgo_build": "True", 05:44:03 INFO - "builduid": "5e94ce95d87542d69b9e698cb6a7d425", 05:44:03 INFO - "slavebuilddir": "test" 05:44:03 INFO - } 05:44:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:44:03 INFO - Running post-action listener: _resource_record_post_action 05:44:03 INFO - ##### 05:44:03 INFO - ##### Finished read-buildbot-config step (success) 05:44:03 INFO - ##### 05:44:03 INFO - ##### 05:44:03 INFO - ##### Running download-and-extract step. 05:44:03 INFO - ##### 05:44:03 INFO - Running pre-action listener: _resource_record_pre_action 05:44:03 INFO - Running main action method: download_and_extract 05:44:03 INFO - mkdir: /builds/slave/test/build/tests 05:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:03 INFO - https://queue.taskcluster.net/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:44:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:44:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:44:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:44:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:44:11 INFO - Downloaded 1361 bytes. 05:44:11 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:44:11 INFO - Using the following test package requirements: 05:44:11 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:44:11 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:44:11 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:44:11 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:11 INFO - u'jsshell-linux-x86_64.zip'], 05:44:11 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:44:11 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:44:11 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:44:11 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:44:11 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:44:11 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:44:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:44:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:11 INFO - https://queue.taskcluster.net/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:44:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:44:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:44:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:44:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:44:18 INFO - Downloaded 24272417 bytes. 05:44:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:44:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:44:19 INFO - Return code: 0 05:44:19 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:19 INFO - https://queue.taskcluster.net/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:44:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:44:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:44:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:44:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:44:25 INFO - Downloaded 24272417 bytes. 05:44:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:44:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:44:26 INFO - Return code: 0 05:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:26 INFO - https://queue.taskcluster.net/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:44:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:44:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:44:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:44:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:44:27 INFO - Downloaded 14405327 bytes. 05:44:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:44:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:44:28 INFO - Return code: 0 05:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:28 INFO - https://queue.taskcluster.net/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:44:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:44:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:44:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:44:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:44:29 INFO - Downloaded 60348651 bytes. 05:44:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:44:29 INFO - mkdir: /builds/slave/test/properties 05:44:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:44:29 INFO - Writing to file /builds/slave/test/properties/build_url 05:44:29 INFO - Contents: 05:44:29 INFO - build_url:https://queue.taskcluster.net/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:44:30 INFO - Running post-action listener: _resource_record_post_action 05:44:30 INFO - Running post-action listener: set_extra_try_arguments 05:44:30 INFO - ##### 05:44:30 INFO - ##### Finished download-and-extract step (success) 05:44:30 INFO - ##### 05:44:30 INFO - ##### 05:44:30 INFO - ##### Running populate-webroot step. 05:44:30 INFO - ##### 05:44:30 INFO - Running pre-action listener: _resource_record_pre_action 05:44:30 INFO - Running main action method: populate_webroot 05:44:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:44:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:44:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:44:30 INFO - '--tppagecycles', 05:44:30 INFO - '7'], 05:44:30 INFO - 'tests': ['tsvgm']}}, 05:44:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:44:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:44:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:44:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:44:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:44:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:44:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:30 INFO - 'talos_options': ['--disable-e10s'], 05:44:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:44:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:44:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:30 INFO - 'talos_options': ['--disable-e10s'], 05:44:30 INFO - 'tests': ['damp', 'tps']}, 05:44:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:30 INFO - 'tests': ['damp', 'tps']}, 05:44:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:44:30 INFO - 'tests': ['dromaeo_dom']}, 05:44:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:44:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:44:30 INFO - 'tests': ['basic_compositor_video']}, 05:44:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:44:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:44:30 INFO - 'tests': ['a11yr', 05:44:30 INFO - 'ts_paint', 05:44:30 INFO - 'tpaint', 05:44:30 INFO - 'sessionrestore', 05:44:30 INFO - 'sessionrestore_no_auto_restore', 05:44:30 INFO - 'tabpaint']}, 05:44:30 INFO - 'other-e10s': {'tests': ['a11yr', 05:44:30 INFO - 'ts_paint', 05:44:30 INFO - 'tpaint', 05:44:30 INFO - 'sessionrestore', 05:44:30 INFO - 'sessionrestore_no_auto_restore', 05:44:30 INFO - 'tabpaint']}, 05:44:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:44:30 INFO - 'ts_paint', 05:44:30 INFO - 'tpaint', 05:44:30 INFO - 'sessionrestore', 05:44:30 INFO - 'sessionrestore_no_auto_restore', 05:44:30 INFO - 'tabpaint']}, 05:44:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:44:30 INFO - 'ts_paint', 05:44:30 INFO - 'tpaint', 05:44:30 INFO - 'sessionrestore', 05:44:30 INFO - 'sessionrestore_no_auto_restore', 05:44:30 INFO - 'tabpaint']}, 05:44:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:44:30 INFO - 'tests': ['a11yr', 05:44:30 INFO - 'ts_paint', 05:44:30 INFO - 'tpaint', 05:44:30 INFO - 'sessionrestore', 05:44:30 INFO - 'sessionrestore_no_auto_restore', 05:44:30 INFO - 'tabpaint']}, 05:44:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:44:30 INFO - 'tests': ['a11yr', 05:44:30 INFO - 'ts_paint', 05:44:30 INFO - 'tpaint', 05:44:30 INFO - 'sessionrestore', 05:44:30 INFO - 'sessionrestore_no_auto_restore', 05:44:30 INFO - 'tabpaint']}, 05:44:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:44:30 INFO - 'tests': ['tsvgx', 05:44:30 INFO - 'tsvgr_opacity', 05:44:30 INFO - 'tart', 05:44:30 INFO - 'tscrollx', 05:44:30 INFO - 'cart']}, 05:44:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:44:30 INFO - 'tsvgr_opacity', 05:44:30 INFO - 'tart', 05:44:30 INFO - 'tscrollx', 05:44:30 INFO - 'cart']}, 05:44:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:30 INFO - 'talos_options': ['--disable-e10s'], 05:44:30 INFO - 'tests': ['tp5o']}, 05:44:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:30 INFO - 'tests': ['tp5o']}, 05:44:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:30 INFO - 'talos_options': ['--disable-e10s', 05:44:30 INFO - '--xperf_path', 05:44:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:44:30 INFO - 'tests': ['tp5n']}, 05:44:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:30 INFO - 'talos_options': ['--xperf_path', 05:44:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:44:30 INFO - 'tests': ['tp5n']}}, 05:44:30 INFO - 'talos.zip': {'path': '', 05:44:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:44:30 INFO - Running post-action listener: _resource_record_post_action 05:44:30 INFO - ##### 05:44:30 INFO - ##### Finished populate-webroot step (success) 05:44:30 INFO - ##### 05:44:30 INFO - ##### 05:44:30 INFO - ##### Running create-virtualenv step. 05:44:30 INFO - ##### 05:44:30 INFO - Running pre-action listener: _resource_record_pre_action 05:44:30 INFO - Running main action method: create_virtualenv 05:44:30 INFO - Creating virtualenv /builds/slave/test/build/venv 05:44:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:44:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:44:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:44:30 INFO - Using real prefix '/usr' 05:44:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:44:30 INFO - Installing distribute.............................................................................................................................................................................................done. 05:44:32 INFO - Installing pip.................done. 05:44:32 INFO - Return code: 0 05:44:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x2068030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23273b0>, '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 0x23282b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2328740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467462932.148651-1816808426', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:32 INFO - Running command: ['/builds/slave/test/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/build 05:44:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:44:32 INFO - Using env: {'DISPLAY': ':0', 05:44:32 INFO - 'HOME': '/home/cltbld', 05:44:32 INFO - 'LANG': 'en_US.UTF-8', 05:44:32 INFO - 'LANGUAGE': 'en_US:en', 05:44:32 INFO - 'LOGNAME': 'cltbld', 05:44:32 INFO - 'MAIL': '/var/mail/cltbld', 05:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:32 INFO - 'MOZ_NO_REMOTE': '1', 05:44:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:32 INFO - 'NO_EM_RESTART': '1', 05:44:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:32 INFO - 'PWD': '/builds/slave/test', 05:44:32 INFO - 'SHELL': '/bin/bash', 05:44:32 INFO - 'SHLVL': '1', 05:44:32 INFO - 'TERM': 'linux', 05:44:32 INFO - 'TMOUT': '86400', 05:44:32 INFO - 'USER': 'cltbld', 05:44:32 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467462932.148651-1816808426', 05:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:32 INFO - '_': '/tools/buildbot/bin/python'} 05:44:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:33 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:44:33 INFO - Cleaning up... 05:44:33 INFO - Return code: 0 05:44:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2068030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23273b0>, '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 0x23282b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2328740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467462932.148651-1816808426', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:33 INFO - Running command: ['/builds/slave/test/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>=3.1.1'] in /builds/slave/test/build 05:44:33 INFO - Copy/paste: /builds/slave/test/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>=3.1.1 05:44:33 INFO - Using env: {'DISPLAY': ':0', 05:44:33 INFO - 'HOME': '/home/cltbld', 05:44:33 INFO - 'LANG': 'en_US.UTF-8', 05:44:33 INFO - 'LANGUAGE': 'en_US:en', 05:44:33 INFO - 'LOGNAME': 'cltbld', 05:44:33 INFO - 'MAIL': '/var/mail/cltbld', 05:44:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:33 INFO - 'MOZ_NO_REMOTE': '1', 05:44:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:33 INFO - 'NO_EM_RESTART': '1', 05:44:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:33 INFO - 'PWD': '/builds/slave/test', 05:44:33 INFO - 'SHELL': '/bin/bash', 05:44:33 INFO - 'SHLVL': '1', 05:44:33 INFO - 'TERM': 'linux', 05:44:33 INFO - 'TMOUT': '86400', 05:44:33 INFO - 'USER': 'cltbld', 05:44:33 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467462932.148651-1816808426', 05:44:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:33 INFO - '_': '/tools/buildbot/bin/python'} 05:44:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:33 INFO - Downloading/unpacking psutil>=3.1.1 05:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:44:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:44:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:44:35 INFO - Installing collected packages: psutil 05:44:35 INFO - Running setup.py install for psutil 05:44:35 INFO - building 'psutil._psutil_linux' extension 05:44:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:44:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:44:35 INFO - building 'psutil._psutil_posix' extension 05:44:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:44:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:44:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:44:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:44:35 INFO - Successfully installed psutil 05:44:35 INFO - Cleaning up... 05:44:35 INFO - Return code: 0 05:44:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2068030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23273b0>, '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 0x23282b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2328740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467462932.148651-1816808426', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:35 INFO - Running command: ['/builds/slave/test/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.3'] in /builds/slave/test/build 05:44:35 INFO - Copy/paste: /builds/slave/test/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.3 05:44:35 INFO - Using env: {'DISPLAY': ':0', 05:44:35 INFO - 'HOME': '/home/cltbld', 05:44:35 INFO - 'LANG': 'en_US.UTF-8', 05:44:35 INFO - 'LANGUAGE': 'en_US:en', 05:44:35 INFO - 'LOGNAME': 'cltbld', 05:44:35 INFO - 'MAIL': '/var/mail/cltbld', 05:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:35 INFO - 'MOZ_NO_REMOTE': '1', 05:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:35 INFO - 'NO_EM_RESTART': '1', 05:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:35 INFO - 'PWD': '/builds/slave/test', 05:44:35 INFO - 'SHELL': '/bin/bash', 05:44:35 INFO - 'SHLVL': '1', 05:44:35 INFO - 'TERM': 'linux', 05:44:35 INFO - 'TMOUT': '86400', 05:44:35 INFO - 'USER': 'cltbld', 05:44:35 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467462932.148651-1816808426', 05:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:35 INFO - '_': '/tools/buildbot/bin/python'} 05:44:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:44:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:44:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:44:38 INFO - Installing collected packages: mozsystemmonitor 05:44:38 INFO - Running setup.py install for mozsystemmonitor 05:44:38 INFO - Successfully installed mozsystemmonitor 05:44:38 INFO - Cleaning up... 05:44:38 INFO - Return code: 0 05:44:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2068030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23273b0>, '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 0x23282b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2328740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467462932.148651-1816808426', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:38 INFO - Running command: ['/builds/slave/test/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==2.5.1'] in /builds/slave/test/build 05:44:38 INFO - Copy/paste: /builds/slave/test/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==2.5.1 05:44:38 INFO - Using env: {'DISPLAY': ':0', 05:44:38 INFO - 'HOME': '/home/cltbld', 05:44:38 INFO - 'LANG': 'en_US.UTF-8', 05:44:38 INFO - 'LANGUAGE': 'en_US:en', 05:44:38 INFO - 'LOGNAME': 'cltbld', 05:44:38 INFO - 'MAIL': '/var/mail/cltbld', 05:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:38 INFO - 'MOZ_NO_REMOTE': '1', 05:44:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:38 INFO - 'NO_EM_RESTART': '1', 05:44:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:38 INFO - 'PWD': '/builds/slave/test', 05:44:38 INFO - 'SHELL': '/bin/bash', 05:44:38 INFO - 'SHLVL': '1', 05:44:38 INFO - 'TERM': 'linux', 05:44:38 INFO - 'TMOUT': '86400', 05:44:38 INFO - 'USER': 'cltbld', 05:44:38 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467462932.148651-1816808426', 05:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:38 INFO - '_': '/tools/buildbot/bin/python'} 05:44:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:38 INFO - Downloading/unpacking jsonschema==2.5.1 05:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:44:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:40 INFO - Downloading functools32-3.2.3-2.tar.gz 05:44:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:44:40 INFO - warning: no files found matching '*.txt' 05:44:40 INFO - no previously-included directories found matching 'build' 05:44:40 INFO - no previously-included directories found matching 'dist' 05:44:40 INFO - no previously-included directories found matching '.git*' 05:44:40 INFO - Installing collected packages: jsonschema, functools32 05:44:40 INFO - Running setup.py install for functools32 05:44:40 INFO - warning: no files found matching '*.txt' 05:44:40 INFO - no previously-included directories found matching 'build' 05:44:40 INFO - no previously-included directories found matching 'dist' 05:44:40 INFO - no previously-included directories found matching '.git*' 05:44:40 INFO - Successfully installed jsonschema functools32 05:44:40 INFO - Cleaning up... 05:44:40 INFO - Return code: 0 05:44:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x2068030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23273b0>, '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 0x23282b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2328740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467462932.148651-1816808426', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:40 INFO - Running command: ['/builds/slave/test/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/build 05:44:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:44:40 INFO - Using env: {'DISPLAY': ':0', 05:44:40 INFO - 'HOME': '/home/cltbld', 05:44:40 INFO - 'LANG': 'en_US.UTF-8', 05:44:40 INFO - 'LANGUAGE': 'en_US:en', 05:44:40 INFO - 'LOGNAME': 'cltbld', 05:44:40 INFO - 'MAIL': '/var/mail/cltbld', 05:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:40 INFO - 'MOZ_NO_REMOTE': '1', 05:44:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:40 INFO - 'NO_EM_RESTART': '1', 05:44:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:40 INFO - 'PWD': '/builds/slave/test', 05:44:40 INFO - 'SHELL': '/bin/bash', 05:44:40 INFO - 'SHLVL': '1', 05:44:40 INFO - 'TERM': 'linux', 05:44:40 INFO - 'TMOUT': '86400', 05:44:40 INFO - 'USER': 'cltbld', 05:44:40 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467462932.148651-1816808426', 05:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:40 INFO - '_': '/tools/buildbot/bin/python'} 05:44:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:40 INFO - Downloading/unpacking blobuploader==1.2.4 05:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:42 INFO - Downloading blobuploader-1.2.4.tar.gz 05:44:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:44:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:44:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:43 INFO - Downloading docopt-0.6.1.tar.gz 05:44:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:44:43 INFO - Installing collected packages: blobuploader, requests, docopt 05:44:43 INFO - Running setup.py install for blobuploader 05:44:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:44:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:44:43 INFO - Running setup.py install for requests 05:44:44 INFO - Running setup.py install for docopt 05:44:44 INFO - Successfully installed blobuploader requests docopt 05:44:44 INFO - Cleaning up... 05:44:44 INFO - Return code: 0 05:44:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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 0x2068030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23273b0>, '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 0x23282b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2328740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467462932.148651-1816808426', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 05:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:44:44 INFO - Using env: {'DISPLAY': ':0', 05:44:44 INFO - 'HOME': '/home/cltbld', 05:44:44 INFO - 'LANG': 'en_US.UTF-8', 05:44:44 INFO - 'LANGUAGE': 'en_US:en', 05:44:44 INFO - 'LOGNAME': 'cltbld', 05:44:44 INFO - 'MAIL': '/var/mail/cltbld', 05:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:44 INFO - 'MOZ_NO_REMOTE': '1', 05:44:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:44 INFO - 'NO_EM_RESTART': '1', 05:44:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:44 INFO - 'PWD': '/builds/slave/test', 05:44:44 INFO - 'SHELL': '/bin/bash', 05:44:44 INFO - 'SHLVL': '1', 05:44:44 INFO - 'TERM': 'linux', 05:44:44 INFO - 'TMOUT': '86400', 05:44:44 INFO - 'USER': 'cltbld', 05:44:44 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467462932.148651-1816808426', 05:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:44 INFO - '_': '/tools/buildbot/bin/python'} 05:44:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:44:44 INFO - Running setup.py (path:/tmp/pip-mp3971-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:44:44 INFO - Running setup.py (path:/tmp/pip-fOzvSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:44:44 INFO - Running setup.py (path:/tmp/pip-IelvFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:44:44 INFO - Running setup.py (path:/tmp/pip-48Ixyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:44:44 INFO - Running setup.py (path:/tmp/pip-DnZ1wb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:44:44 INFO - Running setup.py (path:/tmp/pip-hpebmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:44:44 INFO - Running setup.py (path:/tmp/pip-DPOK2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:44:44 INFO - Running setup.py (path:/tmp/pip-Bx7rTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:44:45 INFO - Running setup.py (path:/tmp/pip-EuwIm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:44:45 INFO - Running setup.py (path:/tmp/pip-8NVOCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:44:45 INFO - Running setup.py (path:/tmp/pip-q7Md7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:44:45 INFO - Running setup.py (path:/tmp/pip-SP48Yf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:44:45 INFO - Running setup.py (path:/tmp/pip-mkzs0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:44:45 INFO - Running setup.py (path:/tmp/pip-b7CtVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:44:45 INFO - Running setup.py (path:/tmp/pip-qa9tr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:44:45 INFO - Running setup.py (path:/tmp/pip-MpghPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:44:45 INFO - Running setup.py (path:/tmp/pip-AqjYGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:44:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:44:45 INFO - Running setup.py install for manifestparser 05:44:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:44:45 INFO - Running setup.py install for mozcrash 05:44:45 INFO - Running setup.py install for mozdebug 05:44:45 INFO - Running setup.py install for mozdevice 05:44:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:44:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:44:46 INFO - Running setup.py install for mozfile 05:44:46 INFO - Running setup.py install for mozhttpd 05:44:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:44:46 INFO - Running setup.py install for mozinfo 05:44:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:44:46 INFO - Running setup.py install for mozInstall 05:44:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:44:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:44:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:44:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:44:46 INFO - Running setup.py install for mozleak 05:44:46 INFO - Running setup.py install for mozlog 05:44:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:44:46 INFO - Running setup.py install for moznetwork 05:44:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:44:46 INFO - Running setup.py install for mozprocess 05:44:46 INFO - Running setup.py install for mozprofile 05:44:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:44:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:44:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:44:47 INFO - Running setup.py install for mozrunner 05:44:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:44:47 INFO - Running setup.py install for mozscreenshot 05:44:47 INFO - Running setup.py install for moztest 05:44:47 INFO - Running setup.py install for mozversion 05:44:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:44:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:44:47 INFO - Cleaning up... 05:44:47 INFO - Return code: 0 05:44:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x2068030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23273b0>, '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 0x23282b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2328740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467462932.148651-1816808426', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 05:44:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:44:47 INFO - Using env: {'DISPLAY': ':0', 05:44:47 INFO - 'HOME': '/home/cltbld', 05:44:47 INFO - 'LANG': 'en_US.UTF-8', 05:44:47 INFO - 'LANGUAGE': 'en_US:en', 05:44:47 INFO - 'LOGNAME': 'cltbld', 05:44:47 INFO - 'MAIL': '/var/mail/cltbld', 05:44:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:47 INFO - 'MOZ_NO_REMOTE': '1', 05:44:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:47 INFO - 'NO_EM_RESTART': '1', 05:44:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:47 INFO - 'PWD': '/builds/slave/test', 05:44:47 INFO - 'SHELL': '/bin/bash', 05:44:47 INFO - 'SHLVL': '1', 05:44:47 INFO - 'TERM': 'linux', 05:44:47 INFO - 'TMOUT': '86400', 05:44:47 INFO - 'USER': 'cltbld', 05:44:47 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467462932.148651-1816808426', 05:44:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:47 INFO - '_': '/tools/buildbot/bin/python'} 05:44:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:44:47 INFO - Running setup.py (path:/tmp/pip-xTaF9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:44:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:44:47 INFO - Running setup.py (path:/tmp/pip-kVZ5H3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:44:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:44:47 INFO - Running setup.py (path:/tmp/pip-2EKLGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:44:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:44:47 INFO - Running setup.py (path:/tmp/pip-u64vo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:44:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:44:47 INFO - Running setup.py (path:/tmp/pip-JDwQdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:44:48 INFO - Running setup.py (path:/tmp/pip-4ENj9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:44:48 INFO - Running setup.py (path:/tmp/pip-7NAL50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:44:48 INFO - Running setup.py (path:/tmp/pip-b0QNQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:44:48 INFO - Running setup.py (path:/tmp/pip-Qw7bLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:44:48 INFO - Running setup.py (path:/tmp/pip-FK4yUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:44:48 INFO - Running setup.py (path:/tmp/pip-SCTqGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:44:48 INFO - Running setup.py (path:/tmp/pip-xEyfkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:44:48 INFO - Running setup.py (path:/tmp/pip-CbpY1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:44:48 INFO - Running setup.py (path:/tmp/pip-aCHlF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:44:48 INFO - Running setup.py (path:/tmp/pip-cg1x2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:44:48 INFO - Running setup.py (path:/tmp/pip-KDkcd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:44:48 INFO - Running setup.py (path:/tmp/pip-KlaM70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:44:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:50 INFO - Downloading blessings-1.6.tar.gz 05:44:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:44:50 INFO - Installing collected packages: blessings 05:44:50 INFO - Running setup.py install for blessings 05:44:51 INFO - Successfully installed blessings 05:44:51 INFO - Cleaning up... 05:44:51 INFO - Return code: 0 05:44:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:44:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:44:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:44:51 INFO - Reading from file tmpfile_stdout 05:44:51 INFO - Current package versions: 05:44:51 INFO - argparse == 1.2.1 05:44:51 INFO - blessings == 1.6 05:44:51 INFO - blobuploader == 1.2.4 05:44:51 INFO - docopt == 0.6.1 05:44:51 INFO - functools32 == 3.2.3-2 05:44:51 INFO - jsonschema == 2.5.1 05:44:51 INFO - manifestparser == 1.1 05:44:51 INFO - mozInstall == 1.12 05:44:51 INFO - mozcrash == 0.17 05:44:51 INFO - mozdebug == 0.1 05:44:51 INFO - mozdevice == 0.48 05:44:51 INFO - mozfile == 1.2 05:44:51 INFO - mozhttpd == 0.7 05:44:51 INFO - mozinfo == 0.9 05:44:51 INFO - mozleak == 0.1 05:44:51 INFO - mozlog == 3.2 05:44:51 INFO - moznetwork == 0.27 05:44:51 INFO - mozprocess == 0.22 05:44:51 INFO - mozprofile == 0.28 05:44:51 INFO - mozrunner == 6.11 05:44:51 INFO - mozscreenshot == 0.1 05:44:51 INFO - mozsystemmonitor == 0.3 05:44:51 INFO - moztest == 0.7 05:44:51 INFO - mozversion == 1.4 05:44:51 INFO - psutil == 3.1.1 05:44:51 INFO - requests == 1.2.3 05:44:51 INFO - wsgiref == 0.1.2 05:44:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:44: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')]} 05:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44: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')]} 05:44:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x2068030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23273b0>, '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 0x23282b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2328740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467462932.148651-1816808426', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/talos 05:44:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:44:51 INFO - Using env: {'DISPLAY': ':0', 05:44:51 INFO - 'HOME': '/home/cltbld', 05:44:51 INFO - 'LANG': 'en_US.UTF-8', 05:44:51 INFO - 'LANGUAGE': 'en_US:en', 05:44:51 INFO - 'LOGNAME': 'cltbld', 05:44:51 INFO - 'MAIL': '/var/mail/cltbld', 05:44:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:51 INFO - 'MOZ_NO_REMOTE': '1', 05:44:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:51 INFO - 'NO_EM_RESTART': '1', 05:44:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:51 INFO - 'PWD': '/builds/slave/test', 05:44:51 INFO - 'SHELL': '/bin/bash', 05:44:51 INFO - 'SHLVL': '1', 05:44:51 INFO - 'TERM': 'linux', 05:44:51 INFO - 'TMOUT': '86400', 05:44:51 INFO - 'USER': 'cltbld', 05:44:51 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467462932.148651-1816808426', 05:44:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:51 INFO - '_': '/tools/buildbot/bin/python'} 05:44:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:44:51 INFO - Cleaning up... 05:44:51 INFO - Return code: 0 05:44:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:44: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')]} 05:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44: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')]} 05:44:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x2068030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23273b0>, '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 0x23282b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2328740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467462932.148651-1816808426', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:51 INFO - Running command: ['/builds/slave/test/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/build 05:44:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:44:51 INFO - Using env: {'DISPLAY': ':0', 05:44:51 INFO - 'HOME': '/home/cltbld', 05:44:51 INFO - 'LANG': 'en_US.UTF-8', 05:44:51 INFO - 'LANGUAGE': 'en_US:en', 05:44:51 INFO - 'LOGNAME': 'cltbld', 05:44:51 INFO - 'MAIL': '/var/mail/cltbld', 05:44:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:51 INFO - 'MOZ_NO_REMOTE': '1', 05:44:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:51 INFO - 'NO_EM_RESTART': '1', 05:44:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:51 INFO - 'PWD': '/builds/slave/test', 05:44:51 INFO - 'SHELL': '/bin/bash', 05:44:51 INFO - 'SHLVL': '1', 05:44:51 INFO - 'TERM': 'linux', 05:44:51 INFO - 'TMOUT': '86400', 05:44:51 INFO - 'USER': 'cltbld', 05:44:51 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467462932.148651-1816808426', 05:44:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:51 INFO - '_': '/tools/buildbot/bin/python'} 05:44:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:44:51 INFO - Cleaning up... 05:44:51 INFO - Return code: 0 05:44:51 INFO - Running post-action listener: _resource_record_post_action 05:44:51 INFO - Running post-action listener: _start_resource_monitoring 05:44:51 INFO - Starting resource monitoring. 05:44:51 INFO - ##### 05:44:51 INFO - ##### Finished create-virtualenv step (success) 05:44:51 INFO - ##### 05:44:51 INFO - ##### 05:44:51 INFO - ##### Running install step. 05:44:51 INFO - ##### 05:44:51 INFO - Running pre-action listener: _resource_record_pre_action 05:44:51 INFO - Running main action method: install 05:44:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:44:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:44:51 INFO - Reading from file tmpfile_stdout 05:44:51 INFO - Detecting whether we're running mozinstall >=1.0... 05:44:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:44:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:44:52 INFO - Reading from file tmpfile_stdout 05:44:52 INFO - Output received: 05:44:52 INFO - Usage: mozinstall [options] installer 05:44:52 INFO - Options: 05:44:52 INFO - -h, --help show this help message and exit 05:44:52 INFO - -d DEST, --destination=DEST 05:44:52 INFO - Directory to install application into. [default: 05:44:52 INFO - "/builds/slave/test"] 05:44:52 INFO - --app=APP Application being installed. [default: firefox] 05:44:52 INFO - mkdir: /builds/slave/test/build/application 05:44:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:44:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:45:09 INFO - Reading from file tmpfile_stdout 05:45:09 INFO - Output received: 05:45:09 INFO - /builds/slave/test/build/application/firefox/firefox 05:45:09 INFO - Running post-action listener: _resource_record_post_action 05:45:09 INFO - ##### 05:45:09 INFO - ##### Finished install step (success) 05:45:09 INFO - ##### 05:45:09 INFO - ##### 05:45:09 INFO - ##### Running run-tests step. 05:45:09 INFO - ##### 05:45:09 INFO - Running pre-action listener: _resource_record_pre_action 05:45:09 INFO - Running main action method: run_tests 05:45:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:45:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:45:09 INFO - Python 2.7.3 05:45:09 INFO - Return code: 0 05:45:09 INFO - grabbing minidump binary from tooltool 05:45:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:09 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/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23273b0>, '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 0x23282b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2328740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:45:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:45:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:45:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:45:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:45:09 INFO - Return code: 0 05:45:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:45:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:45:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:45:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:45:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:45:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:45:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:45:09 INFO - Using env: {'DISPLAY': ':0', 05:45:09 INFO - 'HOME': '/home/cltbld', 05:45:09 INFO - 'LANG': 'en_US.UTF-8', 05:45:09 INFO - 'LANGUAGE': 'en_US:en', 05:45:09 INFO - 'LOGNAME': 'cltbld', 05:45:09 INFO - 'MAIL': '/var/mail/cltbld', 05:45:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:45:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:45:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:09 INFO - 'MOZ_NO_REMOTE': '1', 05:45:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:45:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:09 INFO - 'NO_EM_RESTART': '1', 05:45:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:09 INFO - 'PWD': '/builds/slave/test', 05:45:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:45:09 INFO - 'SHELL': '/bin/bash', 05:45:09 INFO - 'SHLVL': '1', 05:45:09 INFO - 'TERM': 'linux', 05:45:09 INFO - 'TMOUT': '86400', 05:45:09 INFO - 'USER': 'cltbld', 05:45:09 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467462932.148651-1816808426', 05:45:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:09 INFO - '_': '/tools/buildbot/bin/python'} 05:45:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:45:09 INFO - mozversion application_buildid: 20160702030219 05:45:09 INFO - mozversion application_changeset: 39dffbba764210b25bfc1e749b4f16db77fa0d46 05:45:09 INFO - mozversion application_display_name: Nightly 05:45:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:45:09 INFO - mozversion application_name: Firefox 05:45:09 INFO - mozversion application_remotingname: firefox 05:45:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:45:09 INFO - mozversion application_vendor: Mozilla 05:45:09 INFO - mozversion application_version: 50.0a1 05:45:09 INFO - mozversion platform_buildid: 20160702030219 05:45:09 INFO - mozversion platform_changeset: 39dffbba764210b25bfc1e749b4f16db77fa0d46 05:45:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:45:09 INFO - mozversion platform_version: 50.0a1 05:45:09 INFO - using testdate: 1467463509 05:45:09 INFO - actual date: 1467463509 05:45:09 INFO - starting webserver on 'localhost:57400' 05:45:09 INFO - SUITE-START | Running 2 tests 05:45:09 INFO - TEST-START | dromaeo_css 05:45:09 INFO - operating with platform_type : linux_ 05:45:09 INFO - Initialising browser for dromaeo_css test... 05:45:09 INFO - TEST-INFO | started process 21729 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8vFL82/profile http://localhost:57400/getInfo.html) 05:45:13 INFO - PROCESS | 21729 | __metrics Screen width/height:1600/1200 05:45:13 INFO - PROCESS | 21729 | colorDepth:24 05:45:13 INFO - PROCESS | 21729 | Browser inner width/height: 1024/697 05:45:13 INFO - PROCESS | 21729 | __metrics 05:45:14 INFO - PROCESS | 21729 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:45:15 INFO - TEST-INFO | 21729: exit 0 05:45:15 INFO - Browser initialized. 05:45:15 INFO - Running cycle 1/1 for dromaeo_css test... 05:45:15 INFO - TEST-INFO | started process 21811 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8vFL82/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:45:27 INFO - PROCESS | 21811 | RSS: Main: 157057024 05:45:27 INFO - PROCESS | 21811 | 05:46:18 INFO - PROCESS | 21811 | 1467463578974 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:48:26 INFO - PROCESS | 21811 | Cycle 1(1): loaded http://localhost:57400/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57400/tests/dromaeo/cssquery-ext.html) 05:48:27 INFO - PROCESS | 21811 | RSS: Main: 245141504 05:48:27 INFO - PROCESS | 21811 | 05:51:30 INFO - PROCESS | 21811 | Cycle 1(1): loaded http://localhost:57400/tests/dromaeo/cssquery-ext.html (next: http://localhost:57400/tests/dromaeo/cssquery-jquery.html) 05:51:30 INFO - PROCESS | 21811 | RSS: Main: 251748352 05:51:30 INFO - PROCESS | 21811 | 05:54:32 INFO - PROCESS | 21811 | Cycle 1(1): loaded http://localhost:57400/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57400/tests/dromaeo/cssquery-mootools.html) 05:54:33 INFO - PROCESS | 21811 | RSS: Main: 245903360 05:54:33 INFO - PROCESS | 21811 | 05:57:35 INFO - PROCESS | 21811 | Cycle 1(1): loaded http://localhost:57400/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57400/tests/dromaeo/cssquery-prototype.html) 05:57:36 INFO - PROCESS | 21811 | RSS: Main: 248414208 05:57:36 INFO - PROCESS | 21811 | 06:00:38 INFO - PROCESS | 21811 | Cycle 1(1): loaded http://localhost:57400/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57400/tests/dromaeo/cssquery-yui.html) 06:00:39 INFO - PROCESS | 21811 | RSS: Main: 220393472 06:00:39 INFO - PROCESS | 21811 | 06:03:42 INFO - PROCESS | 21811 | Cycle 1(1): loaded http://localhost:57400/tests/dromaeo/cssquery-yui.html (next: http://localhost:57400/tests/dromaeo/cssquery-dojo.html) 06:03:42 INFO - PROCESS | 21811 | RSS: Main: 300236800 06:03:42 INFO - PROCESS | 21811 | 06:03:42 INFO - PROCESS | 21811 | __start_tp_report 06:03:42 INFO - PROCESS | 21811 | _x_x_mozilla_page_load 06:03:42 INFO - PROCESS | 21811 | _x_x_mozilla_page_load_details 06:03:42 INFO - PROCESS | 21811 | |i|pagename|runs| 06:03:42 INFO - PROCESS | 21811 | |0;dojo.html;3089.6910308969104;3094.489409247473;3116.1430606583185;3122.7501799856013;3146.1977195815066;5196.350456192976;5251.343582052244;5283.233931079996;5336.6531175473565;5352.91970620441;5264.736763161845;5279.340082489689;5289.841304760864;5316;5324.946750532494;4776.164171270031;4839.177339852234;4861.368022157115;4869.683470574419;5008.073506401309;4923.82766603169;4979.029089327582;4979.10376132296;4987.426445958725;5003.17447621142;4698.671093023489;4789.353437285974;4797.7601119943865;4833.057553777015;4893.363862697862;4759.952400476021;4760.619150467989;4770.379850619397;4804.5916097131785;4863.781129849165;4782.450018247877;4798.184308667535;4843.903121937541;4864.173090574611;4867.561919427233;5167.4057483389515;5264.92102618461;5319.255304257407;5331.920021199685;5373.919391209135;5743.310802703661;5753.88492230153;5757.740901659436;5775.104858746901;5778.479936805707;5750.3962083981;5829.737661805187;5843.2403787507355;5843.707814609253;5844.386339434341;5187.584993200573;5265.552428043621;5338.546223571001;5344.412114667422;5430.945690543123;5940.732667029907;5944.138099975479;5948.583599148018;5951.880962380728;5954.136650185699;5412.431694672082;5698.458646428583;5708.20085188074;5709.257796486513;5712.371639119693;5635.520980716685;5705.1727499512335;5719.714014299351;5798.072308430631;5798.072308430631;5680.630759000652;5725.312962444534;5731.541476681856;5735.913961290584;5736.6844823534275;5449.427810079964;5562.833115006556;5679.687617181012;5725.828225153252;5740.56945729072;4365.585269399402;4365.716228445141;4394.868153955386;4423.093265880487;4434.778261086933;3909.9609003910164;3918.3730603103368;3928.52857657083;3928.7642741435607;3954.9011274717786;5215.765290561933;5334.733263336818;5393.325834270716;5485.4788795064405;5528.06022976095;5711.771529138871;5751.424857514216;5774.422557744192;5775.942240577624;5820.505257053113;5507.7246137692955;5521.171824226398;5521.309836270466;5522.061249587579;5522.558195344443;4816.927746083811;4881.438634557071;4919.0407870464915;4980.12847751642;5039;5937.465628093492;5942.286925568959;5949.881002379928;5950.702464876739;5988.580799344004;5711.171880077449;5719.3136823581435;5723.170140329546;5725.2843394575675;5726.828195154152;5711.714414279187;5881.617694849821;5898.970505147447;5934.495567876779;5975.521958243243;5644.181593668813;5666.858328541819;5668.433156684298;5674.517665998436;5678.403767604342;5708.115242137475;5772.509336706259;5777.191193232867;5777.6822274775295;5779.2486976694445;5394.27177331071;5542.334919809648;5587.022271102622;5609.158626206102;5624.100143976944;5604.271444712162;5608.6073974823;5609.298837645294;5611.971940140274;5615.747291371979;5253.894922101613;5498.560115190855;5563.833085007456;5564.387917329172;5564.527015203753;5528.391876893458;5576.888462230651;5590.552755779447;5612.971935140298;5670.829875103754;5475.425080366664;5488.890222195613;5489.34127904654;5490.478404551562;5493.533049690821 06:03:42 INFO - PROCESS | 21811 | |1;ext.html;611.4649681528663;626.9843253918652;630.6090224061077;637.595127094295;650.2781912077593;31243;34649.30701385974;34783.30433391334;44412.33381499272;45638.771806140925;46064.769676151656;46464.53535464653;46521.83695407608;46526.76736616321;46573.76713116438;8853.42452740573;9045.638174473013;9078.04680508547;9081.59132839024;9093.363464557484;8972.416792908472;8975.506347150904;9030.051844556325;9041.321900857429;9062.546872656374;9069.863952040725;9116.088391160898;9118.726438206832;9122.270218382546;9125.087491250855;9041.141091596288;9063.728088157366;9091.636334546676;9092.545192769192;9096.181343679067;8905.643774249022;8955.37312388133;8964.641414343483;8972.551372431417;8980.101989801033;43533.782331088456;43935.78032109819;43994.560054399364;44010.55989440097;44021.33967990483;3445.4274937550213;3611.981940090309;3747.4191500317493;3921.5490218624936;4141.109661422808;33562.496562551336;34039;34289.31421371559;34412.82793586041;35387.82306088479;4421.226285400042;4577.1074640444795;4614.353990441341;4681.438227412732;4696.812127514895;333119;333334;334564;334586;335178.32410838036;60184.69907650434;60252.698736506034;60560;60607.696961515794;60686;64428;64833.35166648273;64987;65015;65031.67484162549;16959.321627134777;17043.659126817394;17181.82818171802;17187.31250749981;17212.1393930303;13425;13426.395812188475;13479.663008424868;13485.393157307944;13498.52755153565;16567.73041731756;18404.26382944694;18677.1984202368;18728.344507942158;18849.81150188508;5155;5987.401259873977;6156.815295541141;6208.509957610231;6259.593126446766;919.9080091990882;1001.3441196016621;1062.888396718349;1091.7543552700738;1110.4947249001846;32252.516212256836;32507.512387314207;32588.67411325904;33023.66976330254;33120.66879331224;1088.1566785740956;1114.2033446086086;1161.1291531351487;1180.8760080191457;1191.0032983925892;16994.830051699573;17363.913180434018;17375.391861284796;17396;17471.65056698859;498935;504358;504970;505847;507334;59009.40990590039;59905.400945990856;60021;60115;60219.39780602138;1232.6055662188194;1318.821959035537;1353.7630914589906;1358.7078778062764;1360.5986234061174;31576;33598.328033439684;33990.66009339875;34245.355748427246;34387.82806085954;51672.48327516827;52051.2192317108;52358.47641523536;52484.737576311876;52515.212271816716;407207;407615;409560.8565871455;409636;410559;36032.4595131068;41441;42535.14929701327;42727.78636106799;45898.77050614726;48843.26735098905;49054.75472622614;49089;49354;50210.24684629807;42310.57689423066;42652;42717.35923961081;44122.69079818962;44171.558284416744;42376;42427.363589546796;42929.141417172104;43257;43816.34275485934;36802.63197367992;37545;37754.62245377621;40702.389464157466;41518.16963660649;35441.46837797487;37333.253334932604;37416.251674966894;37797.81101094587;37911;27515.44969100647;27832.16503504898;27907.581386279628;28075.859620702584;28123.015694450594 06:03:42 INFO - PROCESS | 21811 | |2;jquery.html;401.70073295394934;411.09764067871;414.2832899084584;416.9916601667967;430.3437258181273;13965.790513142285;18544.536386590342;20271.59456810865;20486.590268194628;21718.89140554295;15912;18820.43538693838;19412;19488.805111948877;20000;5595.608307418473;5845.473907348338;5846.444587764156;5850.385709500505;5851.239338885939;5623.522000629951;5772.422757724236;5812.709364531777;5846.678432686201;5847.064469684851;5763.279590051244;5793.304803423595;5803.854903627401;5821.56338274629;5823.126531020339;5556.805511807088;5738.598298119134;5748.338941021794;5801.82594522165;5807.796727114531;5216.061109000379;5217.973910130463;5228.37259528859;5236.21456781482;5241.109011468022;23965.88017059921;24019.87990060056;24279.514409711883;24572.262832115066;24895.62656560153;2393.8922748476184;2454;2471.7281099079087;2613.6994245661804;2944.3522425066453;14696.26518674062;15192.848071519255;15483.845161548354;15502.689946201013;15868.841311586968;1932.5072106612724;2019.1721394228296;2041.2855500574829;2051.476873397289;2077.6156411064003;74822.62588687021;77796.99999999943;77889;82270.17729822744;85218.57390713006;10037.39775613451;10066.59733610662;10225.539850706737;10228.232882533839;10406.635767748245;13918.51285205013;13930.930345348208;13950;14006.719865602834;14036.438542458187;8099.311558517592;8311.667533298722;8321.08468068512;8328.958355208186;8468.44955077918;7366.858136988775;8343.165683431609;8413.957930210432;8545.230929216275;8566.91433085661;4655.185342565038;4804.279358096313;4930;4962.283465349476;4997.7251251180805;1996.7703714073068;2001.4295925661118;2050.641137800879;2062.2988184017504;2071.2543484345624;909.6406919266985;989.2728844299434;1045.2213101239624;1083.8976561956135;1095.7479779650726;20260.797392025892;20548;20806.479838004172;20996.580068398853;21161.365159045254;926.4904302633524;962.4033099478369;992.2607657295362;1025.646152077532;1065.3288428290127;10752.731181720363;11074.671039475315;11169.609063682732;11219.270747401393;11315.943420282845;498150;506921;508003;509591;515481;88457.55771221232;90364;91596;92785;95577.522112389;1023.3092662452964;1037.113268155731;1040;1047.1675018360422;1058.513083981362;17574.472765817045;17675.29298828084;17954.102294884942;17956.640867182843;18130.818691812914;42069.15861682688;42413.575864240964;42479.575204247565;42760.57239427566;43900.780496098596;59523.40476595179;59677.40322596719;61681.07478387738;62062.379376207464;62117;5676.7445464955;5972.462478376967;6985.825354366181;8669;9245.630174792934;13036.348182590642;13800.585982420544;14041.92979035139;14048.157110573398;14494.782578261123;12429.75140497203;12542.12205145631;12568.560100396808;12627.368631568568;12813.231206127663;12290.446929888356;12435.937820311203;12524.874751252735;12540.498380064695;12608.180468269533;12622.936885315881;12822.166559173624;12907.123633767113;12910.483580656668;12992.8051079232;8769.736907892773;8777.692780752643;8905.064968178249;8963.969143548575;9089.454632722058;9060.048694887206;11398.487068082122;11905.285682859056;12585.307808070278;12608.558700445441 06:03:42 INFO - PROCESS | 21811 | |3;mootools.html;1451.6878871042727;1493.6041948883544;1597.2093813562287;1741.5297869575206;1787.213626004557;8735.301175905928;9337.953310233457;9397.24822014239;9408.388454750437;9413.152816246537;7814.25764552368;8552.35857310701;8816.691415800447;8911.197992180703;9130.360874738772;2203.6804663323846;2236.4185311818883;2244.5286489837154;2246;2246.2699622622713;2191.967120493186;2239.4177513846435;2241.7870302321253;2243.1363924888956;2245.3264020793695;1975.9110840012163;2152.3435352217566;2211.7345918489805;2211.8672879627193;2264.841461097724;2223.8332125090683;2250.3586477853733;2251.4821591034074;2257.6162052451123;2269.375921621551;2230.7657695941853;2252.087904398721;2259.638457846753;2263.7849404306567;2265.818734501236;9330.953345233298;9372.765680857965;9399.34204605678;9426.057394260588;9438.952805235998;5257.474252574751;5349.698129146073;5405.4324295949145;5407.945920540784;5528.170774383834;3216.710496055366;3304.8843290484956;3351.547541081947;3365.9831700841337;3385.5937287525408;1116.8827273136367;1129.181343525937;2219.6004719150546;2263.7283525976986;2264.750877403484;12942.352882355844;13063.477460901553;13095.148815326973;13105.475780968749;13114.147580407338;4458.464984201852;4542.295944128666;4667.463241727177;4677.573340131293;4707.435107787019;10200.795984080276;10215.080642742189;10231.181505479544;10235.181185505142;10236.897631023743;5419.864503387447;5421.051316019681;5427.972860135753;5431.782728690887;5431.945680543223;5026.673266237683;5079.847604571869;5084.720340381315;5118.360204974379;5128.615353848476;3673.853045878135;3755.8122093895195;3786.905327366783;3801.961980380216;3810.657040866335;1075.0969185883896;1161.227783523964;1169.0589075794067;1172.8299396587447;1180.7815554122515;814.5316443045155;875.0112373018449;886.866969954499;952.5094576293214;976.9658061967797;5721;5746.454086861741;5904;6071.332153463116;6251.562390632703;897.7576054465258;945.4421891084156;954.9140577348072;1019.2152042926905;1028.5268776362807;3881.9324685711654;4043.4137050128156;4094.5022642409167;4155.812988415529;4195.538490766014;11363;11730.70673233176;11846.881531184577;11848.644540663794;11859.347735874437;10231.7442063949;11699.2980421175;11714.297142171497;11714.355710435837;11721.4139293035;7469.327760501581;8527.786805329917;8548.401611887233;8739.694110706096;8750.518721470253;5849.502792262535;5928.294815740162;6004.459598636144;6044.304904935989;6228.283747369111;10538.599819241857;10726.088282496075;10777.245592808742;10835.079018283534;10848.945755271174;10892.61875834342;10901.83647245276;10957.452127393439;10995.615153469591;11029.117670586495;8178.877316840133;8245.95877020611;8348.7912802178;8435.578221089043;8439.578021099043;8812.64749410042;8876.733697989072;8879.733607991771;8927.018028016782;8958.68644597436;7637.083549974039;7900.091489478784;7929.801754956172;8009.55947422874;8022.9598852005365;7868.291853732962;7926.762197134095;7931.60341982887;8064.959675201587;8088.433809633269;7031.964840175767;7062.823429414306;7084.539504932163;7085.50401471892;7095.503314768123;5166.741662916915;5171.198464238049;5218.817341393033;5230.869228269324;5344.171653393731;5145.151050076845;5191.662541934762;5287.4976877196605;5412.945870541244;5436.728163591725 06:03:42 INFO - PROCESS | 21811 | |4;prototype.html;338.1984696269839;344.99655003449965;348.6287104233989;349.22820566547944;351.9560054993125;5270.552003079738;5283.841484755454;5291.1798671206025;5292.89414211716;5316.793530684766;5179.352580927384;5242.161254199329;5247.658902171365;5266.104762190427;5279.472052794728;3771.9811400943095;3930.6658933990575;3987.9601203987877;4056.8580099696514;4154.813033413504;4118.567550407209;4132.442120313749;4150.792460376969;4164.583541645841;4173.958260417403;4093.6725061995116;4116.691248156385;4133.958660413403;4137.586241375869;4152.650388623694;3932.8426862925594;3963.4451176835264;4075.49056367954;4111.814968326417;4144.730592511477;3672.5042119313816;3684.5394325709285;3695.667389934919;3697.334479793636;3700.4634328022557;5036.7733451994745;5066.240063990394;5097.745112744348;5099.898002039939;5129.461406552333;4663.673542852001;4706.846822528468;4711.104890070876;4720.362751028636;4722.669413141081;5169.7932082717025;5231.659942103789;5453.754581043862;5468.644538105011;5469.343678758534;3878.398848178537;3994.520657521087;4014.136960553466;4018.959810401917;4054.108096218827;5543.25166102575;5591.825716599519;5596.356419011825;5601.747921343549;5618.690971996539;3991.201759648082;4079.7148898097003;4085.7957102144774;4092.6725861930972;4138.710290279711;4162.687798415131;4174.686898482626;4177.143685544456;4178.8717046397305;4194.328907374806;4678.625709943196;4693.20215563355;4714.316424118552;4715.4577223619035;4721.6694831362165;5227.634065615446;5461.508464238238;5473.480019398151;5486.259354987025;5498.917516237259;1422.5703168315777;1429.8784603308627;1430.556527476465;1431.6206205355588;1434.8780353670054;950.1923365139576;959.7072892767633;977.5747549815853;982.0523195116747;983.233078199006;4735.644826638016;4750.667453278306;4795.688280261842;4858;4881.804727810919;4899.534544218293;4929.482404347564;4940.826036543909;5003.399592048904;5015.69278132056;4741.407324084489;4759.238521836559;4762.857114286577;4774.856754297377;5010.549050585465;2950.4099180163626;2957.4768993968123;2961.6001839751357;2962.881484740586;2981.38881529286;5761;5787.479126878601;5807.216025836543;5815.88368232633;5839.386864379264;5589.888202236014;5684.204211410406;5698.686572238566;5721.685307308138;5723.170140329712;5743.4256574342235;5791;5791.652500849878;5809.622374545641;5818.854528636818;5342.706151161723;5377.784888604412;5539.390667026704;5564.888702226014;5568.800323871967;5526.668399896019;5541.307336582927;5547.805826796042;5559.360673522597;5576.219329293821;5645.350784659817;5778.191053252464;5800.970995144998;5837.241158649348;5846.41535846412;4070.247004304213;4071.470708807836;4087.4890638670167;4092.69304802147;4137.627613514798;5527.723613819373;5541.833744987657;5555.638883472561;5567.498925096761;5570.8022775103545;5270.288511050959;5379.515843574097;5380.166074258496;5387.542058925035;5447.400785913625;5241.764120614505;5277.868053298698;5297.496737809902;5316.627836051439;5385.246065550904;5306.761195746123;5313.521783039545;5328.987492376436;5349.839504814861;5359.169328754049;5269.868253293698;5367.114426119647;5410.269613602113;5413.702246376487;5427.810026649048;5273.973630131824;5274.89450210986;5290.68255904647;5302.1781623848365;5319.601029922694 06:03:42 INFO - PROCESS | 21811 | |5;yui.html;779.5166996462194;779.9025121859767;838.7567605394436;840.6805413942701;874.4054043250591;15263.389464421423;15842.28709708063;16262.105584192865;16333.918330408345;16350.918245408786;15286.464973725922;15339.769903451457;15468.071915685066;15474.922625386886;15485.380584776623;677.7661706711177;799.7880561651167;816.6406781016349;820.1716266570777;829.8049958259834;824.9422540422173;833.3624777045535;833.4207725630689;836.4604829884721;837.0666706622134;873.3537182484947;874.0298268921492;876.9429987050853;876.9605367758435;877.5656050255101;686.4028295383024;814.0800894988625;841.6086519768276;867.5878957495171;867.700643278068;622.7820262907991;623.3703959001396;623.4949690750507;625.2247213455328;627.4227710506345;15426.460073897471;15508;15638.687226255524;15681.137537435436;15746.76379854303;14301.28493575317;14652.41390344385;14681;14804.40782368704;14816;13441.865581344158;13443.865561344457;13688.65778355539;13779.862201377959;13807.723845523135;4480.8879778005485;4507.076049409896;4512.390827238313;4577.633789296881;4706.411698537683;76464;77556.61221693912;77767;78176.60911695463;80033.99915002113;11641.41792910368;11942.104342174373;11947.103967202494;12057.36667430764;12611.844908393796;22454.101835926707;22456.21403250911;22501.212457563906;22559.323220303417;22589.774102259096;8469.237768600855;8727.825443491094;8737.60680769367;8844.292456603456;9000.36997410188;4800.807967681254;4806;4816.229403295526;4900.705957642553;4974.0797952378925;3507.3862074137433;3618.095476130967;3622.9637703623152;3626;3630.7276954228537;611.8898598252268;623.3174673732256;626.8620903401245;631.1479502671357;633.66732465456;654.9255653810942;690.2062627977765;700.3635930142389;717.8779607466744;725.804032911111;9302.441853488812;9568.760780980392;9922.832410387655;10035.899641003496;10110.342827716175;615.5783288447428;655.0567183256096;686.4885660183096;754.8905408715706;768.5751454162128;5047.747612619428;5159.226116082543;5195.68825870449;5331.786728530893;5345.01117293302;115822;116032;118427;119276;119331;102051.48974255081;103971.4801425988;105094;107716;108348.4582577082;61854.690726546076;91997.0800292002;92368;92500;92530.53734731283;9883.11052005323;10049.296549241482;10061.094501494901;10117.29178957466;10159.492025398553;52051.47948520466;52579.737101315775;53061.510158374476;54009.72995135156;55625.44374556203;71585.6420717893;80906.59546702229;83218.58390708007;83452;83628;12572.245665260114;12670.429830657458;12908;12938.935305323414;13068.215907045607;13845.376958036712;14137.858621414065;14238.715225695221;14449.783253251;14765.261736913326;12548.686282842637;12575.182613130117;13427.664308392368;13455;13470;12445.128840981406;12919.354032298159;13130.934345328213;13151.145175563557;14059.367328470447;13902;14270.785938210727;14640.487582934546;14710.705785884436;14739.55781326562;11260.94369528147;11367;11659.242149260272;11985.820212696992;12318.938405307916;12288.938555307166;12330.81503777462;12384.81422778641;12442.875571244535;12463.875361246271 06:03:42 INFO - PROCESS | 21811 | __end_tp_report 06:03:42 INFO - PROCESS | 21811 | __start_cc_report 06:03:42 INFO - PROCESS | 21811 | _x_x_mozilla_cycle_collect,844 06:03:42 INFO - PROCESS | 21811 | __end_cc_report 06:03:42 INFO - PROCESS | 21811 | __startTimestamp1467464622519__endTimestamp 06:03:42 INFO - PROCESS | 21811 | 06:03:42 INFO - PROCESS | 21811 | ------- Summary: start ------- 06:03:42 INFO - PROCESS | 21811 | Number of tests: 6 06:03:42 INFO - PROCESS | 21811 | 06:03:42 INFO - PROCESS | 21811 | [#0] dojo.html Cycles:165 Average:5317.64 Median:5522.06 stddev:607.87 (11.0%) stddev-sans-first:584.07 06:03:42 INFO - PROCESS | 21811 | Values: 3089.7 3094.5 3116.1 3122.8 3146.2 5196.4 5251.3 5283.2 5336.7 5352.9 5264.7 5279.3 5289.8 5316.0 5324.9 4776.2 4839.2 4861.4 4869.7 5008.1 4923.8 4979.0 4979.1 4987.4 5003.2 4698.7 4789.4 4797.8 4833.1 4893.4 4760.0 4760.6 4770.4 4804.6 4863.8 4782.5 4798.2 4843.9 4864.2 4867.6 5167.4 5264.9 5319.3 5331.9 5373.9 5743.3 5753.9 5757.7 5775.1 5778.5 5750.4 5829.7 5843.2 5843.7 5844.4 5187.6 5265.6 5338.5 5344.4 5430.9 5940.7 5944.1 5948.6 5951.9 5954.1 5412.4 5698.5 5708.2 5709.3 5712.4 5635.5 5705.2 5719.7 5798.1 5798.1 5680.6 5725.3 5731.5 5735.9 5736.7 5449.4 5562.8 5679.7 5725.8 5740.6 4365.6 4365.7 4394.9 4423.1 4434.8 3910.0 3918.4 3928.5 3928.8 3954.9 5215.8 5334.7 5393.3 5485.5 5528.1 5711.8 5751.4 5774.4 5775.9 5820.5 5507.7 5521.2 5521.3 5522.1 5522.6 4816.9 4881.4 4919.0 4980.1 5039.0 5937.5 5942.3 5949.9 5950.7 5988.6 5711.2 5719.3 5723.2 5725.3 5726.8 5711.7 5881.6 5899.0 5934.5 5975.5 5644.2 5666.9 5668.4 5674.5 5678.4 5708.1 5772.5 5777.2 5777.7 5779.2 5394.3 5542.3 5587.0 5609.2 5624.1 5604.3 5608.6 5609.3 5612.0 5615.7 5253.9 5498.6 5563.8 5564.4 5564.5 5528.4 5576.9 5590.6 5613.0 5670.8 5475.4 5488.9 5489.3 5490.5 5493.5 06:03:42 INFO - PROCESS | 21811 | 06:03:42 INFO - PROCESS | 21811 | [#1] ext.html Cycles:180 Average:59020.83 Median:42828.46 stddev:111373.71 (260.0%) stddev-sans-first:111599.80 06:03:42 INFO - PROCESS | 21811 | Values: 611.5 627.0 630.6 637.6 650.3 31243.0 34649.3 34783.3 44412.3 45638.8 46064.8 46464.5 46521.8 46526.8 46573.8 8853.4 9045.6 9078.0 9081.6 9093.4 8972.4 8975.5 9030.1 9041.3 9062.5 9069.9 9116.1 9118.7 9122.3 9125.1 9041.1 9063.7 9091.6 9092.5 9096.2 8905.6 8955.4 8964.6 8972.6 8980.1 43533.8 43935.8 43994.6 44010.6 44021.3 3445.4 3612.0 3747.4 3921.5 4141.1 33562.5 34039.0 34289.3 34412.8 35387.8 4421.2 4577.1 4614.4 4681.4 4696.8 333119.0 333334.0 334564.0 334586.0 335178.3 60184.7 60252.7 60560.0 60607.7 60686.0 64428.0 64833.4 64987.0 65015.0 65031.7 16959.3 17043.7 17181.8 17187.3 17212.1 13425.0 13426.4 13479.7 13485.4 13498.5 16567.7 18404.3 18677.2 18728.3 18849.8 5155.0 5987.4 6156.8 6208.5 6259.6 919.9 1001.3 1062.9 1091.8 1110.5 32252.5 32507.5 32588.7 33023.7 33120.7 1088.2 1114.2 1161.1 1180.9 1191.0 16994.8 17363.9 17375.4 17396.0 17471.7 498935.0 504358.0 504970.0 505847.0 507334.0 59009.4 59905.4 60021.0 60115.0 60219.4 1232.6 1318.8 1353.8 1358.7 1360.6 31576.0 33598.3 33990.7 34245.4 34387.8 51672.5 52051.2 52358.5 52484.7 52515.2 407207.0 407615.0 409560.9 409636.0 410559.0 36032.5 41441.0 42535.1 42727.8 45898.8 48843.3 49054.8 49089.0 49354.0 50210.2 42310.6 42652.0 42717.4 44122.7 44171.6 42376.0 42427.4 42929.1 43257.0 43816.3 36802.6 37545.0 37754.6 40702.4 41518.2 35441.5 37333.3 37416.3 37797.8 37911.0 27515.4 27832.2 27907.6 28075.9 28123.0 06:03:42 INFO - PROCESS | 21811 | 06:03:42 INFO - PROCESS | 21811 | [#2] jquery.html Cycles:180 Average:29817.47 Median:13683.68 stddev:83572.36 (610.7%) stddev-sans-first:83777.61 06:03:42 INFO - PROCESS | 21811 | Values: 401.7 411.1 414.3 417.0 430.3 13965.8 18544.5 20271.6 20486.6 21718.9 15912.0 18820.4 19412.0 19488.8 20000.0 5595.6 5845.5 5846.4 5850.4 5851.2 5623.5 5772.4 5812.7 5846.7 5847.1 5763.3 5793.3 5803.9 5821.6 5823.1 5556.8 5738.6 5748.3 5801.8 5807.8 5216.1 5218.0 5228.4 5236.2 5241.1 23965.9 24019.9 24279.5 24572.3 24895.6 2393.9 2454.0 2471.7 2613.7 2944.4 14696.3 15192.8 15483.8 15502.7 15868.8 1932.5 2019.2 2041.3 2051.5 2077.6 74822.6 77797.0 77889.0 82270.2 85218.6 10037.4 10066.6 10225.5 10228.2 10406.6 13918.5 13930.9 13950.0 14006.7 14036.4 8099.3 8311.7 8321.1 8329.0 8468.4 7366.9 8343.2 8414.0 8545.2 8566.9 4655.2 4804.3 4930.0 4962.3 4997.7 1996.8 2001.4 2050.6 2062.3 2071.3 909.6 989.3 1045.2 1083.9 1095.7 20260.8 20548.0 20806.5 20996.6 21161.4 926.5 962.4 992.3 1025.6 1065.3 10752.7 11074.7 11169.6 11219.3 11315.9 498150.0 506921.0 508003.0 509591.0 515481.0 88457.6 90364.0 91596.0 92785.0 95577.5 1023.3 1037.1 1040.0 1047.2 1058.5 17574.5 17675.3 17954.1 17956.6 18130.8 42069.2 42413.6 42479.6 42760.6 43900.8 59523.4 59677.4 61681.1 62062.4 62117.0 5676.7 5972.5 6985.8 8669.0 9245.6 13036.3 13800.6 14041.9 14048.2 14494.8 12429.8 12542.1 12568.6 12627.4 12813.2 12290.4 12435.9 12524.9 12540.5 12608.2 12622.9 12822.2 12907.1 12910.5 12992.8 8769.7 8777.7 8905.1 8964.0 9089.5 9060.0 11398.5 11905.3 12585.3 12608.6 06:03:42 INFO - PROCESS | 21811 | 06:03:42 INFO - PROCESS | 21811 | [#3] mootools.html Cycles:180 Average:5992.47 Median:4692.50 stddev:3501.98 (74.6%) stddev-sans-first:3495.18 06:03:42 INFO - PROCESS | 21811 | Values: 1451.7 1493.6 1597.2 1741.5 1787.2 8735.3 9338.0 9397.2 9408.4 9413.2 7814.3 8552.4 8816.7 8911.2 9130.4 2203.7 2236.4 2244.5 2246.0 2246.3 2192.0 2239.4 2241.8 2243.1 2245.3 1975.9 2152.3 2211.7 2211.9 2264.8 2223.8 2250.4 2251.5 2257.6 2269.4 2230.8 2252.1 2259.6 2263.8 2265.8 9331.0 9372.8 9399.3 9426.1 9439.0 5257.5 5349.7 5405.4 5407.9 5528.2 3216.7 3304.9 3351.5 3366.0 3385.6 1116.9 1129.2 2219.6 2263.7 2264.8 12942.4 13063.5 13095.1 13105.5 13114.1 4458.5 4542.3 4667.5 4677.6 4707.4 10200.8 10215.1 10231.2 10235.2 10236.9 5419.9 5421.1 5428.0 5431.8 5431.9 5026.7 5079.8 5084.7 5118.4 5128.6 3673.9 3755.8 3786.9 3802.0 3810.7 1075.1 1161.2 1169.1 1172.8 1180.8 814.5 875.0 886.9 952.5 977.0 5721.0 5746.5 5904.0 6071.3 6251.6 897.8 945.4 954.9 1019.2 1028.5 3881.9 4043.4 4094.5 4155.8 4195.5 11363.0 11730.7 11846.9 11848.6 11859.3 10231.7 11699.3 11714.3 11714.4 11721.4 7469.3 8527.8 8548.4 8739.7 8750.5 5849.5 5928.3 6004.5 6044.3 6228.3 10538.6 10726.1 10777.2 10835.1 10848.9 10892.6 10901.8 10957.5 10995.6 11029.1 8178.9 8246.0 8348.8 8435.6 8439.6 8812.6 8876.7 8879.7 8927.0 8958.7 7637.1 7900.1 7929.8 8009.6 8023.0 7868.3 7926.8 7931.6 8065.0 8088.4 7032.0 7062.8 7084.5 7085.5 7095.5 5166.7 5171.2 5218.8 5230.9 5344.2 5145.2 5191.7 5287.5 5412.9 5436.7 06:03:42 INFO - PROCESS | 21811 | 06:03:42 INFO - PROCESS | 21811 | [#4] prototype.html Cycles:180 Average:4564.96 Median:5174.57 stddev:1309.82 (25.3%) stddev-sans-first:1274.49 06:03:42 INFO - PROCESS | 21811 | Values: 338.2 345.0 348.6 349.2 352.0 5270.6 5283.8 5291.2 5292.9 5316.8 5179.4 5242.2 5247.7 5266.1 5279.5 3772.0 3930.7 3988.0 4056.9 4154.8 4118.6 4132.4 4150.8 4164.6 4174.0 4093.7 4116.7 4134.0 4137.6 4152.7 3932.8 3963.4 4075.5 4111.8 4144.7 3672.5 3684.5 3695.7 3697.3 3700.5 5036.8 5066.2 5097.7 5099.9 5129.5 4663.7 4706.8 4711.1 4720.4 4722.7 5169.8 5231.7 5453.8 5468.6 5469.3 3878.4 3994.5 4014.1 4019.0 4054.1 5543.3 5591.8 5596.4 5601.7 5618.7 3991.2 4079.7 4085.8 4092.7 4138.7 4162.7 4174.7 4177.1 4178.9 4194.3 4678.6 4693.2 4714.3 4715.5 4721.7 5227.6 5461.5 5473.5 5486.3 5498.9 1422.6 1429.9 1430.6 1431.6 1434.9 950.2 959.7 977.6 982.1 983.2 4735.6 4750.7 4795.7 4858.0 4881.8 4899.5 4929.5 4940.8 5003.4 5015.7 4741.4 4759.2 4762.9 4774.9 5010.5 2950.4 2957.5 2961.6 2962.9 2981.4 5761.0 5787.5 5807.2 5815.9 5839.4 5589.9 5684.2 5698.7 5721.7 5723.2 5743.4 5791.0 5791.7 5809.6 5818.9 5342.7 5377.8 5539.4 5564.9 5568.8 5526.7 5541.3 5547.8 5559.4 5576.2 5645.4 5778.2 5801.0 5837.2 5846.4 4070.2 4071.5 4087.5 4092.7 4137.6 5527.7 5541.8 5555.6 5567.5 5570.8 5270.3 5379.5 5380.2 5387.5 5447.4 5241.8 5277.9 5297.5 5316.6 5385.2 5306.8 5313.5 5329.0 5349.8 5359.2 5269.9 5367.1 5410.3 5413.7 5427.8 5274.0 5274.9 5290.7 5302.2 5319.6 06:03:42 INFO - PROCESS | 21811 | 06:03:42 INFO - PROCESS | 21811 | [#5] yui.html Cycles:180 Average:21579.56 Median:4055.81 stddev:31107.36 (767.0%) stddev-sans-first:31155.42 06:03:42 INFO - PROCESS | 21811 | Values: 779.5 779.9 838.8 840.7 874.4 15263.4 15842.3 16262.1 16333.9 16350.9 15286.5 15339.8 15468.1 15474.9 15485.4 677.8 799.8 816.6 820.2 829.8 824.9 833.4 833.4 836.5 837.1 873.4 874.0 876.9 877.0 877.6 686.4 814.1 841.6 867.6 867.7 622.8 623.4 623.5 625.2 627.4 15426.5 15508.0 15638.7 15681.1 15746.8 14301.3 14652.4 14681.0 14804.4 14816.0 13441.9 13443.9 13688.7 13779.9 13807.7 4480.9 4507.1 4512.4 4577.6 4706.4 76464.0 77556.6 77767.0 78176.6 80034.0 11641.4 11942.1 11947.1 12057.4 12611.8 22454.1 22456.2 22501.2 22559.3 22589.8 8469.2 8727.8 8737.6 8844.3 9000.4 4800.8 4806.0 4816.2 4900.7 4974.1 3507.4 3618.1 3623.0 3626.0 3630.7 611.9 623.3 626.9 631.1 633.7 654.9 690.2 700.4 717.9 725.8 9302.4 9568.8 9922.8 10035.9 10110.3 615.6 655.1 686.5 754.9 768.6 5047.7 5159.2 5195.7 5331.8 5345.0 115822.0 116032.0 118427.0 119276.0 119331.0 102051.5 103971.5 105094.0 107716.0 108348.5 61854.7 91997.1 92368.0 92500.0 92530.5 9883.1 10049.3 10061.1 10117.3 10159.5 52051.5 52579.7 53061.5 54009.7 55625.4 71585.6 80906.6 83218.6 83452.0 83628.0 12572.2 12670.4 12908.0 12938.9 13068.2 13845.4 14137.9 14238.7 14449.8 14765.3 12548.7 12575.2 13427.7 13455.0 13470.0 12445.1 12919.4 13130.9 13151.1 14059.4 13902.0 14270.8 14640.5 14710.7 14739.6 11260.9 11367.0 11659.2 11985.8 12318.9 12288.9 12330.8 12384.8 12442.9 12463.9 06:03:42 INFO - PROCESS | 21811 | -------- Summary: end -------- 06:03:42 INFO - PROCESS | 21811 | 06:03:43 INFO - TEST-INFO | 21811: exit 0 06:03:43 INFO - TEST-OK | dromaeo_css | took 1113776ms 06:03:43 INFO - TEST-START | kraken 06:03:43 INFO - operating with platform_type : linux_ 06:03:43 INFO - Initialising browser for kraken test... 06:03:43 INFO - TEST-INFO | started process 22009 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb7vQfS/profile http://localhost:57400/getInfo.html) 06:03:47 INFO - PROCESS | 22009 | __metrics Screen width/height:1600/1200 06:03:47 INFO - PROCESS | 22009 | colorDepth:24 06:03:47 INFO - PROCESS | 22009 | Browser inner width/height: 1024/697 06:03:47 INFO - PROCESS | 22009 | __metrics 06:03:48 INFO - PROCESS | 22009 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:03:49 INFO - TEST-INFO | 22009: exit 0 06:03:49 INFO - Browser initialized. 06:03:49 INFO - Running cycle 1/1 for kraken test... 06:03:49 INFO - TEST-INFO | started process 22090 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb7vQfS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:04:01 INFO - PROCESS | 22090 | RSS: Main: 156930048 06:04:01 INFO - PROCESS | 22090 | 06:04:03 INFO - PROCESS | 22090 | Cycle 1(1): loaded http://localhost:57400/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57400/tests/kraken/driver.html?testName=audio-beat-detection) 06:04:04 INFO - PROCESS | 22090 | RSS: Main: 215642112 06:04:04 INFO - PROCESS | 22090 | 06:04:06 INFO - PROCESS | 22090 | Cycle 1(1): loaded http://localhost:57400/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57400/tests/kraken/driver.html?testName=audio-dft) 06:04:07 INFO - PROCESS | 22090 | RSS: Main: 203427840 06:04:07 INFO - PROCESS | 22090 | 06:04:10 INFO - PROCESS | 22090 | Cycle 1(1): loaded http://localhost:57400/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57400/tests/kraken/driver.html?testName=audio-fft) 06:04:11 INFO - PROCESS | 22090 | RSS: Main: 268926976 06:04:11 INFO - PROCESS | 22090 | 06:04:13 INFO - PROCESS | 22090 | Cycle 1(1): loaded http://localhost:57400/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57400/tests/kraken/driver.html?testName=audio-oscillator) 06:04:13 INFO - PROCESS | 22090 | RSS: Main: 180248576 06:04:13 INFO - PROCESS | 22090 | 06:04:16 INFO - PROCESS | 22090 | Cycle 1(1): loaded http://localhost:57400/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57400/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:04:16 INFO - PROCESS | 22090 | RSS: Main: 183906304 06:04:16 INFO - PROCESS | 22090 | 06:04:19 INFO - PROCESS | 22090 | Cycle 1(1): loaded http://localhost:57400/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57400/tests/kraken/driver.html?testName=imaging-darkroom) 06:04:20 INFO - PROCESS | 22090 | RSS: Main: 218644480 06:04:20 INFO - PROCESS | 22090 | 06:04:23 INFO - PROCESS | 22090 | Cycle 1(1): loaded http://localhost:57400/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57400/tests/kraken/driver.html?testName=imaging-desaturate) 06:04:24 INFO - PROCESS | 22090 | RSS: Main: 221274112 06:04:24 INFO - PROCESS | 22090 | 06:04:27 INFO - PROCESS | 22090 | Cycle 1(1): loaded http://localhost:57400/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57400/tests/kraken/driver.html?testName=json-parse-financial) 06:04:27 INFO - PROCESS | 22090 | RSS: Main: 221761536 06:04:27 INFO - PROCESS | 22090 | 06:04:29 INFO - PROCESS | 22090 | Cycle 1(1): loaded http://localhost:57400/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57400/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:04:29 INFO - PROCESS | 22090 | RSS: Main: 208719872 06:04:29 INFO - PROCESS | 22090 | 06:04:31 INFO - PROCESS | 22090 | Cycle 1(1): loaded http://localhost:57400/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57400/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:04:32 INFO - PROCESS | 22090 | RSS: Main: 212008960 06:04:32 INFO - PROCESS | 22090 | 06:04:34 INFO - PROCESS | 22090 | Cycle 1(1): loaded http://localhost:57400/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57400/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:04:34 INFO - PROCESS | 22090 | RSS: Main: 210788352 06:04:34 INFO - PROCESS | 22090 | 06:04:37 INFO - PROCESS | 22090 | Cycle 1(1): loaded http://localhost:57400/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:04:38 INFO - PROCESS | 22090 | RSS: Main: 223125504 06:04:38 INFO - PROCESS | 22090 | 06:04:40 INFO - PROCESS | 22090 | Cycle 1(1): loaded http://localhost:57400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:04:41 INFO - PROCESS | 22090 | RSS: Main: 223285248 06:04:41 INFO - PROCESS | 22090 | 06:04:42 INFO - PROCESS | 22090 | Cycle 1(1): loaded http://localhost:57400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57400/tests/kraken/driver.html?testName=ai-astar) 06:04:43 INFO - PROCESS | 22090 | RSS: Main: 265617408 06:04:43 INFO - PROCESS | 22090 | 06:04:43 INFO - PROCESS | 22090 | __start_tp_report 06:04:43 INFO - PROCESS | 22090 | _x_x_mozilla_page_load 06:04:43 INFO - PROCESS | 22090 | _x_x_mozilla_page_load_details 06:04:43 INFO - PROCESS | 22090 | |i|pagename|runs| 06:04:43 INFO - PROCESS | 22090 | |0;ai-astar;100;110;111;111;112;110;110;110;112;110 06:04:43 INFO - PROCESS | 22090 | |1;audio-beat-detection;144;117;127;173;116;118;146;118;158;117 06:04:43 INFO - PROCESS | 22090 | |2;audio-dft;161;161;160;159;160;161;160;160;161;162 06:04:43 INFO - PROCESS | 22090 | |3;audio-fft;74;73;74;123;76;76;74;74;98;74 06:04:43 INFO - PROCESS | 22090 | |4;audio-oscillator;85;84;118;84;83;84;123;83;85;135 06:04:43 INFO - PROCESS | 22090 | |5;imaging-gaussian-blur;117;117;116;116;117;117;117;117;116;117 06:04:43 INFO - PROCESS | 22090 | |6;imaging-darkroom;145;145;155;146;146;145;147;145;146;145 06:04:43 INFO - PROCESS | 22090 | |7;imaging-desaturate;95;94;95;95;99;94;95;95;96;95 06:04:43 INFO - PROCESS | 22090 | |8;json-parse-financial;53;57;52;52;54;52;55;53;54;53 06:04:43 INFO - PROCESS | 22090 | |9;json-stringify-tinderbox;61;62;61;61;61;61;61;61;61;61 06:04:43 INFO - PROCESS | 22090 | |10;stanford-crypto-aes;79;81;74;75;84;77;81;75;77;80 06:04:43 INFO - PROCESS | 22090 | |11;stanford-crypto-ccm;126;124;126;130;120;118;128;134;161;137 06:04:43 INFO - PROCESS | 22090 | |12;stanford-crypto-pbkdf2;158;156;153;154;153;158;155;152;155;155 06:04:43 INFO - PROCESS | 22090 | |13;stanford-crypto-sha256-iterative;61;61;66;61;61;61;61;60;62;60 06:04:43 INFO - PROCESS | 22090 | __end_tp_report 06:04:43 INFO - PROCESS | 22090 | __start_cc_report 06:04:43 INFO - PROCESS | 22090 | _x_x_mozilla_cycle_collect,1682 06:04:43 INFO - PROCESS | 22090 | __end_cc_report 06:04:43 INFO - PROCESS | 22090 | __startTimestamp1467464683133__endTimestamp 06:04:43 INFO - PROCESS | 22090 | 06:04:43 INFO - PROCESS | 22090 | ------- Summary: start ------- 06:04:43 INFO - PROCESS | 22090 | Number of tests: 14 06:04:43 INFO - PROCESS | 22090 | 06:04:43 INFO - PROCESS | 22090 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.50 stddev:3.47 (3.1%) stddev-sans-first:0.87 06:04:43 INFO - PROCESS | 22090 | Values: 100.0 110.0 111.0 111.0 112.0 110.0 110.0 110.0 112.0 110.0 06:04:43 INFO - PROCESS | 22090 | 06:04:43 INFO - PROCESS | 22090 | [#1] audio-beat-detection Cycles:10 Average:133.40 Median:135.50 stddev:20.55 (15.2%) stddev-sans-first:21.43 06:04:43 INFO - PROCESS | 22090 | Values: 144.0 117.0 127.0 173.0 116.0 118.0 146.0 118.0 158.0 117.0 06:04:43 INFO - PROCESS | 22090 | 06:04:43 INFO - PROCESS | 22090 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 06:04:43 INFO - PROCESS | 22090 | Values: 161.0 161.0 160.0 159.0 160.0 161.0 160.0 160.0 161.0 162.0 06:04:43 INFO - PROCESS | 22090 | 06:04:43 INFO - PROCESS | 22090 | [#3] audio-fft Cycles:10 Average:81.60 Median:74.00 stddev:16.36 (22.1%) stddev-sans-first:17.12 06:04:43 INFO - PROCESS | 22090 | Values: 74.0 73.0 74.0 123.0 76.0 76.0 74.0 74.0 98.0 74.0 06:04:43 INFO - PROCESS | 22090 | 06:04:43 INFO - PROCESS | 22090 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:84.00 stddev:20.40 (24.3%) stddev-sans-first:21.21 06:04:43 INFO - PROCESS | 22090 | Values: 85.0 84.0 118.0 84.0 83.0 84.0 123.0 83.0 85.0 135.0 06:04:43 INFO - PROCESS | 22090 | 06:04:43 INFO - PROCESS | 22090 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 06:04:43 INFO - PROCESS | 22090 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 06:04:43 INFO - PROCESS | 22090 | 06:04:43 INFO - PROCESS | 22090 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.00 stddev:3.06 (2.1%) stddev-sans-first:3.20 06:04:43 INFO - PROCESS | 22090 | Values: 145.0 145.0 155.0 146.0 146.0 145.0 147.0 145.0 146.0 145.0 06:04:43 INFO - PROCESS | 22090 | 06:04:43 INFO - PROCESS | 22090 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:1.42 (1.5%) stddev-sans-first:1.50 06:04:43 INFO - PROCESS | 22090 | Values: 95.0 94.0 95.0 95.0 99.0 94.0 95.0 95.0 96.0 95.0 06:04:43 INFO - PROCESS | 22090 | 06:04:43 INFO - PROCESS | 22090 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:53.50 stddev:1.58 (3.0%) stddev-sans-first:1.67 06:04:43 INFO - PROCESS | 22090 | Values: 53.0 57.0 52.0 52.0 54.0 52.0 55.0 53.0 54.0 53.0 06:04:43 INFO - PROCESS | 22090 | 06:04:43 INFO - PROCESS | 22090 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 06:04:43 INFO - PROCESS | 22090 | Values: 61.0 62.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 06:04:43 INFO - PROCESS | 22090 | 06:04:43 INFO - PROCESS | 22090 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:79.50 stddev:3.23 (4.1%) stddev-sans-first:3.42 06:04:43 INFO - PROCESS | 22090 | Values: 79.0 81.0 74.0 75.0 84.0 77.0 81.0 75.0 77.0 80.0 06:04:43 INFO - PROCESS | 22090 | 06:04:43 INFO - PROCESS | 22090 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:129.00 stddev:12.20 (9.5%) stddev-sans-first:12.84 06:04:43 INFO - PROCESS | 22090 | Values: 126.0 124.0 126.0 130.0 120.0 118.0 128.0 134.0 161.0 137.0 06:04:43 INFO - PROCESS | 22090 | 06:04:43 INFO - PROCESS | 22090 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.90 Median:155.00 stddev:2.02 (1.3%) stddev-sans-first:1.81 06:04:43 INFO - PROCESS | 22090 | Values: 158.0 156.0 153.0 154.0 153.0 158.0 155.0 152.0 155.0 155.0 06:04:43 INFO - PROCESS | 22090 | 06:04:43 INFO - PROCESS | 22090 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.40 Median:61.00 stddev:1.71 (2.8%) stddev-sans-first:1.81 06:04:43 INFO - PROCESS | 22090 | Values: 61.0 61.0 66.0 61.0 61.0 61.0 61.0 60.0 62.0 60.0 06:04:43 INFO - PROCESS | 22090 | -------- Summary: end -------- 06:04:43 INFO - PROCESS | 22090 | 06:04:44 INFO - TEST-INFO | 22090: exit 0 06:04:44 INFO - TEST-OK | kraken | took 60778ms 06:04:44 INFO - SUITE-END | took 1174s 06:04:44 INFO - Completed test suite (00:19:34) 06:04:44 INFO - javascript benchmark 06:04:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3089.6910308969104, 3094.489409247473, 3116.1430606583185, 3122.7501799856013, 3146.1977195815066, 5196.350456192976, 5251.343582052244, 5283.233931079996, 5336.6531175473565, 5352.91970620441, 5264.736763161845, 5279.340082489689, 5289.841304760864, 5316.0, 5324.946750532494, 4776.164171270031, 4839.177339852234, 4861.368022157115, 4869.683470574419, 5008.073506401309, 4923.82766603169, 4979.029089327582, 4979.10376132296, 4987.426445958725, 5003.17447621142, 4698.671093023489, 4789.353437285974, 4797.7601119943865, 4833.057553777015, 4893.363862697862, 4759.952400476021, 4760.619150467989, 4770.379850619397, 4804.5916097131785, 4863.781129849165, 4782.450018247877, 4798.184308667535, 4843.903121937541, 4864.173090574611, 4867.561919427233, 5167.4057483389515, 5264.92102618461, 5319.255304257407, 5331.920021199685, 5373.919391209135, 5743.310802703661, 5753.88492230153, 5757.740901659436, 5775.104858746901, 5778.479936805707, 5750.3962083981, 5829.737661805187, 5843.2403787507355, 5843.707814609253, 5844.386339434341, 5187.584993200573, 5265.552428043621, 5338.546223571001, 5344.412114667422, 5430.945690543123, 5940.732667029907, 5944.138099975479, 5948.583599148018, 5951.880962380728, 5954.136650185699, 5412.431694672082, 5698.458646428583, 5708.20085188074, 5709.257796486513, 5712.371639119693, 5635.520980716685, 5705.1727499512335, 5719.714014299351, 5798.072308430631, 5798.072308430631, 5680.630759000652, 5725.312962444534, 5731.541476681856, 5735.913961290584, 5736.6844823534275, 5449.427810079964, 5562.833115006556, 5679.687617181012, 5725.828225153252, 5740.56945729072, 4365.585269399402, 4365.716228445141, 4394.868153955386, 4423.093265880487, 4434.778261086933, 3909.9609003910164, 3918.3730603103368, 3928.52857657083, 3928.7642741435607, 3954.9011274717786, 5215.765290561933, 5334.733263336818, 5393.325834270716, 5485.4788795064405, 5528.06022976095, 5711.771529138871, 5751.424857514216, 5774.422557744192, 5775.942240577624, 5820.505257053113, 5507.7246137692955, 5521.171824226398, 5521.309836270466, 5522.061249587579, 5522.558195344443, 4816.927746083811, 4881.438634557071, 4919.0407870464915, 4980.12847751642, 5039.0, 5937.465628093492, 5942.286925568959, 5949.881002379928, 5950.702464876739, 5988.580799344004, 5711.171880077449, 5719.3136823581435, 5723.170140329546, 5725.2843394575675, 5726.828195154152, 5711.714414279187, 5881.617694849821, 5898.970505147447, 5934.495567876779, 5975.521958243243, 5644.181593668813, 5666.858328541819, 5668.433156684298, 5674.517665998436, 5678.403767604342, 5708.115242137475, 5772.509336706259, 5777.191193232867, 5777.6822274775295, 5779.2486976694445, 5394.27177331071, 5542.334919809648, 5587.022271102622, 5609.158626206102, 5624.100143976944, 5604.271444712162, 5608.6073974823, 5609.298837645294, 5611.971940140274, 5615.747291371979, 5253.894922101613, 5498.560115190855, 5563.833085007456, 5564.387917329172, 5564.527015203753, 5528.391876893458, 5576.888462230651, 5590.552755779447, 5612.971935140298, 5670.829875103754, 5475.425080366664, 5488.890222195613, 5489.34127904654, 5490.478404551562, 5493.533049690821], "value": 5276.7277929903075, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.4649681528663, 626.9843253918652, 630.6090224061077, 637.595127094295, 650.2781912077593, 31243.0, 34649.30701385974, 34783.30433391334, 44412.33381499272, 45638.771806140925, 46064.769676151656, 46464.53535464653, 46521.83695407608, 46526.76736616321, 46573.76713116438, 8853.42452740573, 9045.638174473013, 9078.04680508547, 9081.59132839024, 9093.363464557484, 8972.416792908472, 8975.506347150904, 9030.051844556325, 9041.321900857429, 9062.546872656374, 9069.863952040725, 9116.088391160898, 9118.726438206832, 9122.270218382546, 9125.087491250855, 9041.141091596288, 9063.728088157366, 9091.636334546676, 9092.545192769192, 9096.181343679067, 8905.643774249022, 8955.37312388133, 8964.641414343483, 8972.551372431417, 8980.101989801033, 43533.782331088456, 43935.78032109819, 43994.560054399364, 44010.55989440097, 44021.33967990483, 3445.4274937550213, 3611.981940090309, 3747.4191500317493, 3921.5490218624936, 4141.109661422808, 33562.496562551336, 34039.0, 34289.31421371559, 34412.82793586041, 35387.82306088479, 4421.226285400042, 4577.1074640444795, 4614.353990441341, 4681.438227412732, 4696.812127514895, 333119.0, 333334.0, 334564.0, 334586.0, 335178.32410838036, 60184.69907650434, 60252.698736506034, 60560.0, 60607.696961515794, 60686.0, 64428.0, 64833.35166648273, 64987.0, 65015.0, 65031.67484162549, 16959.321627134777, 17043.659126817394, 17181.82818171802, 17187.31250749981, 17212.1393930303, 13425.0, 13426.395812188475, 13479.663008424868, 13485.393157307944, 13498.52755153565, 16567.73041731756, 18404.26382944694, 18677.1984202368, 18728.344507942158, 18849.81150188508, 5155.0, 5987.401259873977, 6156.815295541141, 6208.509957610231, 6259.593126446766, 919.9080091990882, 1001.3441196016621, 1062.888396718349, 1091.7543552700738, 1110.4947249001846, 32252.516212256836, 32507.512387314207, 32588.67411325904, 33023.66976330254, 33120.66879331224, 1088.1566785740956, 1114.2033446086086, 1161.1291531351487, 1180.8760080191457, 1191.0032983925892, 16994.830051699573, 17363.913180434018, 17375.391861284796, 17396.0, 17471.65056698859, 498935.0, 504358.0, 504970.0, 505847.0, 507334.0, 59009.40990590039, 59905.400945990856, 60021.0, 60115.0, 60219.39780602138, 1232.6055662188194, 1318.821959035537, 1353.7630914589906, 1358.7078778062764, 1360.5986234061174, 31576.0, 33598.328033439684, 33990.66009339875, 34245.355748427246, 34387.82806085954, 51672.48327516827, 52051.2192317108, 52358.47641523536, 52484.737576311876, 52515.212271816716, 407207.0, 407615.0, 409560.8565871455, 409636.0, 410559.0, 36032.4595131068, 41441.0, 42535.14929701327, 42727.78636106799, 45898.77050614726, 48843.26735098905, 49054.75472622614, 49089.0, 49354.0, 50210.24684629807, 42310.57689423066, 42652.0, 42717.35923961081, 44122.69079818962, 44171.558284416744, 42376.0, 42427.363589546796, 42929.141417172104, 43257.0, 43816.34275485934, 36802.63197367992, 37545.0, 37754.62245377621, 40702.389464157466, 41518.16963660649, 35441.46837797487, 37333.253334932604, 37416.251674966894, 37797.81101094587, 37911.0, 27515.44969100647, 27832.16503504898, 27907.581386279628, 28075.859620702584, 28123.015694450594], "value": 20518.342033979192, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.70073295394934, 411.09764067871, 414.2832899084584, 416.9916601667967, 430.3437258181273, 13965.790513142285, 18544.536386590342, 20271.59456810865, 20486.590268194628, 21718.89140554295, 15912.0, 18820.43538693838, 19412.0, 19488.805111948877, 20000.0, 5595.608307418473, 5845.473907348338, 5846.444587764156, 5850.385709500505, 5851.239338885939, 5623.522000629951, 5772.422757724236, 5812.709364531777, 5846.678432686201, 5847.064469684851, 5763.279590051244, 5793.304803423595, 5803.854903627401, 5821.56338274629, 5823.126531020339, 5556.805511807088, 5738.598298119134, 5748.338941021794, 5801.82594522165, 5807.796727114531, 5216.061109000379, 5217.973910130463, 5228.37259528859, 5236.21456781482, 5241.109011468022, 23965.88017059921, 24019.87990060056, 24279.514409711883, 24572.262832115066, 24895.62656560153, 2393.8922748476184, 2454.0, 2471.7281099079087, 2613.6994245661804, 2944.3522425066453, 14696.26518674062, 15192.848071519255, 15483.845161548354, 15502.689946201013, 15868.841311586968, 1932.5072106612724, 2019.1721394228296, 2041.2855500574829, 2051.476873397289, 2077.6156411064003, 74822.62588687021, 77796.99999999943, 77889.0, 82270.17729822744, 85218.57390713006, 10037.39775613451, 10066.59733610662, 10225.539850706737, 10228.232882533839, 10406.635767748245, 13918.51285205013, 13930.930345348208, 13950.0, 14006.719865602834, 14036.438542458187, 8099.311558517592, 8311.667533298722, 8321.08468068512, 8328.958355208186, 8468.44955077918, 7366.858136988775, 8343.165683431609, 8413.957930210432, 8545.230929216275, 8566.91433085661, 4655.185342565038, 4804.279358096313, 4930.0, 4962.283465349476, 4997.7251251180805, 1996.7703714073068, 2001.4295925661118, 2050.641137800879, 2062.2988184017504, 2071.2543484345624, 909.6406919266985, 989.2728844299434, 1045.2213101239624, 1083.8976561956135, 1095.7479779650726, 20260.797392025892, 20548.0, 20806.479838004172, 20996.580068398853, 21161.365159045254, 926.4904302633524, 962.4033099478369, 992.2607657295362, 1025.646152077532, 1065.3288428290127, 10752.731181720363, 11074.671039475315, 11169.609063682732, 11219.270747401393, 11315.943420282845, 498150.0, 506921.0, 508003.0, 509591.0, 515481.0, 88457.55771221232, 90364.0, 91596.0, 92785.0, 95577.522112389, 1023.3092662452964, 1037.113268155731, 1040.0, 1047.1675018360422, 1058.513083981362, 17574.472765817045, 17675.29298828084, 17954.102294884942, 17956.640867182843, 18130.818691812914, 42069.15861682688, 42413.575864240964, 42479.575204247565, 42760.57239427566, 43900.780496098596, 59523.40476595179, 59677.40322596719, 61681.07478387738, 62062.379376207464, 62117.0, 5676.7445464955, 5972.462478376967, 6985.825354366181, 8669.0, 9245.630174792934, 13036.348182590642, 13800.585982420544, 14041.92979035139, 14048.157110573398, 14494.782578261123, 12429.75140497203, 12542.12205145631, 12568.560100396808, 12627.368631568568, 12813.231206127663, 12290.446929888356, 12435.937820311203, 12524.874751252735, 12540.498380064695, 12608.180468269533, 12622.936885315881, 12822.166559173624, 12907.123633767113, 12910.483580656668, 12992.8051079232, 8769.736907892773, 8777.692780752643, 8905.064968178249, 8963.969143548575, 9089.454632722058, 9060.048694887206, 11398.487068082122, 11905.285682859056, 12585.307808070278, 12608.558700445441], "value": 9476.817096613802, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1451.6878871042727, 1493.6041948883544, 1597.2093813562287, 1741.5297869575206, 1787.213626004557, 8735.301175905928, 9337.953310233457, 9397.24822014239, 9408.388454750437, 9413.152816246537, 7814.25764552368, 8552.35857310701, 8816.691415800447, 8911.197992180703, 9130.360874738772, 2203.6804663323846, 2236.4185311818883, 2244.5286489837154, 2246.0, 2246.2699622622713, 2191.967120493186, 2239.4177513846435, 2241.7870302321253, 2243.1363924888956, 2245.3264020793695, 1975.9110840012163, 2152.3435352217566, 2211.7345918489805, 2211.8672879627193, 2264.841461097724, 2223.8332125090683, 2250.3586477853733, 2251.4821591034074, 2257.6162052451123, 2269.375921621551, 2230.7657695941853, 2252.087904398721, 2259.638457846753, 2263.7849404306567, 2265.818734501236, 9330.953345233298, 9372.765680857965, 9399.34204605678, 9426.057394260588, 9438.952805235998, 5257.474252574751, 5349.698129146073, 5405.4324295949145, 5407.945920540784, 5528.170774383834, 3216.710496055366, 3304.8843290484956, 3351.547541081947, 3365.9831700841337, 3385.5937287525408, 1116.8827273136367, 1129.181343525937, 2219.6004719150546, 2263.7283525976986, 2264.750877403484, 12942.352882355844, 13063.477460901553, 13095.148815326973, 13105.475780968749, 13114.147580407338, 4458.464984201852, 4542.295944128666, 4667.463241727177, 4677.573340131293, 4707.435107787019, 10200.795984080276, 10215.080642742189, 10231.181505479544, 10235.181185505142, 10236.897631023743, 5419.864503387447, 5421.051316019681, 5427.972860135753, 5431.782728690887, 5431.945680543223, 5026.673266237683, 5079.847604571869, 5084.720340381315, 5118.360204974379, 5128.615353848476, 3673.853045878135, 3755.8122093895195, 3786.905327366783, 3801.961980380216, 3810.657040866335, 1075.0969185883896, 1161.227783523964, 1169.0589075794067, 1172.8299396587447, 1180.7815554122515, 814.5316443045155, 875.0112373018449, 886.866969954499, 952.5094576293214, 976.9658061967797, 5721.0, 5746.454086861741, 5904.0, 6071.332153463116, 6251.562390632703, 897.7576054465258, 945.4421891084156, 954.9140577348072, 1019.2152042926905, 1028.5268776362807, 3881.9324685711654, 4043.4137050128156, 4094.5022642409167, 4155.812988415529, 4195.538490766014, 11363.0, 11730.70673233176, 11846.881531184577, 11848.644540663794, 11859.347735874437, 10231.7442063949, 11699.2980421175, 11714.297142171497, 11714.355710435837, 11721.4139293035, 7469.327760501581, 8527.786805329917, 8548.401611887233, 8739.694110706096, 8750.518721470253, 5849.502792262535, 5928.294815740162, 6004.459598636144, 6044.304904935989, 6228.283747369111, 10538.599819241857, 10726.088282496075, 10777.245592808742, 10835.079018283534, 10848.945755271174, 10892.61875834342, 10901.83647245276, 10957.452127393439, 10995.615153469591, 11029.117670586495, 8178.877316840133, 8245.95877020611, 8348.7912802178, 8435.578221089043, 8439.578021099043, 8812.64749410042, 8876.733697989072, 8879.733607991771, 8927.018028016782, 8958.68644597436, 7637.083549974039, 7900.091489478784, 7929.801754956172, 8009.55947422874, 8022.9598852005365, 7868.291853732962, 7926.762197134095, 7931.60341982887, 8064.959675201587, 8088.433809633269, 7031.964840175767, 7062.823429414306, 7084.539504932163, 7085.50401471892, 7095.503314768123, 5166.741662916915, 5171.198464238049, 5218.817341393033, 5230.869228269324, 5344.171653393731, 5145.151050076845, 5191.662541934762, 5287.4976877196605, 5412.945870541244, 5436.728163591725], "value": 4757.831262436045, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.1984696269839, 344.99655003449965, 348.6287104233989, 349.22820566547944, 351.9560054993125, 5270.552003079738, 5283.841484755454, 5291.1798671206025, 5292.89414211716, 5316.793530684766, 5179.352580927384, 5242.161254199329, 5247.658902171365, 5266.104762190427, 5279.472052794728, 3771.9811400943095, 3930.6658933990575, 3987.9601203987877, 4056.8580099696514, 4154.813033413504, 4118.567550407209, 4132.442120313749, 4150.792460376969, 4164.583541645841, 4173.958260417403, 4093.6725061995116, 4116.691248156385, 4133.958660413403, 4137.586241375869, 4152.650388623694, 3932.8426862925594, 3963.4451176835264, 4075.49056367954, 4111.814968326417, 4144.730592511477, 3672.5042119313816, 3684.5394325709285, 3695.667389934919, 3697.334479793636, 3700.4634328022557, 5036.7733451994745, 5066.240063990394, 5097.745112744348, 5099.898002039939, 5129.461406552333, 4663.673542852001, 4706.846822528468, 4711.104890070876, 4720.362751028636, 4722.669413141081, 5169.7932082717025, 5231.659942103789, 5453.754581043862, 5468.644538105011, 5469.343678758534, 3878.398848178537, 3994.520657521087, 4014.136960553466, 4018.959810401917, 4054.108096218827, 5543.25166102575, 5591.825716599519, 5596.356419011825, 5601.747921343549, 5618.690971996539, 3991.201759648082, 4079.7148898097003, 4085.7957102144774, 4092.6725861930972, 4138.710290279711, 4162.687798415131, 4174.686898482626, 4177.143685544456, 4178.8717046397305, 4194.328907374806, 4678.625709943196, 4693.20215563355, 4714.316424118552, 4715.4577223619035, 4721.6694831362165, 5227.634065615446, 5461.508464238238, 5473.480019398151, 5486.259354987025, 5498.917516237259, 1422.5703168315777, 1429.8784603308627, 1430.556527476465, 1431.6206205355588, 1434.8780353670054, 950.1923365139576, 959.7072892767633, 977.5747549815853, 982.0523195116747, 983.233078199006, 4735.644826638016, 4750.667453278306, 4795.688280261842, 4858.0, 4881.804727810919, 4899.534544218293, 4929.482404347564, 4940.826036543909, 5003.399592048904, 5015.69278132056, 4741.407324084489, 4759.238521836559, 4762.857114286577, 4774.856754297377, 5010.549050585465, 2950.4099180163626, 2957.4768993968123, 2961.6001839751357, 2962.881484740586, 2981.38881529286, 5761.0, 5787.479126878601, 5807.216025836543, 5815.88368232633, 5839.386864379264, 5589.888202236014, 5684.204211410406, 5698.686572238566, 5721.685307308138, 5723.170140329712, 5743.4256574342235, 5791.0, 5791.652500849878, 5809.622374545641, 5818.854528636818, 5342.706151161723, 5377.784888604412, 5539.390667026704, 5564.888702226014, 5568.800323871967, 5526.668399896019, 5541.307336582927, 5547.805826796042, 5559.360673522597, 5576.219329293821, 5645.350784659817, 5778.191053252464, 5800.970995144998, 5837.241158649348, 5846.41535846412, 4070.247004304213, 4071.470708807836, 4087.4890638670167, 4092.69304802147, 4137.627613514798, 5527.723613819373, 5541.833744987657, 5555.638883472561, 5567.498925096761, 5570.8022775103545, 5270.288511050959, 5379.515843574097, 5380.166074258496, 5387.542058925035, 5447.400785913625, 5241.764120614505, 5277.868053298698, 5297.496737809902, 5316.627836051439, 5385.246065550904, 5306.761195746123, 5313.521783039545, 5328.987492376436, 5349.839504814861, 5359.169328754049, 5269.868253293698, 5367.114426119647, 5410.269613602113, 5413.702246376487, 5427.810026649048, 5273.973630131824, 5274.89450210986, 5290.68255904647, 5302.1781623848365, 5319.601029922694], "value": 4157.582329273327, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [779.5166996462194, 779.9025121859767, 838.7567605394436, 840.6805413942701, 874.4054043250591, 15263.389464421423, 15842.28709708063, 16262.105584192865, 16333.918330408345, 16350.918245408786, 15286.464973725922, 15339.769903451457, 15468.071915685066, 15474.922625386886, 15485.380584776623, 677.7661706711177, 799.7880561651167, 816.6406781016349, 820.1716266570777, 829.8049958259834, 824.9422540422173, 833.3624777045535, 833.4207725630689, 836.4604829884721, 837.0666706622134, 873.3537182484947, 874.0298268921492, 876.9429987050853, 876.9605367758435, 877.5656050255101, 686.4028295383024, 814.0800894988625, 841.6086519768276, 867.5878957495171, 867.700643278068, 622.7820262907991, 623.3703959001396, 623.4949690750507, 625.2247213455328, 627.4227710506345, 15426.460073897471, 15508.0, 15638.687226255524, 15681.137537435436, 15746.76379854303, 14301.28493575317, 14652.41390344385, 14681.0, 14804.40782368704, 14816.0, 13441.865581344158, 13443.865561344457, 13688.65778355539, 13779.862201377959, 13807.723845523135, 4480.8879778005485, 4507.076049409896, 4512.390827238313, 4577.633789296881, 4706.411698537683, 76464.0, 77556.61221693912, 77767.0, 78176.60911695463, 80033.99915002113, 11641.41792910368, 11942.104342174373, 11947.103967202494, 12057.36667430764, 12611.844908393796, 22454.101835926707, 22456.21403250911, 22501.212457563906, 22559.323220303417, 22589.774102259096, 8469.237768600855, 8727.825443491094, 8737.60680769367, 8844.292456603456, 9000.36997410188, 4800.807967681254, 4806.0, 4816.229403295526, 4900.705957642553, 4974.0797952378925, 3507.3862074137433, 3618.095476130967, 3622.9637703623152, 3626.0, 3630.7276954228537, 611.8898598252268, 623.3174673732256, 626.8620903401245, 631.1479502671357, 633.66732465456, 654.9255653810942, 690.2062627977765, 700.3635930142389, 717.8779607466744, 725.804032911111, 9302.441853488812, 9568.760780980392, 9922.832410387655, 10035.899641003496, 10110.342827716175, 615.5783288447428, 655.0567183256096, 686.4885660183096, 754.8905408715706, 768.5751454162128, 5047.747612619428, 5159.226116082543, 5195.68825870449, 5331.786728530893, 5345.01117293302, 115822.0, 116032.0, 118427.0, 119276.0, 119331.0, 102051.48974255081, 103971.4801425988, 105094.0, 107716.0, 108348.4582577082, 61854.690726546076, 91997.0800292002, 92368.0, 92500.0, 92530.53734731283, 9883.11052005323, 10049.296549241482, 10061.094501494901, 10117.29178957466, 10159.492025398553, 52051.47948520466, 52579.737101315775, 53061.510158374476, 54009.72995135156, 55625.44374556203, 71585.6420717893, 80906.59546702229, 83218.58390708007, 83452.0, 83628.0, 12572.245665260114, 12670.429830657458, 12908.0, 12938.935305323414, 13068.215907045607, 13845.376958036712, 14137.858621414065, 14238.715225695221, 14449.783253251, 14765.261736913326, 12548.686282842637, 12575.182613130117, 13427.664308392368, 13455.0, 13470.0, 12445.128840981406, 12919.354032298159, 13130.934345328213, 13151.145175563557, 14059.367328470447, 13902.0, 14270.785938210727, 14640.487582934546, 14710.705785884436, 14739.55781326562, 11260.94369528147, 11367.0, 11659.242149260272, 11985.820212696992, 12318.938405307916, 12288.938555307166, 12330.81503777462, 12384.81422778641, 12442.875571244535, 12463.875361246271], "value": 7801.741938541855, "unit": "score"}], "name": "dromaeo_css", "value": 7355.45527780323, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 111.0, 111.0, 112.0, 110.0, 110.0, 110.0, 112.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 117.0, 127.0, 173.0, 116.0, 118.0, 146.0, 118.0, 158.0, 117.0], "value": 133.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 159.0, 160.0, 161.0, 160.0, 160.0, 161.0, 162.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 123.0, 76.0, 76.0, 74.0, 74.0, 98.0, 74.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 118.0, 84.0, 83.0, 84.0, 123.0, 83.0, 85.0, 135.0], "value": 96.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 155.0, 146.0, 146.0, 145.0, 147.0, 145.0, 146.0, 145.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 99.0, 94.0, 95.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 57.0, 52.0, 52.0, 54.0, 52.0, 55.0, 53.0, 54.0, 53.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 74.0, 75.0, 84.0, 77.0, 81.0, 75.0, 77.0, 80.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 124.0, 126.0, 130.0, 120.0, 118.0, 128.0, 134.0, 161.0, 137.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 156.0, 153.0, 154.0, 153.0, 158.0, 155.0, 152.0, 155.0, 155.0], "value": 154.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 66.0, 61.0, 61.0, 61.0, 61.0, 60.0, 62.0, 60.0], "value": 61.4, "unit": "score"}], "name": "kraken", "value": 1479.6000000000001, "alertThreshold": 2.0}]} 06:04:44 INFO - Return code: 0 06:04:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:04:44 INFO - # TBPL SUCCESS # 06:04:44 INFO - Running post-action listener: _resource_record_post_action 06:04:44 INFO - ##### 06:04:44 INFO - ##### Finished run-tests step (success) 06:04:44 INFO - ##### 06:04:44 INFO - Running post-run listener: _resource_record_post_run 06:04:44 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 12288; Write bytes: 552005632; Read time: 236; Write time: 451612 06:04:44 INFO - TinderboxPrint: CPU usage
13.0% 06:04:44 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 236 06:04:44 INFO - TinderboxPrint: I/O write bytes / time
552,005,632 / 451,612 06:04:44 INFO - TinderboxPrint: CPU idle
8,274.8 (87.0%) 06:04:44 INFO - TinderboxPrint: CPU user
1,197.5 (12.6%) 06:04:44 INFO - TinderboxPrint: Swap in / out
0 / 0 06:04:44 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256520192; Read time: 0; Write time: 247500 06:04:44 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 295485440; Read time: 228; Write time: 204112 06:04:45 INFO - Running post-run listener: _upload_blobber_files 06:04:45 INFO - Blob upload gear active. 06:04:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:04:45 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:04:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:04:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:04:45 INFO - (blobuploader) - INFO - Open directory for files ... 06:04:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:04:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:04:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:04:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:04:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:04:48 INFO - (blobuploader) - INFO - Done attempting. 06:04:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:04:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:04:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:04:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:04:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:04:49 INFO - (blobuploader) - INFO - Done attempting. 06:04:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:04:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:04:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:04:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:04:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:04:50 INFO - (blobuploader) - INFO - Done attempting. 06:04:50 INFO - (blobuploader) - INFO - Iteration through files over. 06:04:50 INFO - Return code: 0 06:04:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:04:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:04:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/478acedd7ab7d2a7d83ee43b81fb9117258d76986b9d820251948fcac6c73314d378bcc4cedd30076619bf5db19f5ce484b696b962ca05f94aa7836408e8dbf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d64500fd8f6298a164890192b7a31bfc480981e32e5977ba497231e7a88861928c1bf9b1c4bb403d491c19aaad195f18eda18e301c664b7ff4daa9f6ea30900c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/489e3011d9e519a7d18660acd1438f2e1e0f6ebe0d56e70bf68aa4c376fe6c1d2a82fcf0164d491a831820aff0842f95e20753ed4a41f3f658bb3ae7a2bb664a"} 06:04:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:04:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:04:50 INFO - Contents: 06:04:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/478acedd7ab7d2a7d83ee43b81fb9117258d76986b9d820251948fcac6c73314d378bcc4cedd30076619bf5db19f5ce484b696b962ca05f94aa7836408e8dbf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d64500fd8f6298a164890192b7a31bfc480981e32e5977ba497231e7a88861928c1bf9b1c4bb403d491c19aaad195f18eda18e301c664b7ff4daa9f6ea30900c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/489e3011d9e519a7d18660acd1438f2e1e0f6ebe0d56e70bf68aa4c376fe6c1d2a82fcf0164d491a831820aff0842f95e20753ed4a41f3f658bb3ae7a2bb664a"} 06:04:50 INFO - Running post-run listener: copy_logs_to_upload_dir 06:04:50 INFO - Copying logs to upload dir... 06:04:50 INFO - mkdir: /builds/slave/test/build/upload/logs 06:04:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.419986 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-02 06:04:50.145437) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 06:04:50.149010) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/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/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1467462932.148651-1816808426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/478acedd7ab7d2a7d83ee43b81fb9117258d76986b9d820251948fcac6c73314d378bcc4cedd30076619bf5db19f5ce484b696b962ca05f94aa7836408e8dbf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d64500fd8f6298a164890192b7a31bfc480981e32e5977ba497231e7a88861928c1bf9b1c4bb403d491c19aaad195f18eda18e301c664b7ff4daa9f6ea30900c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/489e3011d9e519a7d18660acd1438f2e1e0f6ebe0d56e70bf68aa4c376fe6c1d2a82fcf0164d491a831820aff0842f95e20753ed4a41f3f658bb3ae7a2bb664a"} build_url:https://queue.taskcluster.net/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011261 build_url: 'https://queue.taskcluster.net/v1/task/DpNK1i3-QyOEGOtx0EOLpw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/478acedd7ab7d2a7d83ee43b81fb9117258d76986b9d820251948fcac6c73314d378bcc4cedd30076619bf5db19f5ce484b696b962ca05f94aa7836408e8dbf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d64500fd8f6298a164890192b7a31bfc480981e32e5977ba497231e7a88861928c1bf9b1c4bb403d491c19aaad195f18eda18e301c664b7ff4daa9f6ea30900c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/489e3011d9e519a7d18660acd1438f2e1e0f6ebe0d56e70bf68aa4c376fe6c1d2a82fcf0164d491a831820aff0842f95e20753ed4a41f3f658bb3ae7a2bb664a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 06:04:50.174603) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 06:04:50.175006) ========= rm -f oauth.txt in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1467462932.148651-1816808426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004410 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 06:04:50.260468) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 06:04:50.260805) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 06:04:50.261123) ========= ========= Total master_lag: 0.20 =========