builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1468610553.52 results: success (0) buildid: 20160715101141 builduid: 50549330086b48858b6fc7a95a576471 revision: df9a54d23bbcdd005266f61f85239fe9bebf386e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 12:22:33.517882) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 12:22:33.518331) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 12:22:33.518596) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 12:22:33.530129) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:22:33.530384) ========= 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=6dbc10da6d83fee962c624be000001a8-1468610552.322440-878699086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-15 12:22:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2016-07-15 12:22:34 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157792 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:22:33.699678) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:22:33.699998) ========= 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=6dbc10da6d83fee962c624be000001a8-1468610552.322440-878699086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018982 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:22:33.749753) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:22:33.750103) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev df9a54d23bbcdd005266f61f85239fe9bebf386e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev df9a54d23bbcdd005266f61f85239fe9bebf386e --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=6dbc10da6d83fee962c624be000001a8-1468610552.322440-878699086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-15 12:22:34,123 truncating revision to first 12 chars 2016-07-15 12:22:34,124 Setting DEBUG logging. 2016-07-15 12:22:34,124 attempt 1/10 2016-07-15 12:22:34,124 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/df9a54d23bbc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 12:22:34,452 unpacking tar archive at: mozilla-inbound-df9a54d23bbc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.760656 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:22:34.523985) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 12:22:34.524296) ========= script_repo_revision: df9a54d23bbcdd005266f61f85239fe9bebf386e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 12:22:34.524666) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 12:22:34.524933) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 12:22:34.533638) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-15 12:22:34.533895) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=6dbc10da6d83fee962c624be000001a8-1468610552.322440-878699086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:22:34 INFO - MultiFileLogger online at 20160715 12:22:34 in /builds/slave/test 12:22:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 12:22:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:22:34 INFO - {'append_to_log': False, 12:22:34 INFO - 'base_work_dir': '/builds/slave/test', 12:22:34 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 12:22:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:22:34 INFO - 'branch': 'Mozilla-Inbound', 12:22:34 INFO - 'buildbot_json_path': 'buildprops.json', 12:22:34 INFO - 'config_files': ('talos/linux_config.py',), 12:22:34 INFO - 'default_actions': ('clobber', 12:22:34 INFO - 'read-buildbot-config', 12:22:34 INFO - 'download-and-extract', 12:22:34 INFO - 'populate-webroot', 12:22:34 INFO - 'create-virtualenv', 12:22:34 INFO - 'install', 12:22:34 INFO - 'run-tests'), 12:22:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:22:34 INFO - 'download_minidump_stackwalk': True, 12:22:34 INFO - 'download_symbols': 'ondemand', 12:22:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:22:34 INFO - 'tooltool.py': '/tools/tooltool.py', 12:22:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:22:34 INFO - '/tools/misc-python/virtualenv.py')}, 12:22:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:22:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:22:34 INFO - 'installer_path': 'installer.exe', 12:22:34 INFO - 'log_level': 'info', 12:22:34 INFO - 'log_name': 'talos', 12:22:34 INFO - 'log_to_console': True, 12:22:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:22:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:22:34 INFO - 'opt_config_files': (), 12:22:35 INFO - 'pip_index': False, 12:22:35 INFO - 'sps_profile': False, 12:22:35 INFO - 'sps_profile_interval': 0, 12:22:35 INFO - 'suite': 'dromaeojs', 12:22:35 INFO - 'system_bits': '32', 12:22:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:22:35 INFO - 'title': 'talos-linux64-ix-050', 12:22:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:22:35 INFO - 'use_talos_json': True, 12:22:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:22:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:22:35 INFO - 'work_dir': 'build'} 12:22:35 INFO - ##### 12:22:35 INFO - ##### Running clobber step. 12:22:35 INFO - ##### 12:22:35 INFO - Running pre-action listener: _resource_record_pre_action 12:22:35 INFO - Running main action method: clobber 12:22:35 INFO - rmtree: /builds/slave/test/build 12:22:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:22:35 INFO - Running post-action listener: _resource_record_post_action 12:22:35 INFO - ##### 12:22:35 INFO - ##### Finished clobber step (success) 12:22:35 INFO - ##### 12:22:35 INFO - ##### 12:22:35 INFO - ##### Running read-buildbot-config step. 12:22:35 INFO - ##### 12:22:35 INFO - Running pre-action listener: _resource_record_pre_action 12:22:35 INFO - Running main action method: read_buildbot_config 12:22:35 INFO - Using buildbot properties: 12:22:35 INFO - { 12:22:35 INFO - "project": "", 12:22:35 INFO - "product": "firefox", 12:22:35 INFO - "script_repo_revision": "production", 12:22:35 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 12:22:35 INFO - "repository": "", 12:22:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 12:22:35 INFO - "buildid": "20160715101141", 12:22:35 INFO - "pgo_build": "True", 12:22:35 INFO - "basedir": "/builds/slave/test", 12:22:35 INFO - "buildnumber": 1346, 12:22:35 INFO - "slavename": "talos-linux64-ix-050", 12:22:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:22:35 INFO - "platform": "ubuntu64_hw", 12:22:35 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 12:22:35 INFO - "branch": "mozilla-inbound", 12:22:35 INFO - "repo_path": "integration/mozilla-inbound", 12:22:35 INFO - "revision": "df9a54d23bbcdd005266f61f85239fe9bebf386e", 12:22:35 INFO - "stage_platform": "linux64-pgo", 12:22:35 INFO - "builduid": "50549330086b48858b6fc7a95a576471", 12:22:35 INFO - "slavebuilddir": "test" 12:22:35 INFO - } 12:22:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 12:22:35 INFO - Running post-action listener: _resource_record_post_action 12:22:35 INFO - ##### 12:22:35 INFO - ##### Finished read-buildbot-config step (success) 12:22:35 INFO - ##### 12:22:35 INFO - ##### 12:22:35 INFO - ##### Running download-and-extract step. 12:22:35 INFO - ##### 12:22:35 INFO - Running pre-action listener: _resource_record_pre_action 12:22:35 INFO - Running main action method: download_and_extract 12:22:35 INFO - mkdir: /builds/slave/test/build/tests 12:22: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')]} 12:22:35 INFO - https://queue.taskcluster.net/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:22:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:22:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:22:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/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 12:22:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/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 12:22:36 INFO - Downloaded 1361 bytes. 12:22:36 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:22:36 INFO - Using the following test package requirements: 12:22:36 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:22:36 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:22:36 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:22:36 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:36 INFO - u'jsshell-linux-x86_64.zip'], 12:22:36 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:22:36 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:22:36 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:22:36 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:22:36 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:22:36 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:22:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:22:36 INFO - https://queue.taskcluster.net/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:22:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:22:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:22:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/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 12:22:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/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 12:22:37 INFO - Downloaded 24304719 bytes. 12:22:37 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'] 12:22:37 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 12:22:38 INFO - Return code: 0 12:22:38 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 12:22: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')]} 12:22:38 INFO - https://queue.taskcluster.net/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:22:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:22:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:22:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/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 12:22:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/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 12:22:40 INFO - Downloaded 24304719 bytes. 12:22:40 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'] 12:22:40 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 12:22:41 INFO - Return code: 0 12:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:22:41 INFO - https://queue.taskcluster.net/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:22:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:22:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:22:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/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 12:22:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/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 12:22:42 INFO - Downloaded 14403333 bytes. 12:22:42 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'] 12:22:42 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 12:22:42 INFO - Return code: 0 12:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:22:42 INFO - https://queue.taskcluster.net/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:22:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:22:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:22:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/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 12:22:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/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 12:22:44 INFO - Downloaded 60444014 bytes. 12:22:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:22:44 INFO - mkdir: /builds/slave/test/properties 12:22:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:22:44 INFO - Writing to file /builds/slave/test/properties/build_url 12:22:44 INFO - Contents: 12:22:44 INFO - build_url:https://queue.taskcluster.net/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:22:45 INFO - Running post-action listener: _resource_record_post_action 12:22:45 INFO - Running post-action listener: set_extra_try_arguments 12:22:45 INFO - ##### 12:22:45 INFO - ##### Finished download-and-extract step (success) 12:22:45 INFO - ##### 12:22:45 INFO - ##### 12:22:45 INFO - ##### Running populate-webroot step. 12:22:45 INFO - ##### 12:22:45 INFO - Running pre-action listener: _resource_record_pre_action 12:22:45 INFO - Running main action method: populate_webroot 12:22:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:22:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:22:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:22:45 INFO - '--tppagecycles', 12:22:45 INFO - '7'], 12:22:45 INFO - 'tests': ['tsvgm']}}, 12:22:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:22:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:22:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:22:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:22:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:22:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:22:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:22:45 INFO - 'talos_options': ['--disable-e10s'], 12:22:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:22:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:22:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:22:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:22:45 INFO - 'talos_options': ['--disable-e10s'], 12:22:45 INFO - 'tests': ['damp', 'tps']}, 12:22:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:22:45 INFO - 'tests': ['damp', 'tps']}, 12:22:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:22:45 INFO - 'tests': ['dromaeo_dom']}, 12:22:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:22:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:22:45 INFO - 'tests': ['basic_compositor_video']}, 12:22:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:22:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:22:45 INFO - 'tests': ['a11yr', 12:22:45 INFO - 'ts_paint', 12:22:45 INFO - 'tpaint', 12:22:45 INFO - 'sessionrestore', 12:22:45 INFO - 'sessionrestore_no_auto_restore', 12:22:45 INFO - 'tabpaint']}, 12:22:45 INFO - 'other-e10s': {'tests': ['a11yr', 12:22:45 INFO - 'ts_paint', 12:22:45 INFO - 'tpaint', 12:22:45 INFO - 'sessionrestore', 12:22:45 INFO - 'sessionrestore_no_auto_restore', 12:22:45 INFO - 'tabpaint']}, 12:22:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:22:45 INFO - 'ts_paint', 12:22:45 INFO - 'tpaint', 12:22:45 INFO - 'sessionrestore', 12:22:45 INFO - 'sessionrestore_no_auto_restore', 12:22:45 INFO - 'tabpaint']}, 12:22:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:22:45 INFO - 'ts_paint', 12:22:45 INFO - 'tpaint', 12:22:45 INFO - 'sessionrestore', 12:22:45 INFO - 'sessionrestore_no_auto_restore', 12:22:45 INFO - 'tabpaint']}, 12:22:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:22:45 INFO - 'tests': ['a11yr', 12:22:45 INFO - 'ts_paint', 12:22:45 INFO - 'tpaint', 12:22:45 INFO - 'sessionrestore', 12:22:45 INFO - 'sessionrestore_no_auto_restore', 12:22:45 INFO - 'tabpaint']}, 12:22:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:22:45 INFO - 'tests': ['a11yr', 12:22:45 INFO - 'ts_paint', 12:22:45 INFO - 'tpaint', 12:22:45 INFO - 'sessionrestore', 12:22:45 INFO - 'sessionrestore_no_auto_restore', 12:22:45 INFO - 'tabpaint']}, 12:22:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:22:45 INFO - 'tests': ['tsvgx', 12:22:45 INFO - 'tsvgr_opacity', 12:22:45 INFO - 'tart', 12:22:45 INFO - 'tscrollx', 12:22:45 INFO - 'cart']}, 12:22:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:22:45 INFO - 'tsvgr_opacity', 12:22:45 INFO - 'tart', 12:22:45 INFO - 'tscrollx', 12:22:45 INFO - 'cart']}, 12:22:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:22:45 INFO - 'talos_options': ['--disable-e10s'], 12:22:45 INFO - 'tests': ['tp5o']}, 12:22:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:22:45 INFO - 'tests': ['tp5o']}, 12:22:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:22:45 INFO - 'talos_options': ['--disable-e10s', 12:22:45 INFO - '--xperf_path', 12:22:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:22:45 INFO - 'tests': ['tp5n']}, 12:22:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:22:45 INFO - 'talos_options': ['--xperf_path', 12:22:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:22:45 INFO - 'tests': ['tp5n']}}, 12:22:45 INFO - 'talos.zip': {'path': '', 12:22:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:22:45 INFO - Running post-action listener: _resource_record_post_action 12:22:45 INFO - ##### 12:22:45 INFO - ##### Finished populate-webroot step (success) 12:22:45 INFO - ##### 12:22:45 INFO - ##### 12:22:45 INFO - ##### Running create-virtualenv step. 12:22:45 INFO - ##### 12:22:45 INFO - Running pre-action listener: _resource_record_pre_action 12:22:45 INFO - Running main action method: create_virtualenv 12:22:45 INFO - Creating virtualenv /builds/slave/test/build/venv 12:22:45 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 12:22:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:22:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:22:45 INFO - Using real prefix '/usr' 12:22:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:22:45 INFO - Installing distribute.............................................................................................................................................................................................done. 12:22:47 INFO - Installing pip.................done. 12:22:47 INFO - Return code: 0 12:22:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:22: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')]} 12:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22: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')]} 12:22:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:47 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 0x24d2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2793180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27913b0>, '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 0x27922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2792740>, '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': '6dbc10da6d83fee962c624be000001a8-1468610552.322440-878699086', '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 12:22:47 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 12:22:47 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 12:22:47 INFO - Using env: {'DISPLAY': ':0', 12:22:47 INFO - 'HOME': '/home/cltbld', 12:22:47 INFO - 'LANG': 'en_US.UTF-8', 12:22:47 INFO - 'LANGUAGE': 'en_US:en', 12:22:47 INFO - 'LOGNAME': 'cltbld', 12:22:47 INFO - 'MAIL': '/var/mail/cltbld', 12:22:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:47 INFO - 'MOZ_NO_REMOTE': '1', 12:22:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:47 INFO - 'NO_EM_RESTART': '1', 12:22:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:47 INFO - 'PWD': '/builds/slave/test', 12:22:47 INFO - 'SHELL': '/bin/bash', 12:22:47 INFO - 'SHLVL': '1', 12:22:47 INFO - 'TERM': 'linux', 12:22:47 INFO - 'TMOUT': '86400', 12:22:47 INFO - 'USER': 'cltbld', 12:22:47 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468610552.322440-878699086', 12:22:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:47 INFO - '_': '/tools/buildbot/bin/python'} 12:22:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:22:47 INFO - Cleaning up... 12:22:47 INFO - Return code: 0 12:22:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:22: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')]} 12:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22: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')]} 12:22:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:47 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 0x24d2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2793180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27913b0>, '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 0x27922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2792740>, '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': '6dbc10da6d83fee962c624be000001a8-1468610552.322440-878699086', '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 12:22:47 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 12:22:47 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 12:22:47 INFO - Using env: {'DISPLAY': ':0', 12:22:47 INFO - 'HOME': '/home/cltbld', 12:22:47 INFO - 'LANG': 'en_US.UTF-8', 12:22:47 INFO - 'LANGUAGE': 'en_US:en', 12:22:47 INFO - 'LOGNAME': 'cltbld', 12:22:47 INFO - 'MAIL': '/var/mail/cltbld', 12:22:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:47 INFO - 'MOZ_NO_REMOTE': '1', 12:22:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:47 INFO - 'NO_EM_RESTART': '1', 12:22:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:47 INFO - 'PWD': '/builds/slave/test', 12:22:47 INFO - 'SHELL': '/bin/bash', 12:22:47 INFO - 'SHLVL': '1', 12:22:47 INFO - 'TERM': 'linux', 12:22:47 INFO - 'TMOUT': '86400', 12:22:47 INFO - 'USER': 'cltbld', 12:22:47 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468610552.322440-878699086', 12:22:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:47 INFO - '_': '/tools/buildbot/bin/python'} 12:22:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:48 INFO - Downloading/unpacking psutil>=3.1.1 12:22: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 12:22: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 12:22: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 12:22: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 12:22: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 12:22: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 12:22:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:22:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:22:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:22:50 INFO - Installing collected packages: psutil 12:22:50 INFO - Running setup.py install for psutil 12:22:50 INFO - building 'psutil._psutil_linux' extension 12:22:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:22:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:22:50 INFO - building 'psutil._psutil_posix' extension 12:22:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:22:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:22:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:22:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:22:50 INFO - Successfully installed psutil 12:22:50 INFO - Cleaning up... 12:22:50 INFO - Return code: 0 12:22:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:50 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 0x24d2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2793180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27913b0>, '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 0x27922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2792740>, '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': '6dbc10da6d83fee962c624be000001a8-1468610552.322440-878699086', '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 12:22:50 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 12:22:50 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 12:22:50 INFO - Using env: {'DISPLAY': ':0', 12:22:50 INFO - 'HOME': '/home/cltbld', 12:22:50 INFO - 'LANG': 'en_US.UTF-8', 12:22:50 INFO - 'LANGUAGE': 'en_US:en', 12:22:50 INFO - 'LOGNAME': 'cltbld', 12:22:50 INFO - 'MAIL': '/var/mail/cltbld', 12:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:50 INFO - 'MOZ_NO_REMOTE': '1', 12:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:50 INFO - 'NO_EM_RESTART': '1', 12:22:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:50 INFO - 'PWD': '/builds/slave/test', 12:22:50 INFO - 'SHELL': '/bin/bash', 12:22:50 INFO - 'SHLVL': '1', 12:22:50 INFO - 'TERM': 'linux', 12:22:50 INFO - 'TMOUT': '86400', 12:22:50 INFO - 'USER': 'cltbld', 12:22:50 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468610552.322440-878699086', 12:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:50 INFO - '_': '/tools/buildbot/bin/python'} 12:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:22:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:22:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:22:52 INFO - Installing collected packages: mozsystemmonitor 12:22:52 INFO - Running setup.py install for mozsystemmonitor 12:22:52 INFO - Successfully installed mozsystemmonitor 12:22:52 INFO - Cleaning up... 12:22:53 INFO - Return code: 0 12:22:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:53 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 0x24d2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2793180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27913b0>, '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 0x27922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2792740>, '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': '6dbc10da6d83fee962c624be000001a8-1468610552.322440-878699086', '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 12:22:53 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 12:22:53 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 12:22:53 INFO - Using env: {'DISPLAY': ':0', 12:22:53 INFO - 'HOME': '/home/cltbld', 12:22:53 INFO - 'LANG': 'en_US.UTF-8', 12:22:53 INFO - 'LANGUAGE': 'en_US:en', 12:22:53 INFO - 'LOGNAME': 'cltbld', 12:22:53 INFO - 'MAIL': '/var/mail/cltbld', 12:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:53 INFO - 'MOZ_NO_REMOTE': '1', 12:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:53 INFO - 'NO_EM_RESTART': '1', 12:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:53 INFO - 'PWD': '/builds/slave/test', 12:22:53 INFO - 'SHELL': '/bin/bash', 12:22:53 INFO - 'SHLVL': '1', 12:22:53 INFO - 'TERM': 'linux', 12:22:53 INFO - 'TMOUT': '86400', 12:22:53 INFO - 'USER': 'cltbld', 12:22:53 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468610552.322440-878699086', 12:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:53 INFO - '_': '/tools/buildbot/bin/python'} 12:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:53 INFO - Downloading/unpacking jsonschema==2.5.1 12:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:22:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:55 INFO - Downloading functools32-3.2.3-2.tar.gz 12:22:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:22:55 INFO - warning: no files found matching '*.txt' 12:22:55 INFO - no previously-included directories found matching 'build' 12:22:55 INFO - no previously-included directories found matching 'dist' 12:22:55 INFO - no previously-included directories found matching '.git*' 12:22:55 INFO - Installing collected packages: jsonschema, functools32 12:22:55 INFO - Running setup.py install for functools32 12:22:55 INFO - warning: no files found matching '*.txt' 12:22:55 INFO - no previously-included directories found matching 'build' 12:22:55 INFO - no previously-included directories found matching 'dist' 12:22:55 INFO - no previously-included directories found matching '.git*' 12:22:55 INFO - Successfully installed jsonschema functools32 12:22:55 INFO - Cleaning up... 12:22:55 INFO - Return code: 0 12:22:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:55 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 0x24d2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2793180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27913b0>, '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 0x27922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2792740>, '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': '6dbc10da6d83fee962c624be000001a8-1468610552.322440-878699086', '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 12:22:55 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 12:22:55 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 12:22:55 INFO - Using env: {'DISPLAY': ':0', 12:22:55 INFO - 'HOME': '/home/cltbld', 12:22:55 INFO - 'LANG': 'en_US.UTF-8', 12:22:55 INFO - 'LANGUAGE': 'en_US:en', 12:22:55 INFO - 'LOGNAME': 'cltbld', 12:22:55 INFO - 'MAIL': '/var/mail/cltbld', 12:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:55 INFO - 'MOZ_NO_REMOTE': '1', 12:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:55 INFO - 'NO_EM_RESTART': '1', 12:22:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:55 INFO - 'PWD': '/builds/slave/test', 12:22:55 INFO - 'SHELL': '/bin/bash', 12:22:55 INFO - 'SHLVL': '1', 12:22:55 INFO - 'TERM': 'linux', 12:22:55 INFO - 'TMOUT': '86400', 12:22:55 INFO - 'USER': 'cltbld', 12:22:55 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468610552.322440-878699086', 12:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:55 INFO - '_': '/tools/buildbot/bin/python'} 12:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:55 INFO - Downloading/unpacking blobuploader==1.2.4 12:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:57 INFO - Downloading blobuploader-1.2.4.tar.gz 12:22:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:22:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:22:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:58 INFO - Downloading docopt-0.6.1.tar.gz 12:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:22:58 INFO - Installing collected packages: blobuploader, requests, docopt 12:22:58 INFO - Running setup.py install for blobuploader 12:22:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:22:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:22:58 INFO - Running setup.py install for requests 12:22:59 INFO - Running setup.py install for docopt 12:22:59 INFO - Successfully installed blobuploader requests docopt 12:22:59 INFO - Cleaning up... 12:22:59 INFO - Return code: 0 12:22:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:22:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:22:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:59 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 0x24d2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2793180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27913b0>, '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 0x27922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2792740>, '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': '6dbc10da6d83fee962c624be000001a8-1468610552.322440-878699086', '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 12:22:59 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 12:22:59 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 12:22:59 INFO - Using env: {'DISPLAY': ':0', 12:22:59 INFO - 'HOME': '/home/cltbld', 12:22:59 INFO - 'LANG': 'en_US.UTF-8', 12:22:59 INFO - 'LANGUAGE': 'en_US:en', 12:22:59 INFO - 'LOGNAME': 'cltbld', 12:22:59 INFO - 'MAIL': '/var/mail/cltbld', 12:22:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:59 INFO - 'MOZ_NO_REMOTE': '1', 12:22:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:59 INFO - 'NO_EM_RESTART': '1', 12:22:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:59 INFO - 'PWD': '/builds/slave/test', 12:22:59 INFO - 'SHELL': '/bin/bash', 12:22:59 INFO - 'SHLVL': '1', 12:22:59 INFO - 'TERM': 'linux', 12:22:59 INFO - 'TMOUT': '86400', 12:22:59 INFO - 'USER': 'cltbld', 12:22:59 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468610552.322440-878699086', 12:22:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:59 INFO - '_': '/tools/buildbot/bin/python'} 12:22:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:22:59 INFO - Running setup.py (path:/tmp/pip-1WO74g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:22:59 INFO - Running setup.py (path:/tmp/pip-0I2Ll5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:22:59 INFO - Running setup.py (path:/tmp/pip-w8TgSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:22:59 INFO - Running setup.py (path:/tmp/pip-RxBes3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:22:59 INFO - Running setup.py (path:/tmp/pip-hOw8_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:22:59 INFO - Running setup.py (path:/tmp/pip-eeF6J3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:22:59 INFO - Running setup.py (path:/tmp/pip-8Lx9tm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:22:59 INFO - Running setup.py (path:/tmp/pip-lKTpEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:22:59 INFO - Running setup.py (path:/tmp/pip-9WnKYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:22:59 INFO - Running setup.py (path:/tmp/pip-PZQgun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:23:00 INFO - Running setup.py (path:/tmp/pip-aTkAXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:23:00 INFO - Running setup.py (path:/tmp/pip-AUwK7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:23:00 INFO - Running setup.py (path:/tmp/pip-aOKV8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:23:00 INFO - Running setup.py (path:/tmp/pip-jyDI4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:23:00 INFO - Running setup.py (path:/tmp/pip-3e9iDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:23:00 INFO - Running setup.py (path:/tmp/pip-lyJQur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:23:00 INFO - Running setup.py (path:/tmp/pip-1Dnn2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:23:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:23:00 INFO - Running setup.py install for manifestparser 12:23:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:23:00 INFO - Running setup.py install for mozcrash 12:23:00 INFO - Running setup.py install for mozdebug 12:23:00 INFO - Running setup.py install for mozdevice 12:23:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:23:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:23:01 INFO - Running setup.py install for mozfile 12:23:01 INFO - Running setup.py install for mozhttpd 12:23:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:23:01 INFO - Running setup.py install for mozinfo 12:23:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:23:01 INFO - Running setup.py install for mozInstall 12:23:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:23:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:23:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:23:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:23:01 INFO - Running setup.py install for mozleak 12:23:01 INFO - Running setup.py install for mozlog 12:23:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:23:01 INFO - Running setup.py install for moznetwork 12:23:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:23:01 INFO - Running setup.py install for mozprocess 12:23:01 INFO - Running setup.py install for mozprofile 12:23:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:23:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:23:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:23:01 INFO - Running setup.py install for mozrunner 12:23:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:23:02 INFO - Running setup.py install for mozscreenshot 12:23:02 INFO - Running setup.py install for moztest 12:23:02 INFO - Running setup.py install for mozversion 12:23:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:23:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:23:02 INFO - Cleaning up... 12:23:02 INFO - Return code: 0 12:23:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:02 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 0x24d2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2793180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27913b0>, '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 0x27922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2792740>, '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': '6dbc10da6d83fee962c624be000001a8-1468610552.322440-878699086', '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 12:23:02 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 12:23:02 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 12:23:02 INFO - Using env: {'DISPLAY': ':0', 12:23:02 INFO - 'HOME': '/home/cltbld', 12:23:02 INFO - 'LANG': 'en_US.UTF-8', 12:23:02 INFO - 'LANGUAGE': 'en_US:en', 12:23:02 INFO - 'LOGNAME': 'cltbld', 12:23:02 INFO - 'MAIL': '/var/mail/cltbld', 12:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:02 INFO - 'MOZ_NO_REMOTE': '1', 12:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:02 INFO - 'NO_EM_RESTART': '1', 12:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:02 INFO - 'PWD': '/builds/slave/test', 12:23:02 INFO - 'SHELL': '/bin/bash', 12:23:02 INFO - 'SHLVL': '1', 12:23:02 INFO - 'TERM': 'linux', 12:23:02 INFO - 'TMOUT': '86400', 12:23:02 INFO - 'USER': 'cltbld', 12:23:02 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468610552.322440-878699086', 12:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:02 INFO - '_': '/tools/buildbot/bin/python'} 12:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:23:02 INFO - Running setup.py (path:/tmp/pip-bbze_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:23:02 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)) 12:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:23:02 INFO - Running setup.py (path:/tmp/pip-6MU4Pb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:23:02 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)) 12:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:23:02 INFO - Running setup.py (path:/tmp/pip-OsUpbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:23:02 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)) 12:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:23:02 INFO - Running setup.py (path:/tmp/pip-jlAHJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:23:02 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)) 12:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:23:02 INFO - Running setup.py (path:/tmp/pip-CQfha4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:23:02 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)) 12:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:23:02 INFO - Running setup.py (path:/tmp/pip-8orGjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:23:03 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)) 12:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:23:03 INFO - Running setup.py (path:/tmp/pip-FPnMoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:23:03 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)) 12:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:23:03 INFO - Running setup.py (path:/tmp/pip-ohNQfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:23:03 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)) 12:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:23:03 INFO - Running setup.py (path:/tmp/pip-ZnVY9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:23:03 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)) 12:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:23:03 INFO - Running setup.py (path:/tmp/pip-P8YS2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:23:03 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)) 12:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:23:03 INFO - Running setup.py (path:/tmp/pip-FDYbO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:23:03 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)) 12:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:23:03 INFO - Running setup.py (path:/tmp/pip-HuJVZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 12:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:23:03 INFO - Running setup.py (path:/tmp/pip-0OrUmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:23:03 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)) 12:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:23:03 INFO - Running setup.py (path:/tmp/pip-hSPLcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 12:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:23:03 INFO - Running setup.py (path:/tmp/pip-iKt54Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:23:03 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)) 12:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:23:03 INFO - Running setup.py (path:/tmp/pip-_C4Qq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:23:03 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)) 12:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:23:03 INFO - Running setup.py (path:/tmp/pip-niJIa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:23:03 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)) 12:23:03 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)) 12:23:03 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)) 12:23:03 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)) 12:23:03 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)) 12:23:03 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)) 12:23:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:23:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:23:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:23:05 INFO - Downloading blessings-1.6.tar.gz 12:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:23:05 INFO - Installing collected packages: blessings 12:23:05 INFO - Running setup.py install for blessings 12:23:05 INFO - Successfully installed blessings 12:23:05 INFO - Cleaning up... 12:23:06 INFO - Return code: 0 12:23:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:23:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:23:06 INFO - Reading from file tmpfile_stdout 12:23:06 INFO - Current package versions: 12:23:06 INFO - argparse == 1.2.1 12:23:06 INFO - blessings == 1.6 12:23:06 INFO - blobuploader == 1.2.4 12:23:06 INFO - docopt == 0.6.1 12:23:06 INFO - functools32 == 3.2.3-2 12:23:06 INFO - jsonschema == 2.5.1 12:23:06 INFO - manifestparser == 1.1 12:23:06 INFO - mozInstall == 1.12 12:23:06 INFO - mozcrash == 0.17 12:23:06 INFO - mozdebug == 0.1 12:23:06 INFO - mozdevice == 0.48 12:23:06 INFO - mozfile == 1.2 12:23:06 INFO - mozhttpd == 0.7 12:23:06 INFO - mozinfo == 0.9 12:23:06 INFO - mozleak == 0.1 12:23:06 INFO - mozlog == 3.2 12:23:06 INFO - moznetwork == 0.27 12:23:06 INFO - mozprocess == 0.23 12:23:06 INFO - mozprofile == 0.28 12:23:06 INFO - mozrunner == 6.12 12:23:06 INFO - mozscreenshot == 0.1 12:23:06 INFO - mozsystemmonitor == 0.3 12:23:06 INFO - moztest == 0.7 12:23:06 INFO - mozversion == 1.4 12:23:06 INFO - psutil == 3.1.1 12:23:06 INFO - requests == 1.2.3 12:23:06 INFO - wsgiref == 0.1.2 12:23:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:06 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 0x24d2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2793180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27913b0>, '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 0x27922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2792740>, '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': '6dbc10da6d83fee962c624be000001a8-1468610552.322440-878699086', '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 12:23:06 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 12:23:06 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 12:23:06 INFO - Using env: {'DISPLAY': ':0', 12:23:06 INFO - 'HOME': '/home/cltbld', 12:23:06 INFO - 'LANG': 'en_US.UTF-8', 12:23:06 INFO - 'LANGUAGE': 'en_US:en', 12:23:06 INFO - 'LOGNAME': 'cltbld', 12:23:06 INFO - 'MAIL': '/var/mail/cltbld', 12:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:06 INFO - 'MOZ_NO_REMOTE': '1', 12:23:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:06 INFO - 'NO_EM_RESTART': '1', 12:23:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:06 INFO - 'PWD': '/builds/slave/test', 12:23:06 INFO - 'SHELL': '/bin/bash', 12:23:06 INFO - 'SHLVL': '1', 12:23:06 INFO - 'TERM': 'linux', 12:23:06 INFO - 'TMOUT': '86400', 12:23:06 INFO - 'USER': 'cltbld', 12:23:06 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468610552.322440-878699086', 12:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:06 INFO - '_': '/tools/buildbot/bin/python'} 12:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:06 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)) 12:23:06 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)) 12:23:06 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)) 12:23:06 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)) 12:23:06 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)) 12:23:06 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)) 12:23:06 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)) 12:23:06 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)) 12:23:06 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)) 12:23:06 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)) 12:23:06 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)) 12:23:06 INFO - Cleaning up... 12:23:06 INFO - Return code: 0 12:23:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:06 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 0x24d2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2793180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27913b0>, '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 0x27922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2792740>, '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': '6dbc10da6d83fee962c624be000001a8-1468610552.322440-878699086', '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 12:23:06 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 12:23:06 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 12:23:06 INFO - Using env: {'DISPLAY': ':0', 12:23:06 INFO - 'HOME': '/home/cltbld', 12:23:06 INFO - 'LANG': 'en_US.UTF-8', 12:23:06 INFO - 'LANGUAGE': 'en_US:en', 12:23:06 INFO - 'LOGNAME': 'cltbld', 12:23:06 INFO - 'MAIL': '/var/mail/cltbld', 12:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:06 INFO - 'MOZ_NO_REMOTE': '1', 12:23:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:06 INFO - 'NO_EM_RESTART': '1', 12:23:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:06 INFO - 'PWD': '/builds/slave/test', 12:23:06 INFO - 'SHELL': '/bin/bash', 12:23:06 INFO - 'SHLVL': '1', 12:23:06 INFO - 'TERM': 'linux', 12:23:06 INFO - 'TMOUT': '86400', 12:23:06 INFO - 'USER': 'cltbld', 12:23:06 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468610552.322440-878699086', 12:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:06 INFO - '_': '/tools/buildbot/bin/python'} 12:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:23:06 INFO - Cleaning up... 12:23:06 INFO - Return code: 0 12:23:06 INFO - Running post-action listener: _resource_record_post_action 12:23:06 INFO - Running post-action listener: _start_resource_monitoring 12:23:06 INFO - Starting resource monitoring. 12:23:06 INFO - ##### 12:23:06 INFO - ##### Finished create-virtualenv step (success) 12:23:06 INFO - ##### 12:23:06 INFO - ##### 12:23:06 INFO - ##### Running install step. 12:23:06 INFO - ##### 12:23:06 INFO - Running pre-action listener: _resource_record_pre_action 12:23:06 INFO - Running main action method: install 12:23:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:23:06 INFO - Reading from file tmpfile_stdout 12:23:06 INFO - Detecting whether we're running mozinstall >=1.0... 12:23:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:23:06 INFO - Reading from file tmpfile_stdout 12:23:06 INFO - Output received: 12:23:06 INFO - Usage: mozinstall [options] installer 12:23:06 INFO - Options: 12:23:06 INFO - -h, --help show this help message and exit 12:23:06 INFO - -d DEST, --destination=DEST 12:23:06 INFO - Directory to install application into. [default: 12:23:06 INFO - "/builds/slave/test"] 12:23:06 INFO - --app=APP Application being installed. [default: firefox] 12:23:06 INFO - mkdir: /builds/slave/test/build/application 12:23:06 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'] 12:23:06 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 12:23:24 INFO - Reading from file tmpfile_stdout 12:23:24 INFO - Output received: 12:23:24 INFO - /builds/slave/test/build/application/firefox/firefox 12:23:24 INFO - Running post-action listener: _resource_record_post_action 12:23:24 INFO - ##### 12:23:24 INFO - ##### Finished install step (success) 12:23:24 INFO - ##### 12:23:24 INFO - ##### 12:23:24 INFO - ##### Running run-tests step. 12:23:24 INFO - ##### 12:23:24 INFO - Running pre-action listener: _resource_record_pre_action 12:23:24 INFO - Running main action method: run_tests 12:23:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:23:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:23:24 INFO - Python 2.7.3 12:23:24 INFO - Return code: 0 12:23:24 INFO - grabbing minidump binary from tooltool 12:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:23:24 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 0x27913b0>, '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 0x27922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2792740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:23:24 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 12:23:24 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 12:23:24 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 12:23:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:23:24 INFO - Return code: 0 12:23:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:23:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:23:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:23:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:23:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:23:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 12:23:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 12:23:24 INFO - Using env: {'DISPLAY': ':0', 12:23:24 INFO - 'HOME': '/home/cltbld', 12:23:24 INFO - 'LANG': 'en_US.UTF-8', 12:23:24 INFO - 'LANGUAGE': 'en_US:en', 12:23:24 INFO - 'LOGNAME': 'cltbld', 12:23:24 INFO - 'MAIL': '/var/mail/cltbld', 12:23:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:23:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:23:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:24 INFO - 'MOZ_NO_REMOTE': '1', 12:23:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:23:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:24 INFO - 'NO_EM_RESTART': '1', 12:23:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:24 INFO - 'PWD': '/builds/slave/test', 12:23:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:23:24 INFO - 'SHELL': '/bin/bash', 12:23:24 INFO - 'SHLVL': '1', 12:23:24 INFO - 'TERM': 'linux', 12:23:24 INFO - 'TMOUT': '86400', 12:23:24 INFO - 'USER': 'cltbld', 12:23:24 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468610552.322440-878699086', 12:23:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:24 INFO - '_': '/tools/buildbot/bin/python'} 12:23:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 12:23:24 INFO - mozversion application_buildid: 20160715101141 12:23:24 INFO - mozversion application_changeset: df9a54d23bbcdd005266f61f85239fe9bebf386e 12:23:24 INFO - mozversion application_display_name: Nightly 12:23:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:23:24 INFO - mozversion application_name: Firefox 12:23:24 INFO - mozversion application_remotingname: firefox 12:23:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:23:24 INFO - mozversion application_vendor: Mozilla 12:23:24 INFO - mozversion application_version: 50.0a1 12:23:24 INFO - mozversion platform_buildid: 20160715101141 12:23:24 INFO - mozversion platform_changeset: df9a54d23bbcdd005266f61f85239fe9bebf386e 12:23:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:23:24 INFO - mozversion platform_version: 50.0a1 12:23:24 INFO - using testdate: 1468610604 12:23:24 INFO - actual date: 1468610604 12:23:24 INFO - starting webserver on 'localhost:55240' 12:23:24 INFO - SUITE-START | Running 2 tests 12:23:24 INFO - TEST-START | dromaeo_css 12:23:24 INFO - operating with platform_type : linux_ 12:23:24 INFO - Initialising browser for dromaeo_css test... 12:23:24 INFO - TEST-INFO | started process 22103 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQkQyED/profile http://localhost:55240/getInfo.html) 12:23:28 INFO - PROCESS | 22103 | __metrics Screen width/height:1600/1200 12:23:28 INFO - PROCESS | 22103 | colorDepth:24 12:23:28 INFO - PROCESS | 22103 | Browser inner width/height: 1024/697 12:23:28 INFO - PROCESS | 22103 | __metrics 12:23:28 INFO - PROCESS | 22103 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:23:29 INFO - TEST-INFO | 22103: exit 0 12:23:29 INFO - Browser initialized. 12:23:29 INFO - Running cycle 1/1 for dromaeo_css test... 12:23:29 INFO - TEST-INFO | started process 22184 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQkQyED/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:23:41 INFO - PROCESS | 22184 | RSS: Main: 156979200 12:23:41 INFO - PROCESS | 22184 | 12:24:33 INFO - PROCESS | 22184 | 1468610673229 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:26:40 INFO - PROCESS | 22184 | Cycle 1(1): loaded http://localhost:55240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55240/tests/dromaeo/cssquery-ext.html) 12:26:41 INFO - PROCESS | 22184 | RSS: Main: 245075968 12:26:41 INFO - PROCESS | 22184 | 12:29:44 INFO - PROCESS | 22184 | Cycle 1(1): loaded http://localhost:55240/tests/dromaeo/cssquery-ext.html (next: http://localhost:55240/tests/dromaeo/cssquery-jquery.html) 12:29:44 INFO - PROCESS | 22184 | RSS: Main: 253419520 12:29:44 INFO - PROCESS | 22184 | 12:32:46 INFO - PROCESS | 22184 | Cycle 1(1): loaded http://localhost:55240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55240/tests/dromaeo/cssquery-mootools.html) 12:32:47 INFO - PROCESS | 22184 | RSS: Main: 254164992 12:32:47 INFO - PROCESS | 22184 | 12:35:49 INFO - PROCESS | 22184 | Cycle 1(1): loaded http://localhost:55240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55240/tests/dromaeo/cssquery-prototype.html) 12:35:50 INFO - PROCESS | 22184 | RSS: Main: 246583296 12:35:50 INFO - PROCESS | 22184 | 12:38:52 INFO - PROCESS | 22184 | Cycle 1(1): loaded http://localhost:55240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55240/tests/dromaeo/cssquery-yui.html) 12:38:53 INFO - PROCESS | 22184 | RSS: Main: 229990400 12:38:53 INFO - PROCESS | 22184 | 12:41:56 INFO - PROCESS | 22184 | Cycle 1(1): loaded http://localhost:55240/tests/dromaeo/cssquery-yui.html (next: http://localhost:55240/tests/dromaeo/cssquery-dojo.html) 12:41:56 INFO - PROCESS | 22184 | RSS: Main: 287797248 12:41:56 INFO - PROCESS | 22184 | 12:41:56 INFO - PROCESS | 22184 | __start_tp_report 12:41:56 INFO - PROCESS | 22184 | _x_x_mozilla_page_load 12:41:56 INFO - PROCESS | 22184 | _x_x_mozilla_page_load_details 12:41:56 INFO - PROCESS | 22184 | |i|pagename|runs| 12:41:56 INFO - PROCESS | 22184 | |0;dojo.html;2981.8956336528217;2995.251187203199;3029.5910052142967;3031.136126204032;3038.4986477231246;5125.256837758532;5178.896422071556;5197.116490196666;5248.685078895264;5314.9468505314935;5193.870153246171;5215.400228973669;5228.686278823273;5259.579233661308;5271.393789714184;4690.0854333405;4747;4754.191787396151;4765.237561990082;4903.558679718824;4841.152798260308;4853.272009198631;4875.926861097087;4901.730404827733;4921;4668.393108895839;4683.063387322532;4726.621870250389;4772.451168115676;4796.856094317176;4712.458067322267;4714.4106986626675;4720.291956206596;4723.6929599575915;4815.566599006072;4721.079389519045;4728.976355118237;4746.52534746526;4748.738819364934;4750.406199225097;5105.081085404626;5222.843314700565;5268.947310526884;5300.867478313035;5309.362876454811;5614.606977511576;5645.379008309083;5676.914846277309;5677.517411020068;5678.943210567924;5711.371749107595;5733.340665823442;5745.770169193269;5750.45370689788;5751.884962300773;5101.056304583664;5220.530152286313;5289.920651190235;5291.391489978663;5313.654612450178;5764.423557644202;5815.82552523425;5820.126980952891;5824.068149096124;5826.067829147316;5348.1175606025345;5581.972090139523;5588.329400471969;5592.077307244341;5592.944070559323;5513.58648101394;5553.611247212737;5555.833325000256;5626.803061892814;5632.239647647597;5546.972265138648;5550.750216240279;5552.278203833475;5554.139108438118;5554.972225138848;5440.564754819605;5464.508194262536;5547.611667183339;5550.389457159709;5554.444555544414;4304.78476076195;4331;4332.740035597874;4345.261305578059;4373.584509471595;3827.8468861245237;3837.3860182370686;3846.1346197105986;3879.980600097038;3890.6109389060866;5189.532942035235;5244.108501554745;5249.42256351801;5357.973210133924;5358.571314294847;5587.078132108238;5644.153376993484;5648.265725455747;5675.063614503643;5718.857028574319;5313.814016509404;5332.33345831771;5342.839714808562;5347.652402593897;5349.518543331119;4735.573798358096;4784.928226076611;4825.638077144228;4894.95105048945;4929.211326187793;5773.624714393551;5777.653340799566;5777.797777077866;5781.19063331134;5821.563382746311;5607.607467477237;5619.775208991595;5619.8876022480135;5620.04459241938;5623.184638227516;5628;5639.2668953035845;5656.575756818337;5689.118186681071;5770;5372.838814835562;5391.81128660495;5441.183822426668;5444.210589464426;5445.319335083114;5497.47773961473;5534.308211473566;5549.694766787704;5551.111822108443;5606.607537472338;5295.655782374133;5435.83692489226;5444.782208711607;5446.537044351275;5480.150576660624;5454.4545545445135;5467.835964921059;5512;5520.309961254843;5522.806701765419;5283;5451.64564303319;5495.148252020943;5510.559155267489;5562.749676264659;5369.597280203922;5459.181122831448;5461.508464238238;5463.4263402342185;5518.53092487127;5321.787128514971;5321.787128514971;5331.040412725747;5332.360116786011;5338.706371149624 12:41:56 INFO - PROCESS | 22184 | |1;ext.html;595.217289264617;604.274870155813;609.1259043272906;647.0811447744203;654.9541532092755;31136.221594460123;33211;33257.33485330292;33274.33451330975;43185.568144318546;41950.790246048724;44715.329270060975;45036;45049.099018019704;45056.774716126376;8881.378303518757;9020.413673111227;9039.231665308456;9066.501342426163;9071.183593476586;8859.822803543926;8950.731478055635;8974.50640214788;8978.41640293382;8981.820363592724;8999.325050621197;9040.593173307218;9044.095590440937;9051.366404351666;9054.909450905472;8980.46117232965;9015;9027.4132181408;9034.954825225897;9038.774030649254;8642.395032347738;8705.260052895512;8708;8916.420432671921;8956.8656470153;42547.36178957318;42836.57163428357;42886;42951;42967;3490.5636795400574;3680.576733675635;3774.1885494618787;3993.98003009986;4214.536400995888;32870.16092548301;33498.49752253718;33681.326373472395;33747.662523374696;34110.48834267488;4494.438195225597;4574.359589657451;4586.449626044862;4631.698939568917;4709.858704238878;383335;386936;388514;389132;389270;59180;59265;59323.406765932654;59379.40620593739;59572.40427595669;59971;60592.69703651542;60798.69600651968;60969;60972.69513652403;17138.485845424657;17278.30886764515;17390.913045434692;17400;17413.738793917848;12235.143539952296;12236.755264894653;12237.510499579917;12238.571649992207;12246.326452045223;14480.493182738554;16185;16270.837291626933;16310;16452.424165154163;6017.879642407215;6100.389961003864;6155.4767844732805;6252.906206406908;6263.874722505524;755.2088515651399;1015.9796804063877;1026.7227848480868;1073.270176280137;1115.0633467887014;32785.836070819496;32904.67095329016;33093;33217.3356532868;33845;1083.772407794372;1108.667399780079;1127.1095834290982;1180.527788884453;1247.7255003899127;16651.6669666606;16946.152692365333;17079.48761537156;17108.401205957733;17241.310347586208;573251;573514;577115;577459;577526;59949.70025149846;60128;60141.69929150326;60188.398116019154;60507.394926051056;1213.5995121609847;1309.5678426119357;1316.973660526784;1342.4227582139579;1355.823742913415;32565.674343256265;33843.66156338405;33903.32193356168;33995.49006764851;34367.312653747285;48232;48524;48558.75720621374;48589.5141048585;49045;392068;399917;400203;401345.89232860715;402665;35707.28585428225;36267;41237;44241.55758442375;45111.774441127585;47458.52541474679;48461.75769121132;48517.27224091571;48829;49325;41146.58853411547;42015.27083510175;42226.36660450157;42284.15431691287;42461.787691062586;40984.79507602443;42237.57762422336;42279.788601056796;42669.14661706811;42872.35691464693;39983.400248995706;40873.795631021654;41809.37285940774;41973.37039944464;42090.789546052074;36259.274814503035;37215;37759;38319.80840095893;38426.807865960494;27577.586336205375;28078.71921280761;28099.859500702365;28188.43623127485;28199.577006344512 12:41:56 INFO - PROCESS | 22184 | |2;jquery.html;379.59234664949685;379.89932667843044;398.44814931320116;400.7194963525533;416.15520493398395;13645.2638741662;18934;20566.69149962752;20609.793902060974;21541.569168616617;15557.455489057886;19864.70202946957;19932.202711891507;20344.08451619677;20727.274545390916;5661.377248502672;5833.504152147073;5863.472287494124;5895.233619629464;5904.616199947011;5802.5938184327115;5863.736131874076;5865.560082993771;5867.589268751189;5870.70646467677;4266.168097221043;6138.171346868183;6481.935180648204;6482.319356467574;6629.602223866559;6274.435300822902;6473.608174242513;6558.639274839882;6576.375244351779;6606.9669651651675;5693.572982026365;5716.942830571683;5719.227904232917;5737.799177028784;5737.885242295172;24903;24946.750532494625;25264.494710105693;25689;25777;2429.708434987795;2521.3318470605304;2548.923532294034;3233.224026233687;3287.474004159323;14306.57080287593;15185.848141518554;15550.688986220326;15911.761323580156;15931.442399516078;1928.7203355513511;1985.3944546913185;1996.930107446247;2015.133492598182;2018.6265540874986;87902;88295.55852220762;88376.99999999936;89022.10977890203;89885;10346.085974094816;10423.166146708245;10656.62701805433;10815.134789216843;11067.280626759235;14824.332905019084;14867.256637168099;14893.553193404216;14894.329755161043;14918.552443426715;8310.21052999964;8344.374171937128;8464.873026904601;8684.305255579538;8727.04002559718;8326.375521835887;8358.164183581594;8543.700970466003;8713;8726.563671816384;6117.265928088569;6354.809355719336;6397.616143031433;6638.502112341594;6784.21981472137;1781.416945429133;1868.2807119259182;1881.1628825172668;1890.981090189108;1941.6213838301678;433.60325302347997;434.24874966308465;892.4511425473287;1017.2980643356061;1025.1747343388645;11782.764344713229;12470.314132722788;12549.87450125487;12624.684382890318;12863.163894346837;449.29909341427475;463.9141758774638;467.40172579098805;476.67109694311506;493.05825872583193;6650.634215118118;6715.966420167965;6809.93190068093;6814.250432452426;6853.971904214408;342197.73406797834;349595.87659670034;517601;522036;530449;88648.5567572158;101148.49425752972;104363;105057;105527;460.56936764126317;460.6153861525664;467.7193683789767;469.3991690635991;469.67592361270613;11461.140414469115;11498.310101393943;11854.703632409259;11944.223625464318;12003.579874704343;43716.12567748691;44262.778686106365;45620.77189614031;45744.77127614474;46395;58571;67343.32656673371;67799;67904;69246;8842.46945183291;8857.395925597895;9196.310276729138;9274.072592740671;9287.303452241244;10915.345079295268;13912.095713778572;14193.645158871112;14208.360623771749;14437.639059023608;12230;12375.133740638068;12584.811227831773;12716.173448725804;12740.808887866875;12372.257664540157;12488.875111248772;12681.23912565249;12912.612621621367;12913.806292905427;12181.573644922386;12595;12731.93634031824;12975;12982.35088245565;9123.087691231089;9123.178913897782;9133.31500137479;9139.268858491438;9228.169464748205;12030.27818330903;12471.189372690746;12490.937545312216;12504.624861254177;12647.87352126467 12:41:56 INFO - PROCESS | 22184 | |3;mootools.html;1483.3547406878006;1509.433962264151;1634.8365163483654;1751.3344928927006;1792.2741289777637;8276.83446331073;8683.956580217091;8818.77953051174;8833.381663283573;8839.469631822096;7390;8146.103928567868;8359.582020898946;8382.538960357178;8656.17766312201;2263.864168149908;2286.371247906831;2287.3938406322254;2288.8741119238434;2291.6218823894037;2230.587341341857;2235.508188198594;2263.671767593698;2267;2269.8524595901295;1917.6452356314057;2190.299104286629;2258.559580881729;2263.8981245843893;2265.9660105098437;2199.8900054997184;2210.613142700029;2211.8119959803435;2221.4113259985957;2224.4327696437385;2191.934241972743;2196.670499425083;2197.198022721711;2202.7246594175726;2205.9852467864803;8481.321494280442;8514.063453020162;8544.829103417896;8549.957250213709;8573.571321433965;4713.929291060636;4895.069936712049;4903.338049363361;4932.457429682732;4950.4307004694565;3113.7041981011766;3187.9043628691174;3259.940519331227;3285;3292.1440425489304;1028.4240825137947;1034.348360532867;1043.269711202154;1063.2132222155626;1075.8655168103987;11941.343226122559;11947;11947.880521194764;11987.400629968466;11995.340256285988;4128.793560321972;4306.806193721228;4323.654107671378;4409.404730361424;4447.132809102194;10044.096031357212;10070.093691567794;10083.092521673085;10099.69700908974;10111.949440252753;4999.250112483157;5006.4492905780335;5008.198688209869;5024.422191447957;5027.346444962204;4516.638668906479;4586.082783443325;4586.128635559233;4586.220342541776;4632.444106707217;3832.5209348831395;3835;3847.03824043989;3935.0359162005493;3951.4863067801575;1063.8829728729834;1164.714644912002;1171.6485054483792;1176.3588844079998;1198.7842188405996;921.2629896083241;998.610541888664;1011.701548043329;1044.7231483656838;1050.2251195479614;6011.428914253139;6160.845978850564;6330.05049242608;6366;6381.266154392211;960.2222200018008;983.233078199006;1001.3491230699958;1021.1983592879702;1036.0520124086527;4188.5026003286985;4335.674824388184;4350.608445239944;4392.626626736763;4418.779061046935;10374.481275936172;10796;10899.29154604964;10902.5093870776;10903.781924361627;10483.318584291997;10663.4135122569;10769.78460430787;10769.784604308026;10772.138228941665;7937.2459616336355;8048.718294859769;8079.596020199084;8125.187481251827;8140.5929703514585;5883.382244864228;5939.524838013035;6060.606060606046;6092.908606370819;6199.690015499297;8971.327150463872;9564.426134431678;9733.075357840993;9741.366811157252;9748.805023899624;9848.113669769755;10092.697219083439;10100.141487973604;10239.385636861813;10256.794864102527;7682.347000504796;7683.4621576491345;7684.269994350528;7764.107127680389;7833.882491762514;8358.916410835815;8408.579571021302;8461.703840365557;8468.44955077918;8490.745277641681;7435.219301973431;7451.701931922879;7682.116556596063;7734.265244801735;7865.528068315919;7422.369098626677;7591.127020392725;7645.923540764521;7654.61726913641;7825.960870195612;7165.176004759519;7175.2465991070185;7203.71185152588;7204.3155900189395;7204.459665525002;5324.8136315228785;5336.919946200887;5434.278446921555;5468.234447177478;5521.944780552143;5303.390110137384;5357.223202635518;5388.541973932103;5503.229547863222;5519.227308176939 12:41:56 INFO - PROCESS | 22184 | |4;prototype.html;309.75374577211113;313.61738678811844;317.4048658764816;319.697885498204;321.75546584595713;5334.653247538912;5375.193720941861;5408;5414;5432.293801805759;5339.252504649352;5356.8304836541165;5359.330083739533;5396.217548455482;5401.108817045193;3944.309745794482;3991.2217117662067;4089.20260549193;4091.365838295069;4138.896527586804;4057.8985525361954;4099.487564054493;4108.26051310764;4125.814338354766;4140.234056699505;3981.124152686404;4115.670746340301;4129.380592911058;4146.129312844307;4150.9584904151025;3970.404439334094;4053.675705943532;4071.943668447415;4074.6129117734063;4078.6940979426663;3523.2248905241063;3540.946885796715;3542.291541691672;3543.131932676485;3545.3795585772386;5185.585153187773;5189.948100518985;5200.869978250536;5202.687838729688;5218.556422704075;4451.577100175478;4596.643990022918;4611.423572053493;4614.953850461519;4644.210484217691;5445.564354851603;5463.426340234298;5487.807926722586;5511;5524.33707955044;3884.8251828667494;3886.514185726784;3888.2782052563034;3893.396523538856;3903.882883513471;5499.3675727291475;5735.684537350444;5744.597878148531;5806.44838740319;5813.593048486608;3939.625735555118;3941.6649584785614;3943.881683549498;3963.3460479021214;3997.560268370477;3975.8210880510446;4018.457508236351;4031.475908131924;4041.3533834586915;4072.979635101865;4505.684602077823;4671.48613652498;4681.180793361148;4710.199266124767;4715.669903106818;5496.615236933376;5497.202905578749;5499.972500137474;5508.779648814003;5589.664620122806;1390.9165450072826;1401.7196560687698;1422.5945605502588;1437.252628633105;1440.9265097502428;930.851063829784;947.4362754161263;950.843110886696;964.3490643815396;972.8443449048118;5334.626576139711;5344.385395679469;5357.249985002103;5366.651167674088;5367;5618.831435056954;5619.381867994517;5619.831405057855;5630.577706672016;5637.43625637433;5154.92267615986;5311.389190243094;5334.466553344634;5337.2527846101575;5344.091504444254;2979.3594377209006;2997.175776661392;3004.062379765083;3004.504256797604;3026.3947210557535;5544.500994910478;5787.131930210502;5791.739371728282;5808.30300363959;5824.883502330014;5708.401647538696;5717.799877004285;5729.54163666914;5751.281089863767;5763.596548241583;5801.796937107265;5818.272715910512;5841.766329346863;5863.618864773776;5866.941330586725;5458.536024437808;5676.013395311608;5682.801101961411;5809.618056596775;5818.359980402237;5703.315602127605;5726.484616384545;5741.368449470471;5752.309722833287;5755.1942728017275;5702;5921.5558833086825;5941.643501389931;5953.404659534012;6031.341381120227;3958.445817585483;3967.0479085019965;3971.7021223407783;3980.800959951933;3994.7403418777685;5723.112917497794;5749.281339832521;5752.395998420106;5754.05058165398;5756.9061878243;5472.288602481652;5609.747561359667;5628.465295796893;5648.830535083954;5653.773849045992;5530;5545.140503222007;5582.441755824385;5610.242617246619;5620.8032718856275;5296.814611488579;5368.731563421891;5520.006398848246;5527.53015993645;5607.299087614048;5637.267155269788;5643.943560564342;5649.293838270216;5661.2923384576925;5729.341125770589;5530.972345138249;5552.666839989613;5555.8610484851315;5602.607817452739;5627 12:41:56 INFO - PROCESS | 22184 | |5;yui.html;730.0354616954255;813.5810057820223;846.9280111190549;854.1159899504007;856.6616186606291;12046.216995895282;13127;14738.852611473882;15196.240187990597;15220;14906;15613.375464981416;15628.687426251468;15631.765523517157;15644.452444164457;640.4492136762381;663.0154220981838;764.6482617995715;772.6291380137537;791.1771757372326;785.0030461314128;788.7397158937565;790.2255789326434;791.2404092071589;791.7901756034655;847.7117779954814;848.0501837941514;848.452747977554;848.9490630562156;849.1890244816186;838.739990602912;840.3361344537808;840.5755093677715;840.7015509494164;840.970566030189;608.5679167790829;608.8386577556951;609.881073190728;610.2006371653149;610.2890132995055;13911.30443477822;13925;13925;13936;13938.442462301497;15413.3834646614;15695.618145612705;15722.921385393114;15877.682446351007;15954.76067858983;12120.27278363301;12317.22514882654;12395.690107747288;12425.37873106341;12737.235765854079;3869.8839034829;3880.2627500775043;3908.706846986459;3950.0914789598264;4050.5949405059555;45250.321245181345;68034.31965680329;68299.65850170767;78527.60736196283;83010;12226.816597751042;12360.196587221802;12375.319357435248;12491;12701.047421443429;22429.66355504669;22495.775042249366;22615.54768904613;22617.660735088986;22647;8555.572221388906;8982.685606003759;9165;9206.585703643352;9273.304502162366;4891.954845021854;4939.160342741742;5017.54842064216;5094.49055094495;5126.5898728101665;3422.093145316493;3501.3347463981763;3504.0889368764306;3509.263054758478;3522.066652337133;589.3046205477577;590.1354515634616;601.7592962814822;605.9394060593905;615.0006239860227;722.3174100475105;741.4365082537311;777.3314949143731;778.6418247606051;813.0081300812999;9577.952110239405;10298.845517317246;10383.584656613803;10546.525406356732;10588.205884558689;764.6635480388722;777.6980730699757;786.170590027515;789.5984627286613;794.9562774047367;4626.190416677068;4819.445763737145;4843.685160464559;4864.82973095947;4875.293082503017;109826.90173098327;113069;115842;119486;124402.37798810948;60336.69831650814;73212;88966.11033889579;91734;107399.46300268448;88719.55640221758;90744.54627726952;92493.53753231191;93426;94614.99999999862;10408.603008658849;10720.785584288114;10783.299085559414;10828.620998265023;10838.458077096271;50140.49859501358;50968.49031509786;51206;51871.481285186666;52111.436656900354;66088.66955665383;70851;76765;77057;77668.61165694136;13762.724745505235;13850.792238116235;13930.164190148624;14068.155910645393;14411.711765764416;13875.098118622258;14754.188519631523;14828.110313381232;15365.846341536888;15854.7621785671;14528;14626.634334141732;14903.552893413214;14988.700225995637;15498.612534686723;14337.56987290383;14394.424223030961;14885.479008234659;15092.169930653481;15787.763183552486;14252.71494570082;14434.350454229374;14608.488702895347;14621.853781462049;14790.260486975392;11595.536178552764;11644.6506604802;11842.340463564198;11979.221350612183;12063.21589096706;11984;12187.451564679433;12220.388980551115;12423.192492487959;12655.177413468095 12:41:56 INFO - PROCESS | 22184 | __end_tp_report 12:41:56 INFO - PROCESS | 22184 | __start_cc_report 12:41:56 INFO - PROCESS | 22184 | _x_x_mozilla_cycle_collect,824 12:41:56 INFO - PROCESS | 22184 | __end_cc_report 12:41:56 INFO - PROCESS | 22184 | __startTimestamp1468611716458__endTimestamp 12:41:56 INFO - PROCESS | 22184 | 12:41:56 INFO - PROCESS | 22184 | ------- Summary: start ------- 12:41:56 INFO - PROCESS | 22184 | Number of tests: 6 12:41:56 INFO - PROCESS | 22184 | 12:41:56 INFO - PROCESS | 22184 | [#0] dojo.html Cycles:165 Average:5203.00 Median:5358.57 stddev:585.78 (10.9%) stddev-sans-first:561.06 12:41:56 INFO - PROCESS | 22184 | Values: 2981.9 2995.3 3029.6 3031.1 3038.5 5125.3 5178.9 5197.1 5248.7 5314.9 5193.9 5215.4 5228.7 5259.6 5271.4 4690.1 4747.0 4754.2 4765.2 4903.6 4841.2 4853.3 4875.9 4901.7 4921.0 4668.4 4683.1 4726.6 4772.5 4796.9 4712.5 4714.4 4720.3 4723.7 4815.6 4721.1 4729.0 4746.5 4748.7 4750.4 5105.1 5222.8 5268.9 5300.9 5309.4 5614.6 5645.4 5676.9 5677.5 5678.9 5711.4 5733.3 5745.8 5750.5 5751.9 5101.1 5220.5 5289.9 5291.4 5313.7 5764.4 5815.8 5820.1 5824.1 5826.1 5348.1 5582.0 5588.3 5592.1 5592.9 5513.6 5553.6 5555.8 5626.8 5632.2 5547.0 5550.8 5552.3 5554.1 5555.0 5440.6 5464.5 5547.6 5550.4 5554.4 4304.8 4331.0 4332.7 4345.3 4373.6 3827.8 3837.4 3846.1 3880.0 3890.6 5189.5 5244.1 5249.4 5358.0 5358.6 5587.1 5644.2 5648.3 5675.1 5718.9 5313.8 5332.3 5342.8 5347.7 5349.5 4735.6 4784.9 4825.6 4895.0 4929.2 5773.6 5777.7 5777.8 5781.2 5821.6 5607.6 5619.8 5619.9 5620.0 5623.2 5628.0 5639.3 5656.6 5689.1 5770.0 5372.8 5391.8 5441.2 5444.2 5445.3 5497.5 5534.3 5549.7 5551.1 5606.6 5295.7 5435.8 5444.8 5446.5 5480.2 5454.5 5467.8 5512.0 5520.3 5522.8 5283.0 5451.6 5495.1 5510.6 5562.7 5369.6 5459.2 5461.5 5463.4 5518.5 5321.8 5321.8 5331.0 5332.4 5338.7 12:41:56 INFO - PROCESS | 22184 | 12:41:56 INFO - PROCESS | 22184 | [#1] ext.html Cycles:180 Average:61665.13 Median:42231.97 stddev:122665.13 (290.5%) stddev-sans-first:122923.54 12:41:56 INFO - PROCESS | 22184 | Values: 595.2 604.3 609.1 647.1 655.0 31136.2 33211.0 33257.3 33274.3 43185.6 41950.8 44715.3 45036.0 45049.1 45056.8 8881.4 9020.4 9039.2 9066.5 9071.2 8859.8 8950.7 8974.5 8978.4 8981.8 8999.3 9040.6 9044.1 9051.4 9054.9 8980.5 9015.0 9027.4 9035.0 9038.8 8642.4 8705.3 8708.0 8916.4 8956.9 42547.4 42836.6 42886.0 42951.0 42967.0 3490.6 3680.6 3774.2 3994.0 4214.5 32870.2 33498.5 33681.3 33747.7 34110.5 4494.4 4574.4 4586.4 4631.7 4709.9 383335.0 386936.0 388514.0 389132.0 389270.0 59180.0 59265.0 59323.4 59379.4 59572.4 59971.0 60592.7 60798.7 60969.0 60972.7 17138.5 17278.3 17390.9 17400.0 17413.7 12235.1 12236.8 12237.5 12238.6 12246.3 14480.5 16185.0 16270.8 16310.0 16452.4 6017.9 6100.4 6155.5 6252.9 6263.9 755.2 1016.0 1026.7 1073.3 1115.1 32785.8 32904.7 33093.0 33217.3 33845.0 1083.8 1108.7 1127.1 1180.5 1247.7 16651.7 16946.2 17079.5 17108.4 17241.3 573251.0 573514.0 577115.0 577459.0 577526.0 59949.7 60128.0 60141.7 60188.4 60507.4 1213.6 1309.6 1317.0 1342.4 1355.8 32565.7 33843.7 33903.3 33995.5 34367.3 48232.0 48524.0 48558.8 48589.5 49045.0 392068.0 399917.0 400203.0 401345.9 402665.0 35707.3 36267.0 41237.0 44241.6 45111.8 47458.5 48461.8 48517.3 48829.0 49325.0 41146.6 42015.3 42226.4 42284.2 42461.8 40984.8 42237.6 42279.8 42669.1 42872.4 39983.4 40873.8 41809.4 41973.4 42090.8 36259.3 37215.0 37759.0 38319.8 38426.8 27577.6 28078.7 28099.9 28188.4 28199.6 12:41:56 INFO - PROCESS | 22184 | 12:41:56 INFO - PROCESS | 22184 | [#2] jquery.html Cycles:180 Average:28698.88 Median:399.58 stddev:76730.22 (19202.5%) stddev-sans-first:76916.00 12:41:56 INFO - PROCESS | 22184 | Values: 379.6 379.9 398.4 400.7 416.2 13645.3 18934.0 20566.7 20609.8 21541.6 15557.5 19864.7 19932.2 20344.1 20727.3 5661.4 5833.5 5863.5 5895.2 5904.6 5802.6 5863.7 5865.6 5867.6 5870.7 4266.2 6138.2 6481.9 6482.3 6629.6 6274.4 6473.6 6558.6 6576.4 6607.0 5693.6 5716.9 5719.2 5737.8 5737.9 24903.0 24946.8 25264.5 25689.0 25777.0 2429.7 2521.3 2548.9 3233.2 3287.5 14306.6 15185.8 15550.7 15911.8 15931.4 1928.7 1985.4 1996.9 2015.1 2018.6 87902.0 88295.6 88377.0 89022.1 89885.0 10346.1 10423.2 10656.6 10815.1 11067.3 14824.3 14867.3 14893.6 14894.3 14918.6 8310.2 8344.4 8464.9 8684.3 8727.0 8326.4 8358.2 8543.7 8713.0 8726.6 6117.3 6354.8 6397.6 6638.5 6784.2 1781.4 1868.3 1881.2 1891.0 1941.6 433.6 434.2 892.5 1017.3 1025.2 11782.8 12470.3 12549.9 12624.7 12863.2 449.3 463.9 467.4 476.7 493.1 6650.6 6716.0 6809.9 6814.3 6854.0 342197.7 349595.9 517601.0 522036.0 530449.0 88648.6 101148.5 104363.0 105057.0 105527.0 460.6 460.6 467.7 469.4 469.7 11461.1 11498.3 11854.7 11944.2 12003.6 43716.1 44262.8 45620.8 45744.8 46395.0 58571.0 67343.3 67799.0 67904.0 69246.0 8842.5 8857.4 9196.3 9274.1 9287.3 10915.3 13912.1 14193.6 14208.4 14437.6 12230.0 12375.1 12584.8 12716.2 12740.8 12372.3 12488.9 12681.2 12912.6 12913.8 12181.6 12595.0 12731.9 12975.0 12982.4 9123.1 9123.2 9133.3 9139.3 9228.2 12030.3 12471.2 12490.9 12504.6 12647.9 12:41:56 INFO - PROCESS | 22184 | 12:41:56 INFO - PROCESS | 22184 | [#3] mootools.html Cycles:180 Average:5711.09 Median:4551.36 stddev:3229.74 (71.0%) stddev-sans-first:3223.18 12:41:56 INFO - PROCESS | 22184 | Values: 1483.4 1509.4 1634.8 1751.3 1792.3 8276.8 8684.0 8818.8 8833.4 8839.5 7390.0 8146.1 8359.6 8382.5 8656.2 2263.9 2286.4 2287.4 2288.9 2291.6 2230.6 2235.5 2263.7 2267.0 2269.9 1917.6 2190.3 2258.6 2263.9 2266.0 2199.9 2210.6 2211.8 2221.4 2224.4 2191.9 2196.7 2197.2 2202.7 2206.0 8481.3 8514.1 8544.8 8550.0 8573.6 4713.9 4895.1 4903.3 4932.5 4950.4 3113.7 3187.9 3259.9 3285.0 3292.1 1028.4 1034.3 1043.3 1063.2 1075.9 11941.3 11947.0 11947.9 11987.4 11995.3 4128.8 4306.8 4323.7 4409.4 4447.1 10044.1 10070.1 10083.1 10099.7 10111.9 4999.3 5006.4 5008.2 5024.4 5027.3 4516.6 4586.1 4586.1 4586.2 4632.4 3832.5 3835.0 3847.0 3935.0 3951.5 1063.9 1164.7 1171.6 1176.4 1198.8 921.3 998.6 1011.7 1044.7 1050.2 6011.4 6160.8 6330.1 6366.0 6381.3 960.2 983.2 1001.3 1021.2 1036.1 4188.5 4335.7 4350.6 4392.6 4418.8 10374.5 10796.0 10899.3 10902.5 10903.8 10483.3 10663.4 10769.8 10769.8 10772.1 7937.2 8048.7 8079.6 8125.2 8140.6 5883.4 5939.5 6060.6 6092.9 6199.7 8971.3 9564.4 9733.1 9741.4 9748.8 9848.1 10092.7 10100.1 10239.4 10256.8 7682.3 7683.5 7684.3 7764.1 7833.9 8358.9 8408.6 8461.7 8468.4 8490.7 7435.2 7451.7 7682.1 7734.3 7865.5 7422.4 7591.1 7645.9 7654.6 7826.0 7165.2 7175.2 7203.7 7204.3 7204.5 5324.8 5336.9 5434.3 5468.2 5521.9 5303.4 5357.2 5388.5 5503.2 5519.2 12:41:56 INFO - PROCESS | 22184 | 12:41:56 INFO - PROCESS | 22184 | [#4] prototype.html Cycles:180 Average:4663.47 Median:5371.96 stddev:1389.85 (25.9%) stddev-sans-first:1354.79 12:41:56 INFO - PROCESS | 22184 | Values: 309.8 313.6 317.4 319.7 321.8 5334.7 5375.2 5408.0 5414.0 5432.3 5339.3 5356.8 5359.3 5396.2 5401.1 3944.3 3991.2 4089.2 4091.4 4138.9 4057.9 4099.5 4108.3 4125.8 4140.2 3981.1 4115.7 4129.4 4146.1 4151.0 3970.4 4053.7 4071.9 4074.6 4078.7 3523.2 3540.9 3542.3 3543.1 3545.4 5185.6 5189.9 5200.9 5202.7 5218.6 4451.6 4596.6 4611.4 4615.0 4644.2 5445.6 5463.4 5487.8 5511.0 5524.3 3884.8 3886.5 3888.3 3893.4 3903.9 5499.4 5735.7 5744.6 5806.4 5813.6 3939.6 3941.7 3943.9 3963.3 3997.6 3975.8 4018.5 4031.5 4041.4 4073.0 4505.7 4671.5 4681.2 4710.2 4715.7 5496.6 5497.2 5500.0 5508.8 5589.7 1390.9 1401.7 1422.6 1437.3 1440.9 930.9 947.4 950.8 964.3 972.8 5334.6 5344.4 5357.2 5366.7 5367.0 5618.8 5619.4 5619.8 5630.6 5637.4 5154.9 5311.4 5334.5 5337.3 5344.1 2979.4 2997.2 3004.1 3004.5 3026.4 5544.5 5787.1 5791.7 5808.3 5824.9 5708.4 5717.8 5729.5 5751.3 5763.6 5801.8 5818.3 5841.8 5863.6 5866.9 5458.5 5676.0 5682.8 5809.6 5818.4 5703.3 5726.5 5741.4 5752.3 5755.2 5702.0 5921.6 5941.6 5953.4 6031.3 3958.4 3967.0 3971.7 3980.8 3994.7 5723.1 5749.3 5752.4 5754.1 5756.9 5472.3 5609.7 5628.5 5648.8 5653.8 5530.0 5545.1 5582.4 5610.2 5620.8 5296.8 5368.7 5520.0 5527.5 5607.3 5637.3 5643.9 5649.3 5661.3 5729.3 5531.0 5552.7 5555.9 5602.6 5627.0 12:41:56 INFO - PROCESS | 22184 | 12:41:56 INFO - PROCESS | 22184 | [#5] yui.html Cycles:180 Average:20680.41 Median:3875.07 stddev:29166.73 (752.7%) stddev-sans-first:29210.08 12:41:56 INFO - PROCESS | 22184 | Values: 730.0 813.6 846.9 854.1 856.7 12046.2 13127.0 14738.9 15196.2 15220.0 14906.0 15613.4 15628.7 15631.8 15644.5 640.4 663.0 764.6 772.6 791.2 785.0 788.7 790.2 791.2 791.8 847.7 848.1 848.5 848.9 849.2 838.7 840.3 840.6 840.7 841.0 608.6 608.8 609.9 610.2 610.3 13911.3 13925.0 13925.0 13936.0 13938.4 15413.4 15695.6 15722.9 15877.7 15954.8 12120.3 12317.2 12395.7 12425.4 12737.2 3869.9 3880.3 3908.7 3950.1 4050.6 45250.3 68034.3 68299.7 78527.6 83010.0 12226.8 12360.2 12375.3 12491.0 12701.0 22429.7 22495.8 22615.5 22617.7 22647.0 8555.6 8982.7 9165.0 9206.6 9273.3 4892.0 4939.2 5017.5 5094.5 5126.6 3422.1 3501.3 3504.1 3509.3 3522.1 589.3 590.1 601.8 605.9 615.0 722.3 741.4 777.3 778.6 813.0 9578.0 10298.8 10383.6 10546.5 10588.2 764.7 777.7 786.2 789.6 795.0 4626.2 4819.4 4843.7 4864.8 4875.3 109826.9 113069.0 115842.0 119486.0 124402.4 60336.7 73212.0 88966.1 91734.0 107399.5 88719.6 90744.5 92493.5 93426.0 94615.0 10408.6 10720.8 10783.3 10828.6 10838.5 50140.5 50968.5 51206.0 51871.5 52111.4 66088.7 70851.0 76765.0 77057.0 77668.6 13762.7 13850.8 13930.2 14068.2 14411.7 13875.1 14754.2 14828.1 15365.8 15854.8 14528.0 14626.6 14903.6 14988.7 15498.6 14337.6 14394.4 14885.5 15092.2 15787.8 14252.7 14434.4 14608.5 14621.9 14790.3 11595.5 11644.7 11842.3 11979.2 12063.2 11984.0 12187.5 12220.4 12423.2 12655.2 12:41:56 INFO - PROCESS | 22184 | -------- Summary: end -------- 12:41:56 INFO - PROCESS | 22184 | 12:41:57 INFO - TEST-INFO | 22184: exit 0 12:41:57 INFO - TEST-OK | dromaeo_css | took 1112779ms 12:41:57 INFO - TEST-START | kraken 12:41:57 INFO - operating with platform_type : linux_ 12:41:57 INFO - Initialising browser for kraken test... 12:41:57 INFO - TEST-INFO | started process 22375 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDNo4ZX/profile http://localhost:55240/getInfo.html) 12:42:00 INFO - PROCESS | 22375 | __metrics Screen width/height:1600/1200 12:42:00 INFO - PROCESS | 22375 | colorDepth:24 12:42:00 INFO - PROCESS | 22375 | Browser inner width/height: 1024/697 12:42:00 INFO - PROCESS | 22375 | __metrics 12:42:01 INFO - PROCESS | 22375 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:42:02 INFO - TEST-INFO | 22375: exit 0 12:42:02 INFO - Browser initialized. 12:42:02 INFO - Running cycle 1/1 for kraken test... 12:42:02 INFO - TEST-INFO | started process 22459 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDNo4ZX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:42:14 INFO - PROCESS | 22459 | RSS: Main: 157614080 12:42:14 INFO - PROCESS | 22459 | 12:42:16 INFO - PROCESS | 22459 | Cycle 1(1): loaded http://localhost:55240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55240/tests/kraken/driver.html?testName=audio-beat-detection) 12:42:17 INFO - PROCESS | 22459 | RSS: Main: 216223744 12:42:17 INFO - PROCESS | 22459 | 12:42:20 INFO - PROCESS | 22459 | Cycle 1(1): loaded http://localhost:55240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55240/tests/kraken/driver.html?testName=audio-dft) 12:42:20 INFO - PROCESS | 22459 | RSS: Main: 202915840 12:42:20 INFO - PROCESS | 22459 | 12:42:24 INFO - PROCESS | 22459 | Cycle 1(1): loaded http://localhost:55240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55240/tests/kraken/driver.html?testName=audio-fft) 12:42:24 INFO - PROCESS | 22459 | RSS: Main: 269729792 12:42:24 INFO - PROCESS | 22459 | 12:42:26 INFO - PROCESS | 22459 | Cycle 1(1): loaded http://localhost:55240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55240/tests/kraken/driver.html?testName=audio-oscillator) 12:42:27 INFO - PROCESS | 22459 | RSS: Main: 179220480 12:42:27 INFO - PROCESS | 22459 | 12:42:29 INFO - PROCESS | 22459 | Cycle 1(1): loaded http://localhost:55240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:42:30 INFO - PROCESS | 22459 | RSS: Main: 184119296 12:42:30 INFO - PROCESS | 22459 | 12:42:33 INFO - PROCESS | 22459 | Cycle 1(1): loaded http://localhost:55240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55240/tests/kraken/driver.html?testName=imaging-darkroom) 12:42:33 INFO - PROCESS | 22459 | RSS: Main: 218873856 12:42:33 INFO - PROCESS | 22459 | 12:42:37 INFO - PROCESS | 22459 | Cycle 1(1): loaded http://localhost:55240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55240/tests/kraken/driver.html?testName=imaging-desaturate) 12:42:37 INFO - PROCESS | 22459 | RSS: Main: 220917760 12:42:37 INFO - PROCESS | 22459 | 12:42:40 INFO - PROCESS | 22459 | Cycle 1(1): loaded http://localhost:55240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55240/tests/kraken/driver.html?testName=json-parse-financial) 12:42:41 INFO - PROCESS | 22459 | RSS: Main: 220921856 12:42:41 INFO - PROCESS | 22459 | 12:42:42 INFO - PROCESS | 22459 | Cycle 1(1): loaded http://localhost:55240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:42:43 INFO - PROCESS | 22459 | RSS: Main: 206983168 12:42:43 INFO - PROCESS | 22459 | 12:42:45 INFO - PROCESS | 22459 | Cycle 1(1): loaded http://localhost:55240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55240/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:42:45 INFO - PROCESS | 22459 | RSS: Main: 212021248 12:42:45 INFO - PROCESS | 22459 | 12:42:47 INFO - PROCESS | 22459 | Cycle 1(1): loaded http://localhost:55240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:42:48 INFO - PROCESS | 22459 | RSS: Main: 212348928 12:42:48 INFO - PROCESS | 22459 | 12:42:50 INFO - PROCESS | 22459 | Cycle 1(1): loaded http://localhost:55240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:42:51 INFO - PROCESS | 22459 | RSS: Main: 223989760 12:42:51 INFO - PROCESS | 22459 | 12:42:54 INFO - PROCESS | 22459 | Cycle 1(1): loaded http://localhost:55240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:42:54 INFO - PROCESS | 22459 | RSS: Main: 224407552 12:42:54 INFO - PROCESS | 22459 | 12:42:56 INFO - PROCESS | 22459 | Cycle 1(1): loaded http://localhost:55240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55240/tests/kraken/driver.html?testName=ai-astar) 12:42:56 INFO - PROCESS | 22459 | RSS: Main: 266518528 12:42:56 INFO - PROCESS | 22459 | 12:42:56 INFO - PROCESS | 22459 | __start_tp_report 12:42:56 INFO - PROCESS | 22459 | _x_x_mozilla_page_load 12:42:56 INFO - PROCESS | 22459 | _x_x_mozilla_page_load_details 12:42:56 INFO - PROCESS | 22459 | |i|pagename|runs| 12:42:56 INFO - PROCESS | 22459 | |0;ai-astar;102;113;111;112;112;110;111;112;110;112 12:42:56 INFO - PROCESS | 22459 | |1;audio-beat-detection;141;115;120;177;129;117;138;115;152;115 12:42:56 INFO - PROCESS | 22459 | |2;audio-dft;161;161;159;162;161;161;160;161;160;161 12:42:56 INFO - PROCESS | 22459 | |3;audio-fft;73;84;74;115;75;76;73;75;110;74 12:42:56 INFO - PROCESS | 22459 | |4;audio-oscillator;84;83;106;84;84;85;122;83;85;124 12:42:56 INFO - PROCESS | 22459 | |5;imaging-gaussian-blur;117;117;116;116;117;117;119;118;118;116 12:42:56 INFO - PROCESS | 22459 | |6;imaging-darkroom;146;146;145;145;145;146;145;146;146;145 12:42:56 INFO - PROCESS | 22459 | |7;imaging-desaturate;96;95;95;94;95;95;95;95;95;95 12:42:56 INFO - PROCESS | 22459 | |8;json-parse-financial;54;52;52;53;52;53;53;53;53;52 12:42:56 INFO - PROCESS | 22459 | |9;json-stringify-tinderbox;62;63;62;62;64;63;63;63;63;62 12:42:56 INFO - PROCESS | 22459 | |10;stanford-crypto-aes;84;76;75;76;84;77;75;75;74;82 12:42:56 INFO - PROCESS | 22459 | |11;stanford-crypto-ccm;122;125;128;126;119;121;127;132;159;129 12:42:56 INFO - PROCESS | 22459 | |12;stanford-crypto-pbkdf2;159;156;156;157;156;160;156;157;156;156 12:42:56 INFO - PROCESS | 22459 | |13;stanford-crypto-sha256-iterative;62;63;63;64;62;65;61;64;60;62 12:42:56 INFO - PROCESS | 22459 | __end_tp_report 12:42:56 INFO - PROCESS | 22459 | __start_cc_report 12:42:56 INFO - PROCESS | 22459 | _x_x_mozilla_cycle_collect,1677 12:42:56 INFO - PROCESS | 22459 | __end_cc_report 12:42:56 INFO - PROCESS | 22459 | __startTimestamp1468611776734__endTimestamp 12:42:56 INFO - PROCESS | 22459 | 12:42:56 INFO - PROCESS | 22459 | ------- Summary: start ------- 12:42:56 INFO - PROCESS | 22459 | Number of tests: 14 12:42:56 INFO - PROCESS | 22459 | 12:42:56 INFO - PROCESS | 22459 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.14 (2.8%) stddev-sans-first:1.01 12:42:56 INFO - PROCESS | 22459 | Values: 102.0 113.0 111.0 112.0 112.0 110.0 111.0 112.0 110.0 112.0 12:42:56 INFO - PROCESS | 22459 | 12:42:56 INFO - PROCESS | 22459 | [#1] audio-beat-detection Cycles:10 Average:131.90 Median:133.50 stddev:20.51 (15.4%) stddev-sans-first:21.49 12:42:56 INFO - PROCESS | 22459 | Values: 141.0 115.0 120.0 177.0 129.0 117.0 138.0 115.0 152.0 115.0 12:42:56 INFO - PROCESS | 22459 | 12:42:56 INFO - PROCESS | 22459 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 12:42:56 INFO - PROCESS | 22459 | Values: 161.0 161.0 159.0 162.0 161.0 161.0 160.0 161.0 160.0 161.0 12:42:56 INFO - PROCESS | 22459 | 12:42:56 INFO - PROCESS | 22459 | [#3] audio-fft Cycles:10 Average:82.90 Median:74.50 stddev:15.96 (21.4%) stddev-sans-first:16.52 12:42:56 INFO - PROCESS | 22459 | Values: 73.0 84.0 74.0 115.0 75.0 76.0 73.0 75.0 110.0 74.0 12:42:56 INFO - PROCESS | 22459 | 12:42:56 INFO - PROCESS | 22459 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:84.00 stddev:16.77 (20.0%) stddev-sans-first:17.40 12:42:56 INFO - PROCESS | 22459 | Values: 84.0 83.0 106.0 84.0 84.0 85.0 122.0 83.0 85.0 124.0 12:42:56 INFO - PROCESS | 22459 | 12:42:56 INFO - PROCESS | 22459 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.99 (0.8%) stddev-sans-first:1.05 12:42:56 INFO - PROCESS | 22459 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 119.0 118.0 118.0 116.0 12:42:56 INFO - PROCESS | 22459 | 12:42:56 INFO - PROCESS | 22459 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 12:42:56 INFO - PROCESS | 22459 | Values: 146.0 146.0 145.0 145.0 145.0 146.0 145.0 146.0 146.0 145.0 12:42:56 INFO - PROCESS | 22459 | 12:42:56 INFO - PROCESS | 22459 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 12:42:56 INFO - PROCESS | 22459 | Values: 96.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 12:42:56 INFO - PROCESS | 22459 | 12:42:56 INFO - PROCESS | 22459 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:0.67 (1.3%) stddev-sans-first:0.53 12:42:56 INFO - PROCESS | 22459 | Values: 54.0 52.0 52.0 53.0 52.0 53.0 53.0 53.0 53.0 52.0 12:42:56 INFO - PROCESS | 22459 | 12:42:56 INFO - PROCESS | 22459 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 12:42:56 INFO - PROCESS | 22459 | Values: 62.0 63.0 62.0 62.0 64.0 63.0 63.0 63.0 63.0 62.0 12:42:56 INFO - PROCESS | 22459 | 12:42:56 INFO - PROCESS | 22459 | [#10] stanford-crypto-aes Cycles:10 Average:77.80 Median:76.50 stddev:3.94 (5.1%) stddev-sans-first:3.48 12:42:56 INFO - PROCESS | 22459 | Values: 84.0 76.0 75.0 76.0 84.0 77.0 75.0 75.0 74.0 82.0 12:42:56 INFO - PROCESS | 22459 | 12:42:56 INFO - PROCESS | 22459 | [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:127.50 stddev:11.31 (8.9%) stddev-sans-first:11.73 12:42:56 INFO - PROCESS | 22459 | Values: 122.0 125.0 128.0 126.0 119.0 121.0 127.0 132.0 159.0 129.0 12:42:56 INFO - PROCESS | 22459 | 12:42:56 INFO - PROCESS | 22459 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.90 Median:156.50 stddev:1.45 (0.9%) stddev-sans-first:1.32 12:42:56 INFO - PROCESS | 22459 | Values: 159.0 156.0 156.0 157.0 156.0 160.0 156.0 157.0 156.0 156.0 12:42:56 INFO - PROCESS | 22459 | 12:42:56 INFO - PROCESS | 22459 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:1.51 (2.4%) stddev-sans-first:1.58 12:42:56 INFO - PROCESS | 22459 | Values: 62.0 63.0 63.0 64.0 62.0 65.0 61.0 64.0 60.0 62.0 12:42:56 INFO - PROCESS | 22459 | -------- Summary: end -------- 12:42:56 INFO - PROCESS | 22459 | 12:42:57 INFO - TEST-INFO | 22459: exit 0 12:42:57 INFO - TEST-OK | kraken | took 60598ms 12:42:57 INFO - SUITE-END | took 1173s 12:42:57 INFO - Completed test suite (00:19:33) 12:42:57 INFO - javascript benchmark 12:42:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2981.8956336528217, 2995.251187203199, 3029.5910052142967, 3031.136126204032, 3038.4986477231246, 5125.256837758532, 5178.896422071556, 5197.116490196666, 5248.685078895264, 5314.9468505314935, 5193.870153246171, 5215.400228973669, 5228.686278823273, 5259.579233661308, 5271.393789714184, 4690.0854333405, 4747.0, 4754.191787396151, 4765.237561990082, 4903.558679718824, 4841.152798260308, 4853.272009198631, 4875.926861097087, 4901.730404827733, 4921.0, 4668.393108895839, 4683.063387322532, 4726.621870250389, 4772.451168115676, 4796.856094317176, 4712.458067322267, 4714.4106986626675, 4720.291956206596, 4723.6929599575915, 4815.566599006072, 4721.079389519045, 4728.976355118237, 4746.52534746526, 4748.738819364934, 4750.406199225097, 5105.081085404626, 5222.843314700565, 5268.947310526884, 5300.867478313035, 5309.362876454811, 5614.606977511576, 5645.379008309083, 5676.914846277309, 5677.517411020068, 5678.943210567924, 5711.371749107595, 5733.340665823442, 5745.770169193269, 5750.45370689788, 5751.884962300773, 5101.056304583664, 5220.530152286313, 5289.920651190235, 5291.391489978663, 5313.654612450178, 5764.423557644202, 5815.82552523425, 5820.126980952891, 5824.068149096124, 5826.067829147316, 5348.1175606025345, 5581.972090139523, 5588.329400471969, 5592.077307244341, 5592.944070559323, 5513.58648101394, 5553.611247212737, 5555.833325000256, 5626.803061892814, 5632.239647647597, 5546.972265138648, 5550.750216240279, 5552.278203833475, 5554.139108438118, 5554.972225138848, 5440.564754819605, 5464.508194262536, 5547.611667183339, 5550.389457159709, 5554.444555544414, 4304.78476076195, 4331.0, 4332.740035597874, 4345.261305578059, 4373.584509471595, 3827.8468861245237, 3837.3860182370686, 3846.1346197105986, 3879.980600097038, 3890.6109389060866, 5189.532942035235, 5244.108501554745, 5249.42256351801, 5357.973210133924, 5358.571314294847, 5587.078132108238, 5644.153376993484, 5648.265725455747, 5675.063614503643, 5718.857028574319, 5313.814016509404, 5332.33345831771, 5342.839714808562, 5347.652402593897, 5349.518543331119, 4735.573798358096, 4784.928226076611, 4825.638077144228, 4894.95105048945, 4929.211326187793, 5773.624714393551, 5777.653340799566, 5777.797777077866, 5781.19063331134, 5821.563382746311, 5607.607467477237, 5619.775208991595, 5619.8876022480135, 5620.04459241938, 5623.184638227516, 5628.0, 5639.2668953035845, 5656.575756818337, 5689.118186681071, 5770.0, 5372.838814835562, 5391.81128660495, 5441.183822426668, 5444.210589464426, 5445.319335083114, 5497.47773961473, 5534.308211473566, 5549.694766787704, 5551.111822108443, 5606.607537472338, 5295.655782374133, 5435.83692489226, 5444.782208711607, 5446.537044351275, 5480.150576660624, 5454.4545545445135, 5467.835964921059, 5512.0, 5520.309961254843, 5522.806701765419, 5283.0, 5451.64564303319, 5495.148252020943, 5510.559155267489, 5562.749676264659, 5369.597280203922, 5459.181122831448, 5461.508464238238, 5463.4263402342185, 5518.53092487127, 5321.787128514971, 5321.787128514971, 5331.040412725747, 5332.360116786011, 5338.706371149624], "value": 5163.656687916115, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.217289264617, 604.274870155813, 609.1259043272906, 647.0811447744203, 654.9541532092755, 31136.221594460123, 33211.0, 33257.33485330292, 33274.33451330975, 43185.568144318546, 41950.790246048724, 44715.329270060975, 45036.0, 45049.099018019704, 45056.774716126376, 8881.378303518757, 9020.413673111227, 9039.231665308456, 9066.501342426163, 9071.183593476586, 8859.822803543926, 8950.731478055635, 8974.50640214788, 8978.41640293382, 8981.820363592724, 8999.325050621197, 9040.593173307218, 9044.095590440937, 9051.366404351666, 9054.909450905472, 8980.46117232965, 9015.0, 9027.4132181408, 9034.954825225897, 9038.774030649254, 8642.395032347738, 8705.260052895512, 8708.0, 8916.420432671921, 8956.8656470153, 42547.36178957318, 42836.57163428357, 42886.0, 42951.0, 42967.0, 3490.5636795400574, 3680.576733675635, 3774.1885494618787, 3993.98003009986, 4214.536400995888, 32870.16092548301, 33498.49752253718, 33681.326373472395, 33747.662523374696, 34110.48834267488, 4494.438195225597, 4574.359589657451, 4586.449626044862, 4631.698939568917, 4709.858704238878, 383335.0, 386936.0, 388514.0, 389132.0, 389270.0, 59180.0, 59265.0, 59323.406765932654, 59379.40620593739, 59572.40427595669, 59971.0, 60592.69703651542, 60798.69600651968, 60969.0, 60972.69513652403, 17138.485845424657, 17278.30886764515, 17390.913045434692, 17400.0, 17413.738793917848, 12235.143539952296, 12236.755264894653, 12237.510499579917, 12238.571649992207, 12246.326452045223, 14480.493182738554, 16185.0, 16270.837291626933, 16310.0, 16452.424165154163, 6017.879642407215, 6100.389961003864, 6155.4767844732805, 6252.906206406908, 6263.874722505524, 755.2088515651399, 1015.9796804063877, 1026.7227848480868, 1073.270176280137, 1115.0633467887014, 32785.836070819496, 32904.67095329016, 33093.0, 33217.3356532868, 33845.0, 1083.772407794372, 1108.667399780079, 1127.1095834290982, 1180.527788884453, 1247.7255003899127, 16651.6669666606, 16946.152692365333, 17079.48761537156, 17108.401205957733, 17241.310347586208, 573251.0, 573514.0, 577115.0, 577459.0, 577526.0, 59949.70025149846, 60128.0, 60141.69929150326, 60188.398116019154, 60507.394926051056, 1213.5995121609847, 1309.5678426119357, 1316.973660526784, 1342.4227582139579, 1355.823742913415, 32565.674343256265, 33843.66156338405, 33903.32193356168, 33995.49006764851, 34367.312653747285, 48232.0, 48524.0, 48558.75720621374, 48589.5141048585, 49045.0, 392068.0, 399917.0, 400203.0, 401345.89232860715, 402665.0, 35707.28585428225, 36267.0, 41237.0, 44241.55758442375, 45111.774441127585, 47458.52541474679, 48461.75769121132, 48517.27224091571, 48829.0, 49325.0, 41146.58853411547, 42015.27083510175, 42226.36660450157, 42284.15431691287, 42461.787691062586, 40984.79507602443, 42237.57762422336, 42279.788601056796, 42669.14661706811, 42872.35691464693, 39983.400248995706, 40873.795631021654, 41809.37285940774, 41973.37039944464, 42090.789546052074, 36259.274814503035, 37215.0, 37759.0, 38319.80840095893, 38426.807865960494, 27577.586336205375, 28078.71921280761, 28099.859500702365, 28188.43623127485, 28199.577006344512], "value": 20309.79967882746, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.59234664949685, 379.89932667843044, 398.44814931320116, 400.7194963525533, 416.15520493398395, 13645.2638741662, 18934.0, 20566.69149962752, 20609.793902060974, 21541.569168616617, 15557.455489057886, 19864.70202946957, 19932.202711891507, 20344.08451619677, 20727.274545390916, 5661.377248502672, 5833.504152147073, 5863.472287494124, 5895.233619629464, 5904.616199947011, 5802.5938184327115, 5863.736131874076, 5865.560082993771, 5867.589268751189, 5870.70646467677, 4266.168097221043, 6138.171346868183, 6481.935180648204, 6482.319356467574, 6629.602223866559, 6274.435300822902, 6473.608174242513, 6558.639274839882, 6576.375244351779, 6606.9669651651675, 5693.572982026365, 5716.942830571683, 5719.227904232917, 5737.799177028784, 5737.885242295172, 24903.0, 24946.750532494625, 25264.494710105693, 25689.0, 25777.0, 2429.708434987795, 2521.3318470605304, 2548.923532294034, 3233.224026233687, 3287.474004159323, 14306.57080287593, 15185.848141518554, 15550.688986220326, 15911.761323580156, 15931.442399516078, 1928.7203355513511, 1985.3944546913185, 1996.930107446247, 2015.133492598182, 2018.6265540874986, 87902.0, 88295.55852220762, 88376.99999999936, 89022.10977890203, 89885.0, 10346.085974094816, 10423.166146708245, 10656.62701805433, 10815.134789216843, 11067.280626759235, 14824.332905019084, 14867.256637168099, 14893.553193404216, 14894.329755161043, 14918.552443426715, 8310.21052999964, 8344.374171937128, 8464.873026904601, 8684.305255579538, 8727.04002559718, 8326.375521835887, 8358.164183581594, 8543.700970466003, 8713.0, 8726.563671816384, 6117.265928088569, 6354.809355719336, 6397.616143031433, 6638.502112341594, 6784.21981472137, 1781.416945429133, 1868.2807119259182, 1881.1628825172668, 1890.981090189108, 1941.6213838301678, 433.60325302347997, 434.24874966308465, 892.4511425473287, 1017.2980643356061, 1025.1747343388645, 11782.764344713229, 12470.314132722788, 12549.87450125487, 12624.684382890318, 12863.163894346837, 449.29909341427475, 463.9141758774638, 467.40172579098805, 476.67109694311506, 493.05825872583193, 6650.634215118118, 6715.966420167965, 6809.93190068093, 6814.250432452426, 6853.971904214408, 342197.73406797834, 349595.87659670034, 517601.0, 522036.0, 530449.0, 88648.5567572158, 101148.49425752972, 104363.0, 105057.0, 105527.0, 460.56936764126317, 460.6153861525664, 467.7193683789767, 469.3991690635991, 469.67592361270613, 11461.140414469115, 11498.310101393943, 11854.703632409259, 11944.223625464318, 12003.579874704343, 43716.12567748691, 44262.778686106365, 45620.77189614031, 45744.77127614474, 46395.0, 58571.0, 67343.32656673371, 67799.0, 67904.0, 69246.0, 8842.46945183291, 8857.395925597895, 9196.310276729138, 9274.072592740671, 9287.303452241244, 10915.345079295268, 13912.095713778572, 14193.645158871112, 14208.360623771749, 14437.639059023608, 12230.0, 12375.133740638068, 12584.811227831773, 12716.173448725804, 12740.808887866875, 12372.257664540157, 12488.875111248772, 12681.23912565249, 12912.612621621367, 12913.806292905427, 12181.573644922386, 12595.0, 12731.93634031824, 12975.0, 12982.35088245565, 9123.087691231089, 9123.178913897782, 9133.31500137479, 9139.268858491438, 9228.169464748205, 12030.27818330903, 12471.189372690746, 12490.937545312216, 12504.624861254177, 12647.87352126467], "value": 8957.143623986129, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1483.3547406878006, 1509.433962264151, 1634.8365163483654, 1751.3344928927006, 1792.2741289777637, 8276.83446331073, 8683.956580217091, 8818.77953051174, 8833.381663283573, 8839.469631822096, 7390.0, 8146.103928567868, 8359.582020898946, 8382.538960357178, 8656.17766312201, 2263.864168149908, 2286.371247906831, 2287.3938406322254, 2288.8741119238434, 2291.6218823894037, 2230.587341341857, 2235.508188198594, 2263.671767593698, 2267.0, 2269.8524595901295, 1917.6452356314057, 2190.299104286629, 2258.559580881729, 2263.8981245843893, 2265.9660105098437, 2199.8900054997184, 2210.613142700029, 2211.8119959803435, 2221.4113259985957, 2224.4327696437385, 2191.934241972743, 2196.670499425083, 2197.198022721711, 2202.7246594175726, 2205.9852467864803, 8481.321494280442, 8514.063453020162, 8544.829103417896, 8549.957250213709, 8573.571321433965, 4713.929291060636, 4895.069936712049, 4903.338049363361, 4932.457429682732, 4950.4307004694565, 3113.7041981011766, 3187.9043628691174, 3259.940519331227, 3285.0, 3292.1440425489304, 1028.4240825137947, 1034.348360532867, 1043.269711202154, 1063.2132222155626, 1075.8655168103987, 11941.343226122559, 11947.0, 11947.880521194764, 11987.400629968466, 11995.340256285988, 4128.793560321972, 4306.806193721228, 4323.654107671378, 4409.404730361424, 4447.132809102194, 10044.096031357212, 10070.093691567794, 10083.092521673085, 10099.69700908974, 10111.949440252753, 4999.250112483157, 5006.4492905780335, 5008.198688209869, 5024.422191447957, 5027.346444962204, 4516.638668906479, 4586.082783443325, 4586.128635559233, 4586.220342541776, 4632.444106707217, 3832.5209348831395, 3835.0, 3847.03824043989, 3935.0359162005493, 3951.4863067801575, 1063.8829728729834, 1164.714644912002, 1171.6485054483792, 1176.3588844079998, 1198.7842188405996, 921.2629896083241, 998.610541888664, 1011.701548043329, 1044.7231483656838, 1050.2251195479614, 6011.428914253139, 6160.845978850564, 6330.05049242608, 6366.0, 6381.266154392211, 960.2222200018008, 983.233078199006, 1001.3491230699958, 1021.1983592879702, 1036.0520124086527, 4188.5026003286985, 4335.674824388184, 4350.608445239944, 4392.626626736763, 4418.779061046935, 10374.481275936172, 10796.0, 10899.29154604964, 10902.5093870776, 10903.781924361627, 10483.318584291997, 10663.4135122569, 10769.78460430787, 10769.784604308026, 10772.138228941665, 7937.2459616336355, 8048.718294859769, 8079.596020199084, 8125.187481251827, 8140.5929703514585, 5883.382244864228, 5939.524838013035, 6060.606060606046, 6092.908606370819, 6199.690015499297, 8971.327150463872, 9564.426134431678, 9733.075357840993, 9741.366811157252, 9748.805023899624, 9848.113669769755, 10092.697219083439, 10100.141487973604, 10239.385636861813, 10256.794864102527, 7682.347000504796, 7683.4621576491345, 7684.269994350528, 7764.107127680389, 7833.882491762514, 8358.916410835815, 8408.579571021302, 8461.703840365557, 8468.44955077918, 8490.745277641681, 7435.219301973431, 7451.701931922879, 7682.116556596063, 7734.265244801735, 7865.528068315919, 7422.369098626677, 7591.127020392725, 7645.923540764521, 7654.61726913641, 7825.960870195612, 7165.176004759519, 7175.2465991070185, 7203.71185152588, 7204.3155900189395, 7204.459665525002, 5324.8136315228785, 5336.919946200887, 5434.278446921555, 5468.234447177478, 5521.944780552143, 5303.390110137384, 5357.223202635518, 5388.541973932103, 5503.229547863222, 5519.227308176939], "value": 4569.545526643228, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.75374577211113, 313.61738678811844, 317.4048658764816, 319.697885498204, 321.75546584595713, 5334.653247538912, 5375.193720941861, 5408.0, 5414.0, 5432.293801805759, 5339.252504649352, 5356.8304836541165, 5359.330083739533, 5396.217548455482, 5401.108817045193, 3944.309745794482, 3991.2217117662067, 4089.20260549193, 4091.365838295069, 4138.896527586804, 4057.8985525361954, 4099.487564054493, 4108.26051310764, 4125.814338354766, 4140.234056699505, 3981.124152686404, 4115.670746340301, 4129.380592911058, 4146.129312844307, 4150.9584904151025, 3970.404439334094, 4053.675705943532, 4071.943668447415, 4074.6129117734063, 4078.6940979426663, 3523.2248905241063, 3540.946885796715, 3542.291541691672, 3543.131932676485, 3545.3795585772386, 5185.585153187773, 5189.948100518985, 5200.869978250536, 5202.687838729688, 5218.556422704075, 4451.577100175478, 4596.643990022918, 4611.423572053493, 4614.953850461519, 4644.210484217691, 5445.564354851603, 5463.426340234298, 5487.807926722586, 5511.0, 5524.33707955044, 3884.8251828667494, 3886.514185726784, 3888.2782052563034, 3893.396523538856, 3903.882883513471, 5499.3675727291475, 5735.684537350444, 5744.597878148531, 5806.44838740319, 5813.593048486608, 3939.625735555118, 3941.6649584785614, 3943.881683549498, 3963.3460479021214, 3997.560268370477, 3975.8210880510446, 4018.457508236351, 4031.475908131924, 4041.3533834586915, 4072.979635101865, 4505.684602077823, 4671.48613652498, 4681.180793361148, 4710.199266124767, 4715.669903106818, 5496.615236933376, 5497.202905578749, 5499.972500137474, 5508.779648814003, 5589.664620122806, 1390.9165450072826, 1401.7196560687698, 1422.5945605502588, 1437.252628633105, 1440.9265097502428, 930.851063829784, 947.4362754161263, 950.843110886696, 964.3490643815396, 972.8443449048118, 5334.626576139711, 5344.385395679469, 5357.249985002103, 5366.651167674088, 5367.0, 5618.831435056954, 5619.381867994517, 5619.831405057855, 5630.577706672016, 5637.43625637433, 5154.92267615986, 5311.389190243094, 5334.466553344634, 5337.2527846101575, 5344.091504444254, 2979.3594377209006, 2997.175776661392, 3004.062379765083, 3004.504256797604, 3026.3947210557535, 5544.500994910478, 5787.131930210502, 5791.739371728282, 5808.30300363959, 5824.883502330014, 5708.401647538696, 5717.799877004285, 5729.54163666914, 5751.281089863767, 5763.596548241583, 5801.796937107265, 5818.272715910512, 5841.766329346863, 5863.618864773776, 5866.941330586725, 5458.536024437808, 5676.013395311608, 5682.801101961411, 5809.618056596775, 5818.359980402237, 5703.315602127605, 5726.484616384545, 5741.368449470471, 5752.309722833287, 5755.1942728017275, 5702.0, 5921.5558833086825, 5941.643501389931, 5953.404659534012, 6031.341381120227, 3958.445817585483, 3967.0479085019965, 3971.7021223407783, 3980.800959951933, 3994.7403418777685, 5723.112917497794, 5749.281339832521, 5752.395998420106, 5754.05058165398, 5756.9061878243, 5472.288602481652, 5609.747561359667, 5628.465295796893, 5648.830535083954, 5653.773849045992, 5530.0, 5545.140503222007, 5582.441755824385, 5610.242617246619, 5620.8032718856275, 5296.814611488579, 5368.731563421891, 5520.006398848246, 5527.53015993645, 5607.299087614048, 5637.267155269788, 5643.943560564342, 5649.293838270216, 5661.2923384576925, 5729.341125770589, 5530.972345138249, 5552.666839989613, 5555.8610484851315, 5602.607817452739, 5627.0], "value": 4217.5016226109965, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.0354616954255, 813.5810057820223, 846.9280111190549, 854.1159899504007, 856.6616186606291, 12046.216995895282, 13127.0, 14738.852611473882, 15196.240187990597, 15220.0, 14906.0, 15613.375464981416, 15628.687426251468, 15631.765523517157, 15644.452444164457, 640.4492136762381, 663.0154220981838, 764.6482617995715, 772.6291380137537, 791.1771757372326, 785.0030461314128, 788.7397158937565, 790.2255789326434, 791.2404092071589, 791.7901756034655, 847.7117779954814, 848.0501837941514, 848.452747977554, 848.9490630562156, 849.1890244816186, 838.739990602912, 840.3361344537808, 840.5755093677715, 840.7015509494164, 840.970566030189, 608.5679167790829, 608.8386577556951, 609.881073190728, 610.2006371653149, 610.2890132995055, 13911.30443477822, 13925.0, 13925.0, 13936.0, 13938.442462301497, 15413.3834646614, 15695.618145612705, 15722.921385393114, 15877.682446351007, 15954.76067858983, 12120.27278363301, 12317.22514882654, 12395.690107747288, 12425.37873106341, 12737.235765854079, 3869.8839034829, 3880.2627500775043, 3908.706846986459, 3950.0914789598264, 4050.5949405059555, 45250.321245181345, 68034.31965680329, 68299.65850170767, 78527.60736196283, 83010.0, 12226.816597751042, 12360.196587221802, 12375.319357435248, 12491.0, 12701.047421443429, 22429.66355504669, 22495.775042249366, 22615.54768904613, 22617.660735088986, 22647.0, 8555.572221388906, 8982.685606003759, 9165.0, 9206.585703643352, 9273.304502162366, 4891.954845021854, 4939.160342741742, 5017.54842064216, 5094.49055094495, 5126.5898728101665, 3422.093145316493, 3501.3347463981763, 3504.0889368764306, 3509.263054758478, 3522.066652337133, 589.3046205477577, 590.1354515634616, 601.7592962814822, 605.9394060593905, 615.0006239860227, 722.3174100475105, 741.4365082537311, 777.3314949143731, 778.6418247606051, 813.0081300812999, 9577.952110239405, 10298.845517317246, 10383.584656613803, 10546.525406356732, 10588.205884558689, 764.6635480388722, 777.6980730699757, 786.170590027515, 789.5984627286613, 794.9562774047367, 4626.190416677068, 4819.445763737145, 4843.685160464559, 4864.82973095947, 4875.293082503017, 109826.90173098327, 113069.0, 115842.0, 119486.0, 124402.37798810948, 60336.69831650814, 73212.0, 88966.11033889579, 91734.0, 107399.46300268448, 88719.55640221758, 90744.54627726952, 92493.53753231191, 93426.0, 94614.99999999862, 10408.603008658849, 10720.785584288114, 10783.299085559414, 10828.620998265023, 10838.458077096271, 50140.49859501358, 50968.49031509786, 51206.0, 51871.481285186666, 52111.436656900354, 66088.66955665383, 70851.0, 76765.0, 77057.0, 77668.61165694136, 13762.724745505235, 13850.792238116235, 13930.164190148624, 14068.155910645393, 14411.711765764416, 13875.098118622258, 14754.188519631523, 14828.110313381232, 15365.846341536888, 15854.7621785671, 14528.0, 14626.634334141732, 14903.552893413214, 14988.700225995637, 15498.612534686723, 14337.56987290383, 14394.424223030961, 14885.479008234659, 15092.169930653481, 15787.763183552486, 14252.71494570082, 14434.350454229374, 14608.488702895347, 14621.853781462049, 14790.260486975392, 11595.536178552764, 11644.6506604802, 11842.340463564198, 11979.221350612183, 12063.21589096706, 11984.0, 12187.451564679433, 12220.388980551115, 12423.192492487959, 12655.177413468095], "value": 7728.243379533256, "unit": "score"}], "name": "dromaeo_css", "value": 7205.232843672726, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 111.0, 112.0, 112.0, 110.0, 111.0, 112.0, 110.0, 112.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 115.0, 120.0, 177.0, 129.0, 117.0, 138.0, 115.0, 152.0, 115.0], "value": 131.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 162.0, 161.0, 161.0, 160.0, 161.0, 160.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 84.0, 74.0, 115.0, 75.0, 76.0, 73.0, 75.0, 110.0, 74.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 106.0, 84.0, 84.0, 85.0, 122.0, 83.0, 85.0, 124.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 119.0, 118.0, 118.0, 116.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 52.0, 53.0, 52.0, 53.0, 53.0, 53.0, 53.0, 52.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 64.0, 63.0, 63.0, 63.0, 63.0, 62.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 76.0, 75.0, 76.0, 84.0, 77.0, 75.0, 75.0, 74.0, 82.0], "value": 77.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 125.0, 128.0, 126.0, 119.0, 121.0, 127.0, 132.0, 159.0, 129.0], "value": 128.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 156.0, 156.0, 157.0, 156.0, 160.0, 156.0, 157.0, 156.0, 156.0], "value": 156.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 64.0, 62.0, 65.0, 61.0, 64.0, 60.0, 62.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1479.1, "alertThreshold": 2.0}]} 12:42:57 INFO - Return code: 0 12:42:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:42:58 INFO - # TBPL SUCCESS # 12:42:58 INFO - Running post-action listener: _resource_record_post_action 12:42:58 INFO - ##### 12:42:58 INFO - ##### Finished run-tests step (success) 12:42:58 INFO - ##### 12:42:58 INFO - Running post-run listener: _resource_record_post_run 12:42:58 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 558321664; Read time: 12; Write time: 429464 12:42:58 INFO - TinderboxPrint: CPU usage
13.0% 12:42:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 12:42:58 INFO - TinderboxPrint: I/O write bytes / time
558,321,664 / 429,464 12:42:58 INFO - TinderboxPrint: CPU idle
8,272.6 (87.0%) 12:42:58 INFO - TinderboxPrint: CPU user
1,192.3 (12.5%) 12:42:58 INFO - TinderboxPrint: Swap in / out
0 / 0 12:42:58 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 260247552; Read time: 0; Write time: 221836 12:42:58 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 297459712; Read time: 0; Write time: 207532 12:42:58 INFO - Running post-run listener: _upload_blobber_files 12:42:58 INFO - Blob upload gear active. 12:42:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:42:58 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 12:42:58 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:42:58 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:42:59 INFO - (blobuploader) - INFO - Open directory for files ... 12:42:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:42:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:42:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:42:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:42:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:42:59 INFO - (blobuploader) - INFO - Done attempting. 12:42:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:42:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:42:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:43:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:43:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:43:03 INFO - (blobuploader) - INFO - Done attempting. 12:43:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:43:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:43:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:43:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:43:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:43:04 INFO - (blobuploader) - INFO - Done attempting. 12:43:04 INFO - (blobuploader) - INFO - Iteration through files over. 12:43:04 INFO - Return code: 0 12:43:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:43:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:43:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b62d485d8c2114262c03e1c986ebb3cdc80a3bd7a9fb6453e900c1ccda0a387b58cdcc1c0c789dad8b9267fa188b0e3186963e17b0352fb6a8698a87613f593b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aef6d5b8427413790e03b499dfb6560bd193074a1cd7758402868606debe9b64bb30ad51af24c9cd7b3dcbae4e8fe83729136337a39889ff50b4be2f1d427dee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5d253b74dd13c4d12f02e044c8ab0cbceae06d803bf6c7099599770cf2d14e89271a752070f119f4f903978dbb9f3de25e20a68120a263cad73d8644a66ad9f8"} 12:43:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:43:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:43:04 INFO - Contents: 12:43:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b62d485d8c2114262c03e1c986ebb3cdc80a3bd7a9fb6453e900c1ccda0a387b58cdcc1c0c789dad8b9267fa188b0e3186963e17b0352fb6a8698a87613f593b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aef6d5b8427413790e03b499dfb6560bd193074a1cd7758402868606debe9b64bb30ad51af24c9cd7b3dcbae4e8fe83729136337a39889ff50b4be2f1d427dee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5d253b74dd13c4d12f02e044c8ab0cbceae06d803bf6c7099599770cf2d14e89271a752070f119f4f903978dbb9f3de25e20a68120a263cad73d8644a66ad9f8"} 12:43:04 INFO - Running post-run listener: copy_logs_to_upload_dir 12:43:04 INFO - Copying logs to upload dir... 12:43:04 INFO - mkdir: /builds/slave/test/build/upload/logs 12:43:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.555152 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-15 12:43:04.096217) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 12:43:04.099373) ========= 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=6dbc10da6d83fee962c624be000001a8-1468610552.322440-878699086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b62d485d8c2114262c03e1c986ebb3cdc80a3bd7a9fb6453e900c1ccda0a387b58cdcc1c0c789dad8b9267fa188b0e3186963e17b0352fb6a8698a87613f593b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aef6d5b8427413790e03b499dfb6560bd193074a1cd7758402868606debe9b64bb30ad51af24c9cd7b3dcbae4e8fe83729136337a39889ff50b4be2f1d427dee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5d253b74dd13c4d12f02e044c8ab0cbceae06d803bf6c7099599770cf2d14e89271a752070f119f4f903978dbb9f3de25e20a68120a263cad73d8644a66ad9f8"} build_url:https://queue.taskcluster.net/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011315 build_url: 'https://queue.taskcluster.net/v1/task/VTwjeG5dR3mkqtWCYfW1GQ/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/Mozilla-Inbound/sha512/b62d485d8c2114262c03e1c986ebb3cdc80a3bd7a9fb6453e900c1ccda0a387b58cdcc1c0c789dad8b9267fa188b0e3186963e17b0352fb6a8698a87613f593b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aef6d5b8427413790e03b499dfb6560bd193074a1cd7758402868606debe9b64bb30ad51af24c9cd7b3dcbae4e8fe83729136337a39889ff50b4be2f1d427dee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5d253b74dd13c4d12f02e044c8ab0cbceae06d803bf6c7099599770cf2d14e89271a752070f119f4f903978dbb9f3de25e20a68120a263cad73d8644a66ad9f8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 12:43:04.125316) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:43:04.125679) ========= 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=6dbc10da6d83fee962c624be000001a8-1468610552.322440-878699086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:43:04.208162) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 12:43:04.208505) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 12:43:04.208823) ========= ========= Total master_lag: 0.16 =========