builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1467707178.09 results: success (0) buildid: 20160704222341 builduid: 37d9f57766f9485088cef5c8f2f414c0 revision: 441bc4305490 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 01:26:18.085767) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 01:26:18.086205) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 01:26:18.086505) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 01:26:18.209879) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 01:26:18.210161) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467705108.220271-1322865100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 01:26:18-- 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% 225M=0s 2016-07-05 01:26:18 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181535 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 01:26:18.430487) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 01:26:18.430834) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467705108.220271-1322865100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.073441 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 01:26:18.516650) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 01:26:18.517481) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 441bc4305490 --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 441bc4305490 --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=516f8d7ca085b4d087ab0a71000001a4-1467705108.220271-1322865100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 01:26:18,554 Setting DEBUG logging. 2016-07-05 01:26:18,554 attempt 1/10 2016-07-05 01:26:18,554 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/441bc4305490?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 01:26:18,858 unpacking tar archive at: mozilla-inbound-441bc4305490/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646008 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 01:26:19.185049) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 01:26:19.185353) ========= script_repo_revision: 441bc4305490 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 01:26:19.185749) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 01:26:19.186025) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 01:26:19.197055) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-05 01:26:19.197357) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=516f8d7ca085b4d087ab0a71000001a4-1467705108.220271-1322865100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:26:19 INFO - MultiFileLogger online at 20160705 01:26:19 in /builds/slave/test 01:26:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 01:26:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:26:19 INFO - {'append_to_log': False, 01:26:19 INFO - 'base_work_dir': '/builds/slave/test', 01:26:19 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:26:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:26:19 INFO - 'branch': 'Mozilla-Inbound', 01:26:19 INFO - 'buildbot_json_path': 'buildprops.json', 01:26:19 INFO - 'config_files': ('talos/linux_config.py',), 01:26:19 INFO - 'default_actions': ('clobber', 01:26:19 INFO - 'read-buildbot-config', 01:26:19 INFO - 'download-and-extract', 01:26:19 INFO - 'populate-webroot', 01:26:19 INFO - 'create-virtualenv', 01:26:19 INFO - 'install', 01:26:19 INFO - 'run-tests'), 01:26:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:26:19 INFO - 'download_minidump_stackwalk': True, 01:26:19 INFO - 'download_symbols': 'ondemand', 01:26:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:26:19 INFO - 'tooltool.py': '/tools/tooltool.py', 01:26:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:26:19 INFO - '/tools/misc-python/virtualenv.py')}, 01:26:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:26:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:26:19 INFO - 'installer_path': 'installer.exe', 01:26:19 INFO - 'log_level': 'info', 01:26:19 INFO - 'log_name': 'talos', 01:26:19 INFO - 'log_to_console': True, 01:26:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:26:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:26:19 INFO - 'opt_config_files': (), 01:26:19 INFO - 'pip_index': False, 01:26:19 INFO - 'sps_profile': False, 01:26:19 INFO - 'sps_profile_interval': 0, 01:26:19 INFO - 'suite': 'dromaeojs-e10s', 01:26:19 INFO - 'system_bits': '32', 01:26:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:26:19 INFO - 'title': 'talos-linux64-ix-061', 01:26:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:26:19 INFO - 'use_talos_json': True, 01:26:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:26:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:26:19 INFO - 'work_dir': 'build'} 01:26:19 INFO - ##### 01:26:19 INFO - ##### Running clobber step. 01:26:19 INFO - ##### 01:26:19 INFO - Running pre-action listener: _resource_record_pre_action 01:26:19 INFO - Running main action method: clobber 01:26:19 INFO - rmtree: /builds/slave/test/build 01:26:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:26:20 INFO - Running post-action listener: _resource_record_post_action 01:26:20 INFO - ##### 01:26:20 INFO - ##### Finished clobber step (success) 01:26:20 INFO - ##### 01:26:20 INFO - ##### 01:26:20 INFO - ##### Running read-buildbot-config step. 01:26:20 INFO - ##### 01:26:20 INFO - Running pre-action listener: _resource_record_pre_action 01:26:20 INFO - Running main action method: read_buildbot_config 01:26:20 INFO - Using buildbot properties: 01:26:20 INFO - { 01:26:20 INFO - "project": "", 01:26:20 INFO - "product": "firefox", 01:26:20 INFO - "script_repo_revision": "production", 01:26:20 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 01:26:20 INFO - "repository": "", 01:26:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 01:26:20 INFO - "buildid": "20160704222341", 01:26:20 INFO - "pgo_build": "True", 01:26:20 INFO - "basedir": "/builds/slave/test", 01:26:20 INFO - "buildnumber": 953, 01:26:20 INFO - "slavename": "talos-linux64-ix-061", 01:26:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:26:20 INFO - "platform": "ubuntu64_hw", 01:26:20 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:26:20 INFO - "branch": "mozilla-inbound", 01:26:20 INFO - "repo_path": "integration/mozilla-inbound", 01:26:20 INFO - "revision": "441bc4305490", 01:26:20 INFO - "stage_platform": "linux64-pgo", 01:26:20 INFO - "builduid": "37d9f57766f9485088cef5c8f2f414c0", 01:26:20 INFO - "slavebuilddir": "test" 01:26:20 INFO - } 01:26:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/QZnkR8GLR7me8Tv07f_loQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:26:20 INFO - Running post-action listener: _resource_record_post_action 01:26:20 INFO - ##### 01:26:20 INFO - ##### Finished read-buildbot-config step (success) 01:26:20 INFO - ##### 01:26:20 INFO - ##### 01:26:20 INFO - ##### Running download-and-extract step. 01:26:20 INFO - ##### 01:26:20 INFO - Running pre-action listener: _resource_record_pre_action 01:26:20 INFO - Running main action method: download_and_extract 01:26:20 INFO - mkdir: /builds/slave/test/build/tests 01:26:20 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')]} 01:26:20 INFO - https://queue.taskcluster.net/v1/task/QZnkR8GLR7me8Tv07f_loQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:26:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZnkR8GLR7me8Tv07f_loQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:26:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZnkR8GLR7me8Tv07f_loQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:26:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZnkR8GLR7me8Tv07f_loQ/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 01:26:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZnkR8GLR7me8Tv07f_loQ/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 01:26:30 INFO - Downloaded 1361 bytes. 01:26:30 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:26:30 INFO - Using the following test package requirements: 01:26:30 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:26:30 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:26:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:26:30 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:26:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:26:30 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:26:30 INFO - u'jsshell-linux-x86_64.zip'], 01:26:30 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:26:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:26:30 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:26:30 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:26:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:26:30 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:26:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:26:30 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:26:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:26:30 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:26:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:26:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:26:30 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')]} 01:26:30 INFO - https://queue.taskcluster.net/v1/task/QZnkR8GLR7me8Tv07f_loQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:26:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZnkR8GLR7me8Tv07f_loQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:26:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZnkR8GLR7me8Tv07f_loQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:26:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZnkR8GLR7me8Tv07f_loQ/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 01:26:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZnkR8GLR7me8Tv07f_loQ/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 01:26:42 INFO - Downloaded 24298565 bytes. 01:26:42 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'] 01:26:42 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 01:26:43 INFO - Return code: 0 01:26:43 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 01:26:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:43 INFO - https://queue.taskcluster.net/v1/task/QZnkR8GLR7me8Tv07f_loQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:26:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZnkR8GLR7me8Tv07f_loQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:26:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZnkR8GLR7me8Tv07f_loQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:26:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZnkR8GLR7me8Tv07f_loQ/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 01:26:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZnkR8GLR7me8Tv07f_loQ/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 01:26:45 INFO - Downloaded 24298565 bytes. 01:26:45 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'] 01:26:45 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 01:26:46 INFO - Return code: 0 01:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:46 INFO - https://queue.taskcluster.net/v1/task/QZnkR8GLR7me8Tv07f_loQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:26:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZnkR8GLR7me8Tv07f_loQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:26:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZnkR8GLR7me8Tv07f_loQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:26:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZnkR8GLR7me8Tv07f_loQ/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 01:26:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZnkR8GLR7me8Tv07f_loQ/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 01:26:47 INFO - Downloaded 14403333 bytes. 01:26:47 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'] 01:26:47 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 01:26:47 INFO - Return code: 0 01:26: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')]} 01:26:47 INFO - https://queue.taskcluster.net/v1/task/QZnkR8GLR7me8Tv07f_loQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:26:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZnkR8GLR7me8Tv07f_loQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:26:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZnkR8GLR7me8Tv07f_loQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:26:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZnkR8GLR7me8Tv07f_loQ/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 01:26:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZnkR8GLR7me8Tv07f_loQ/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 01:26:49 INFO - Downloaded 60369613 bytes. 01:26:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QZnkR8GLR7me8Tv07f_loQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:26:49 INFO - mkdir: /builds/slave/test/properties 01:26:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:26:49 INFO - Writing to file /builds/slave/test/properties/build_url 01:26:49 INFO - Contents: 01:26:49 INFO - build_url:https://queue.taskcluster.net/v1/task/QZnkR8GLR7me8Tv07f_loQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:26:50 INFO - Running post-action listener: _resource_record_post_action 01:26:50 INFO - Running post-action listener: set_extra_try_arguments 01:26:50 INFO - ##### 01:26:50 INFO - ##### Finished download-and-extract step (success) 01:26:50 INFO - ##### 01:26:50 INFO - ##### 01:26:50 INFO - ##### Running populate-webroot step. 01:26:50 INFO - ##### 01:26:50 INFO - Running pre-action listener: _resource_record_pre_action 01:26:50 INFO - Running main action method: populate_webroot 01:26:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:26:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:26:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:26:50 INFO - '--tppagecycles', 01:26:50 INFO - '7'], 01:26:50 INFO - 'tests': ['tsvgm']}}, 01:26:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:26:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:26:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:26:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:26:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:26:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:26:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:50 INFO - 'talos_options': ['--disable-e10s'], 01:26:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:26:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:26:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:50 INFO - 'talos_options': ['--disable-e10s'], 01:26:50 INFO - 'tests': ['damp', 'tps']}, 01:26:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:50 INFO - 'tests': ['damp', 'tps']}, 01:26:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:26:50 INFO - 'tests': ['dromaeo_dom']}, 01:26:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:26:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:26:50 INFO - 'tests': ['basic_compositor_video']}, 01:26:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:26:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:26:50 INFO - 'tests': ['a11yr', 01:26:50 INFO - 'ts_paint', 01:26:50 INFO - 'tpaint', 01:26:50 INFO - 'sessionrestore', 01:26:50 INFO - 'sessionrestore_no_auto_restore', 01:26:50 INFO - 'tabpaint']}, 01:26:50 INFO - 'other-e10s': {'tests': ['a11yr', 01:26:50 INFO - 'ts_paint', 01:26:50 INFO - 'tpaint', 01:26:50 INFO - 'sessionrestore', 01:26:50 INFO - 'sessionrestore_no_auto_restore', 01:26:50 INFO - 'tabpaint']}, 01:26:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:26:50 INFO - 'ts_paint', 01:26:50 INFO - 'tpaint', 01:26:50 INFO - 'sessionrestore', 01:26:50 INFO - 'sessionrestore_no_auto_restore', 01:26:50 INFO - 'tabpaint']}, 01:26:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:26:50 INFO - 'ts_paint', 01:26:50 INFO - 'tpaint', 01:26:50 INFO - 'sessionrestore', 01:26:50 INFO - 'sessionrestore_no_auto_restore', 01:26:50 INFO - 'tabpaint']}, 01:26:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:26:50 INFO - 'tests': ['a11yr', 01:26:50 INFO - 'ts_paint', 01:26:50 INFO - 'tpaint', 01:26:50 INFO - 'sessionrestore', 01:26:50 INFO - 'sessionrestore_no_auto_restore', 01:26:50 INFO - 'tabpaint']}, 01:26:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:26:50 INFO - 'tests': ['a11yr', 01:26:50 INFO - 'ts_paint', 01:26:50 INFO - 'tpaint', 01:26:50 INFO - 'sessionrestore', 01:26:50 INFO - 'sessionrestore_no_auto_restore', 01:26:50 INFO - 'tabpaint']}, 01:26:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:26:50 INFO - 'tests': ['tsvgx', 01:26:50 INFO - 'tsvgr_opacity', 01:26:50 INFO - 'tart', 01:26:50 INFO - 'tscrollx', 01:26:50 INFO - 'cart']}, 01:26:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:26:50 INFO - 'tsvgr_opacity', 01:26:50 INFO - 'tart', 01:26:50 INFO - 'tscrollx', 01:26:50 INFO - 'cart']}, 01:26:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:50 INFO - 'talos_options': ['--disable-e10s'], 01:26:50 INFO - 'tests': ['tp5o']}, 01:26:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:50 INFO - 'tests': ['tp5o']}, 01:26:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:50 INFO - 'talos_options': ['--disable-e10s', 01:26:50 INFO - '--xperf_path', 01:26:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:26:50 INFO - 'tests': ['tp5n']}, 01:26:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:50 INFO - 'talos_options': ['--xperf_path', 01:26:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:26:50 INFO - 'tests': ['tp5n']}}, 01:26:50 INFO - 'talos.zip': {'path': '', 01:26:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:26:50 INFO - Running post-action listener: _resource_record_post_action 01:26:50 INFO - ##### 01:26:50 INFO - ##### Finished populate-webroot step (success) 01:26:50 INFO - ##### 01:26:50 INFO - ##### 01:26:50 INFO - ##### Running create-virtualenv step. 01:26:50 INFO - ##### 01:26:50 INFO - Running pre-action listener: _resource_record_pre_action 01:26:50 INFO - Running main action method: create_virtualenv 01:26:50 INFO - Creating virtualenv /builds/slave/test/build/venv 01:26:50 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 01:26:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:26:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:26:50 INFO - Using real prefix '/usr' 01:26:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:26:50 INFO - Installing distribute.............................................................................................................................................................................................done. 01:26:52 INFO - Installing pip.................done. 01:26:52 INFO - Return code: 0 01:26:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:26:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:52 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 0x2772030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a30570>, '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 0x2a31470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a31900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467705108.220271-1322865100', '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 01:26:52 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 01:26:52 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 01:26:52 INFO - Using env: {'DISPLAY': ':0', 01:26:52 INFO - 'HOME': '/home/cltbld', 01:26:52 INFO - 'LANG': 'en_US.UTF-8', 01:26:52 INFO - 'LANGUAGE': 'en_US:en', 01:26:52 INFO - 'LOGNAME': 'cltbld', 01:26:52 INFO - 'MAIL': '/var/mail/cltbld', 01:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:52 INFO - 'MOZ_NO_REMOTE': '1', 01:26:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:52 INFO - 'NO_EM_RESTART': '1', 01:26:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:52 INFO - 'PWD': '/builds/slave/test', 01:26:52 INFO - 'SHELL': '/bin/bash', 01:26:52 INFO - 'SHLVL': '1', 01:26:52 INFO - 'TERM': 'linux', 01:26:52 INFO - 'TMOUT': '86400', 01:26:52 INFO - 'USER': 'cltbld', 01:26:52 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467705108.220271-1322865100', 01:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:52 INFO - '_': '/tools/buildbot/bin/python'} 01:26:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:53 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 01:26:53 INFO - Cleaning up... 01:26:53 INFO - Return code: 0 01:26:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:26: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')]} 01:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26: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')]} 01:26:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26: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', '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 0x2772030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a30570>, '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 0x2a31470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a31900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467705108.220271-1322865100', '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 01:26: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', 'psutil>=3.1.1'] in /builds/slave/test/build 01:26: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 psutil>=3.1.1 01:26:53 INFO - Using env: {'DISPLAY': ':0', 01:26:53 INFO - 'HOME': '/home/cltbld', 01:26:53 INFO - 'LANG': 'en_US.UTF-8', 01:26:53 INFO - 'LANGUAGE': 'en_US:en', 01:26:53 INFO - 'LOGNAME': 'cltbld', 01:26:53 INFO - 'MAIL': '/var/mail/cltbld', 01:26:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:53 INFO - 'MOZ_NO_REMOTE': '1', 01:26:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:53 INFO - 'NO_EM_RESTART': '1', 01:26:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:53 INFO - 'PWD': '/builds/slave/test', 01:26:53 INFO - 'SHELL': '/bin/bash', 01:26:53 INFO - 'SHLVL': '1', 01:26:53 INFO - 'TERM': 'linux', 01:26:53 INFO - 'TMOUT': '86400', 01:26:53 INFO - 'USER': 'cltbld', 01:26:53 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467705108.220271-1322865100', 01:26:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:53 INFO - '_': '/tools/buildbot/bin/python'} 01:26:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:53 INFO - Downloading/unpacking psutil>=3.1.1 01:26: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 01:26: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 01:26: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 01:26: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 01:26: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 01:26: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 01:26:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:26:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:26:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:26:55 INFO - Installing collected packages: psutil 01:26:55 INFO - Running setup.py install for psutil 01:26:55 INFO - building 'psutil._psutil_linux' extension 01:26:55 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 01:26:56 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 01:26:56 INFO - building 'psutil._psutil_posix' extension 01:26:56 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 01:26:56 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 01:26:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:26:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:26:56 INFO - Successfully installed psutil 01:26:56 INFO - Cleaning up... 01:26:56 INFO - Return code: 0 01:26:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:26:56 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')]} 01:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:56 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')]} 01:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:56 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 0x2772030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a30570>, '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 0x2a31470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a31900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467705108.220271-1322865100', '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 01:26:56 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 01:26:56 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 01:26:56 INFO - Using env: {'DISPLAY': ':0', 01:26:56 INFO - 'HOME': '/home/cltbld', 01:26:56 INFO - 'LANG': 'en_US.UTF-8', 01:26:56 INFO - 'LANGUAGE': 'en_US:en', 01:26:56 INFO - 'LOGNAME': 'cltbld', 01:26:56 INFO - 'MAIL': '/var/mail/cltbld', 01:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:56 INFO - 'MOZ_NO_REMOTE': '1', 01:26:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:56 INFO - 'NO_EM_RESTART': '1', 01:26:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:56 INFO - 'PWD': '/builds/slave/test', 01:26:56 INFO - 'SHELL': '/bin/bash', 01:26:56 INFO - 'SHLVL': '1', 01:26:56 INFO - 'TERM': 'linux', 01:26:56 INFO - 'TMOUT': '86400', 01:26:56 INFO - 'USER': 'cltbld', 01:26:56 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467705108.220271-1322865100', 01:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:56 INFO - '_': '/tools/buildbot/bin/python'} 01:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:26: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 01:26: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 01:26: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 01:26: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 01:26: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 01:26: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 01:26:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:26:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:26:58 INFO - Installing collected packages: mozsystemmonitor 01:26:58 INFO - Running setup.py install for mozsystemmonitor 01:26:59 INFO - Successfully installed mozsystemmonitor 01:26:59 INFO - Cleaning up... 01:26:59 INFO - Return code: 0 01:26:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:26: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')]} 01:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26: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')]} 01:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:59 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 0x2772030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a30570>, '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 0x2a31470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a31900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467705108.220271-1322865100', '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 01:26:59 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 01:26:59 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 01:26:59 INFO - Using env: {'DISPLAY': ':0', 01:26:59 INFO - 'HOME': '/home/cltbld', 01:26:59 INFO - 'LANG': 'en_US.UTF-8', 01:26:59 INFO - 'LANGUAGE': 'en_US:en', 01:26:59 INFO - 'LOGNAME': 'cltbld', 01:26:59 INFO - 'MAIL': '/var/mail/cltbld', 01:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:59 INFO - 'MOZ_NO_REMOTE': '1', 01:26:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:59 INFO - 'NO_EM_RESTART': '1', 01:26:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:59 INFO - 'PWD': '/builds/slave/test', 01:26:59 INFO - 'SHELL': '/bin/bash', 01:26:59 INFO - 'SHLVL': '1', 01:26:59 INFO - 'TERM': 'linux', 01:26:59 INFO - 'TMOUT': '86400', 01:26:59 INFO - 'USER': 'cltbld', 01:26:59 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467705108.220271-1322865100', 01:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:59 INFO - '_': '/tools/buildbot/bin/python'} 01:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:59 INFO - Downloading/unpacking jsonschema==2.5.1 01:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:27:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:01 INFO - Downloading functools32-3.2.3-2.tar.gz 01:27:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:27:01 INFO - warning: no files found matching '*.txt' 01:27:01 INFO - no previously-included directories found matching 'build' 01:27:01 INFO - no previously-included directories found matching 'dist' 01:27:01 INFO - no previously-included directories found matching '.git*' 01:27:01 INFO - Installing collected packages: jsonschema, functools32 01:27:01 INFO - Running setup.py install for functools32 01:27:01 INFO - warning: no files found matching '*.txt' 01:27:01 INFO - no previously-included directories found matching 'build' 01:27:01 INFO - no previously-included directories found matching 'dist' 01:27:01 INFO - no previously-included directories found matching '.git*' 01:27:01 INFO - Successfully installed jsonschema functools32 01:27:01 INFO - Cleaning up... 01:27:01 INFO - Return code: 0 01:27:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:01 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 0x2772030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a30570>, '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 0x2a31470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a31900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467705108.220271-1322865100', '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 01:27:01 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 01:27:01 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 01:27:01 INFO - Using env: {'DISPLAY': ':0', 01:27:01 INFO - 'HOME': '/home/cltbld', 01:27:01 INFO - 'LANG': 'en_US.UTF-8', 01:27:01 INFO - 'LANGUAGE': 'en_US:en', 01:27:01 INFO - 'LOGNAME': 'cltbld', 01:27:01 INFO - 'MAIL': '/var/mail/cltbld', 01:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:01 INFO - 'MOZ_NO_REMOTE': '1', 01:27:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:01 INFO - 'NO_EM_RESTART': '1', 01:27:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:01 INFO - 'PWD': '/builds/slave/test', 01:27:01 INFO - 'SHELL': '/bin/bash', 01:27:01 INFO - 'SHLVL': '1', 01:27:01 INFO - 'TERM': 'linux', 01:27:01 INFO - 'TMOUT': '86400', 01:27:01 INFO - 'USER': 'cltbld', 01:27:01 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467705108.220271-1322865100', 01:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:01 INFO - '_': '/tools/buildbot/bin/python'} 01:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:01 INFO - Downloading/unpacking blobuploader==1.2.4 01:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:03 INFO - Downloading blobuploader-1.2.4.tar.gz 01:27:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:27:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:27: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 01:27: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 01:27: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 01:27: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 01:27: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 01:27: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 01:27:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:27:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:04 INFO - Downloading docopt-0.6.1.tar.gz 01:27:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:27:04 INFO - Installing collected packages: blobuploader, requests, docopt 01:27:04 INFO - Running setup.py install for blobuploader 01:27:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:27:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:27:04 INFO - Running setup.py install for requests 01:27:05 INFO - Running setup.py install for docopt 01:27:05 INFO - Successfully installed blobuploader requests docopt 01:27:05 INFO - Cleaning up... 01:27:05 INFO - Return code: 0 01:27:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:27:05 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')]} 01:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:05 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')]} 01:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:05 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 0x2772030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a30570>, '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 0x2a31470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a31900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467705108.220271-1322865100', '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 01:27:05 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 01:27:05 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 01:27:05 INFO - Using env: {'DISPLAY': ':0', 01:27:05 INFO - 'HOME': '/home/cltbld', 01:27:05 INFO - 'LANG': 'en_US.UTF-8', 01:27:05 INFO - 'LANGUAGE': 'en_US:en', 01:27:05 INFO - 'LOGNAME': 'cltbld', 01:27:05 INFO - 'MAIL': '/var/mail/cltbld', 01:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:05 INFO - 'MOZ_NO_REMOTE': '1', 01:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:05 INFO - 'NO_EM_RESTART': '1', 01:27:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:05 INFO - 'PWD': '/builds/slave/test', 01:27:05 INFO - 'SHELL': '/bin/bash', 01:27:05 INFO - 'SHLVL': '1', 01:27:05 INFO - 'TERM': 'linux', 01:27:05 INFO - 'TMOUT': '86400', 01:27:05 INFO - 'USER': 'cltbld', 01:27:05 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467705108.220271-1322865100', 01:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:05 INFO - '_': '/tools/buildbot/bin/python'} 01:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:27:05 INFO - Running setup.py (path:/tmp/pip-aTXlrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:27:05 INFO - Running setup.py (path:/tmp/pip-7hLg3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:27:05 INFO - Running setup.py (path:/tmp/pip-aE5Ltg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:27:05 INFO - Running setup.py (path:/tmp/pip-RMD1Lf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:27:05 INFO - Running setup.py (path:/tmp/pip-I94ckO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:27:05 INFO - Running setup.py (path:/tmp/pip-DZALiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:27:05 INFO - Running setup.py (path:/tmp/pip-UxyCOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:27:05 INFO - Running setup.py (path:/tmp/pip-iBskmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:27:05 INFO - Running setup.py (path:/tmp/pip-flgpYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:27:06 INFO - Running setup.py (path:/tmp/pip-ll893G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:27:06 INFO - Running setup.py (path:/tmp/pip-Jaoge9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:27:06 INFO - Running setup.py (path:/tmp/pip-GVjG8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:27:06 INFO - Running setup.py (path:/tmp/pip-yejgCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:27:06 INFO - Running setup.py (path:/tmp/pip-sRM19m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:27:06 INFO - Running setup.py (path:/tmp/pip-4l7B1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:27:06 INFO - Running setup.py (path:/tmp/pip-A3nFm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:27:06 INFO - Running setup.py (path:/tmp/pip-2H4LuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:27:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:27:06 INFO - Running setup.py install for manifestparser 01:27:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:27:06 INFO - Running setup.py install for mozcrash 01:27:06 INFO - Running setup.py install for mozdebug 01:27:06 INFO - Running setup.py install for mozdevice 01:27:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:27:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:27:07 INFO - Running setup.py install for mozfile 01:27:07 INFO - Running setup.py install for mozhttpd 01:27:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:27:07 INFO - Running setup.py install for mozinfo 01:27:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:27:07 INFO - Running setup.py install for mozInstall 01:27:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:27:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:27:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:27:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:27:07 INFO - Running setup.py install for mozleak 01:27:07 INFO - Running setup.py install for mozlog 01:27:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:27:07 INFO - Running setup.py install for moznetwork 01:27:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:27:07 INFO - Running setup.py install for mozprocess 01:27:07 INFO - Running setup.py install for mozprofile 01:27:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:27:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:27:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:27:07 INFO - Running setup.py install for mozrunner 01:27:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:27:08 INFO - Running setup.py install for mozscreenshot 01:27:08 INFO - Running setup.py install for moztest 01:27:08 INFO - Running setup.py install for mozversion 01:27:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:27:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:27:08 INFO - Cleaning up... 01:27:08 INFO - Return code: 0 01:27:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:27:08 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')]} 01:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:08 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')]} 01:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:08 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 0x2772030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a30570>, '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 0x2a31470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a31900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467705108.220271-1322865100', '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 01:27:08 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 01:27:08 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 01:27:08 INFO - Using env: {'DISPLAY': ':0', 01:27:08 INFO - 'HOME': '/home/cltbld', 01:27:08 INFO - 'LANG': 'en_US.UTF-8', 01:27:08 INFO - 'LANGUAGE': 'en_US:en', 01:27:08 INFO - 'LOGNAME': 'cltbld', 01:27:08 INFO - 'MAIL': '/var/mail/cltbld', 01:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:08 INFO - 'MOZ_NO_REMOTE': '1', 01:27:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:08 INFO - 'NO_EM_RESTART': '1', 01:27:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:08 INFO - 'PWD': '/builds/slave/test', 01:27:08 INFO - 'SHELL': '/bin/bash', 01:27:08 INFO - 'SHLVL': '1', 01:27:08 INFO - 'TERM': 'linux', 01:27:08 INFO - 'TMOUT': '86400', 01:27:08 INFO - 'USER': 'cltbld', 01:27:08 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467705108.220271-1322865100', 01:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:08 INFO - '_': '/tools/buildbot/bin/python'} 01:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:27:08 INFO - Running setup.py (path:/tmp/pip-bll0PA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:27:08 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)) 01:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:27:08 INFO - Running setup.py (path:/tmp/pip-AEoxQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:27:08 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)) 01:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:27:08 INFO - Running setup.py (path:/tmp/pip-j3H3Ry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:27:08 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)) 01:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:27:08 INFO - Running setup.py (path:/tmp/pip-xyFloz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:27:08 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)) 01:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:27:08 INFO - Running setup.py (path:/tmp/pip-riNUcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:27:09 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)) 01:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:27:09 INFO - Running setup.py (path:/tmp/pip-ACJAZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:27:09 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)) 01:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:27:09 INFO - Running setup.py (path:/tmp/pip-Ftye4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:27:09 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)) 01:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:27:09 INFO - Running setup.py (path:/tmp/pip-kJujRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:27:09 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)) 01:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:27:09 INFO - Running setup.py (path:/tmp/pip-UNLQ8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:27:09 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)) 01:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:27:09 INFO - Running setup.py (path:/tmp/pip-O7N0Vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:27:09 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)) 01:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:27:09 INFO - Running setup.py (path:/tmp/pip-5Hw2Zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:27:09 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)) 01:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:27:09 INFO - Running setup.py (path:/tmp/pip-2e8tru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:27:09 INFO - Running setup.py (path:/tmp/pip-sbqnOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:27:09 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)) 01:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:27:09 INFO - Running setup.py (path:/tmp/pip-vvleG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:27:09 INFO - Running setup.py (path:/tmp/pip-jqoXlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:27:09 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)) 01:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:27:09 INFO - Running setup.py (path:/tmp/pip-5fF8zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:27:09 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)) 01:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:27:09 INFO - Running setup.py (path:/tmp/pip-zttQ1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:27:09 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)) 01:27:09 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)) 01:27:09 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)) 01:27:09 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)) 01:27:09 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)) 01:27:09 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)) 01:27:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:11 INFO - Downloading blessings-1.6.tar.gz 01:27:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:27:11 INFO - Installing collected packages: blessings 01:27:11 INFO - Running setup.py install for blessings 01:27:11 INFO - Successfully installed blessings 01:27:11 INFO - Cleaning up... 01:27:12 INFO - Return code: 0 01:27:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:27:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:27:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:27:12 INFO - Reading from file tmpfile_stdout 01:27:12 INFO - Current package versions: 01:27:12 INFO - argparse == 1.2.1 01:27:12 INFO - blessings == 1.6 01:27:12 INFO - blobuploader == 1.2.4 01:27:12 INFO - docopt == 0.6.1 01:27:12 INFO - functools32 == 3.2.3-2 01:27:12 INFO - jsonschema == 2.5.1 01:27:12 INFO - manifestparser == 1.1 01:27:12 INFO - mozInstall == 1.12 01:27:12 INFO - mozcrash == 0.17 01:27:12 INFO - mozdebug == 0.1 01:27:12 INFO - mozdevice == 0.48 01:27:12 INFO - mozfile == 1.2 01:27:12 INFO - mozhttpd == 0.7 01:27:12 INFO - mozinfo == 0.9 01:27:12 INFO - mozleak == 0.1 01:27:12 INFO - mozlog == 3.2 01:27:12 INFO - moznetwork == 0.27 01:27:12 INFO - mozprocess == 0.22 01:27:12 INFO - mozprofile == 0.28 01:27:12 INFO - mozrunner == 6.11 01:27:12 INFO - mozscreenshot == 0.1 01:27:12 INFO - mozsystemmonitor == 0.3 01:27:12 INFO - moztest == 0.7 01:27:12 INFO - mozversion == 1.4 01:27:12 INFO - psutil == 3.1.1 01:27:12 INFO - requests == 1.2.3 01:27:12 INFO - wsgiref == 0.1.2 01:27:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:12 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 0x2772030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a30570>, '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 0x2a31470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a31900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467705108.220271-1322865100', '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 01:27:12 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 01:27:12 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 01:27:12 INFO - Using env: {'DISPLAY': ':0', 01:27:12 INFO - 'HOME': '/home/cltbld', 01:27:12 INFO - 'LANG': 'en_US.UTF-8', 01:27:12 INFO - 'LANGUAGE': 'en_US:en', 01:27:12 INFO - 'LOGNAME': 'cltbld', 01:27:12 INFO - 'MAIL': '/var/mail/cltbld', 01:27:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:12 INFO - 'MOZ_NO_REMOTE': '1', 01:27:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:12 INFO - 'NO_EM_RESTART': '1', 01:27:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:12 INFO - 'PWD': '/builds/slave/test', 01:27:12 INFO - 'SHELL': '/bin/bash', 01:27:12 INFO - 'SHLVL': '1', 01:27:12 INFO - 'TERM': 'linux', 01:27:12 INFO - 'TMOUT': '86400', 01:27:12 INFO - 'USER': 'cltbld', 01:27:12 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467705108.220271-1322865100', 01:27:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:12 INFO - '_': '/tools/buildbot/bin/python'} 01:27:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:12 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)) 01:27:12 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)) 01:27:12 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)) 01:27:12 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)) 01:27:12 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)) 01:27:12 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)) 01:27:12 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)) 01:27:12 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)) 01:27:12 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)) 01:27:12 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)) 01:27:12 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)) 01:27:12 INFO - Cleaning up... 01:27:12 INFO - Return code: 0 01:27:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:12 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 0x2772030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a30570>, '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 0x2a31470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a31900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467705108.220271-1322865100', '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 01:27:12 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 01:27:12 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 01:27:12 INFO - Using env: {'DISPLAY': ':0', 01:27:12 INFO - 'HOME': '/home/cltbld', 01:27:12 INFO - 'LANG': 'en_US.UTF-8', 01:27:12 INFO - 'LANGUAGE': 'en_US:en', 01:27:12 INFO - 'LOGNAME': 'cltbld', 01:27:12 INFO - 'MAIL': '/var/mail/cltbld', 01:27:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:12 INFO - 'MOZ_NO_REMOTE': '1', 01:27:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:12 INFO - 'NO_EM_RESTART': '1', 01:27:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:12 INFO - 'PWD': '/builds/slave/test', 01:27:12 INFO - 'SHELL': '/bin/bash', 01:27:12 INFO - 'SHLVL': '1', 01:27:12 INFO - 'TERM': 'linux', 01:27:12 INFO - 'TMOUT': '86400', 01:27:12 INFO - 'USER': 'cltbld', 01:27:12 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467705108.220271-1322865100', 01:27:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:12 INFO - '_': '/tools/buildbot/bin/python'} 01:27:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:27:12 INFO - Cleaning up... 01:27:12 INFO - Return code: 0 01:27:12 INFO - Running post-action listener: _resource_record_post_action 01:27:12 INFO - Running post-action listener: _start_resource_monitoring 01:27:12 INFO - Starting resource monitoring. 01:27:12 INFO - ##### 01:27:12 INFO - ##### Finished create-virtualenv step (success) 01:27:12 INFO - ##### 01:27:12 INFO - ##### 01:27:12 INFO - ##### Running install step. 01:27:12 INFO - ##### 01:27:12 INFO - Running pre-action listener: _resource_record_pre_action 01:27:12 INFO - Running main action method: install 01:27:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:27:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:27:12 INFO - Reading from file tmpfile_stdout 01:27:12 INFO - Detecting whether we're running mozinstall >=1.0... 01:27:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:27:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:27:13 INFO - Reading from file tmpfile_stdout 01:27:13 INFO - Output received: 01:27:13 INFO - Usage: mozinstall [options] installer 01:27:13 INFO - Options: 01:27:13 INFO - -h, --help show this help message and exit 01:27:13 INFO - -d DEST, --destination=DEST 01:27:13 INFO - Directory to install application into. [default: 01:27:13 INFO - "/builds/slave/test"] 01:27:13 INFO - --app=APP Application being installed. [default: firefox] 01:27:13 INFO - mkdir: /builds/slave/test/build/application 01:27:13 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'] 01:27:13 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 01:27:30 INFO - Reading from file tmpfile_stdout 01:27:30 INFO - Output received: 01:27:30 INFO - /builds/slave/test/build/application/firefox/firefox 01:27:30 INFO - Running post-action listener: _resource_record_post_action 01:27:30 INFO - ##### 01:27:30 INFO - ##### Finished install step (success) 01:27:30 INFO - ##### 01:27:30 INFO - ##### 01:27:30 INFO - ##### Running run-tests step. 01:27:30 INFO - ##### 01:27:30 INFO - Running pre-action listener: _resource_record_pre_action 01:27:30 INFO - Running main action method: run_tests 01:27:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:27:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:27:30 INFO - Python 2.7.3 01:27:30 INFO - Return code: 0 01:27:30 INFO - grabbing minidump binary from tooltool 01:27:30 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')]} 01:27:30 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 0x2a30570>, '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 0x2a31470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a31900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:27:30 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 01:27:30 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 01:27:30 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 01:27:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:27:30 INFO - Return code: 0 01:27:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:27:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:27:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:27:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:27:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:27:30 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QZnkR8GLR7me8Tv07f_loQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:27:30 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QZnkR8GLR7me8Tv07f_loQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:27:30 INFO - Using env: {'DISPLAY': ':0', 01:27:30 INFO - 'HOME': '/home/cltbld', 01:27:30 INFO - 'LANG': 'en_US.UTF-8', 01:27:30 INFO - 'LANGUAGE': 'en_US:en', 01:27:30 INFO - 'LOGNAME': 'cltbld', 01:27:30 INFO - 'MAIL': '/var/mail/cltbld', 01:27:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:27:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:27:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:30 INFO - 'MOZ_NO_REMOTE': '1', 01:27:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:27:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:30 INFO - 'NO_EM_RESTART': '1', 01:27:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:30 INFO - 'PWD': '/builds/slave/test', 01:27:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:27:30 INFO - 'SHELL': '/bin/bash', 01:27:30 INFO - 'SHLVL': '1', 01:27:30 INFO - 'TERM': 'linux', 01:27:30 INFO - 'TMOUT': '86400', 01:27:30 INFO - 'USER': 'cltbld', 01:27:30 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467705108.220271-1322865100', 01:27:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:30 INFO - '_': '/tools/buildbot/bin/python'} 01:27:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QZnkR8GLR7me8Tv07f_loQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:27:30 INFO - mozversion application_buildid: 20160704222341 01:27:30 INFO - mozversion application_changeset: 441bc43054900d751b43870a3d0f6f7ccab4317e 01:27:30 INFO - mozversion application_display_name: Nightly 01:27:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:27:30 INFO - mozversion application_name: Firefox 01:27:30 INFO - mozversion application_remotingname: firefox 01:27:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:27:30 INFO - mozversion application_vendor: Mozilla 01:27:30 INFO - mozversion application_version: 50.0a1 01:27:30 INFO - mozversion platform_buildid: 20160704222341 01:27:30 INFO - mozversion platform_changeset: 441bc43054900d751b43870a3d0f6f7ccab4317e 01:27:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:27:30 INFO - mozversion platform_version: 50.0a1 01:27:30 INFO - using testdate: 1467707250 01:27:30 INFO - actual date: 1467707250 01:27:30 INFO - starting webserver on 'localhost:55570' 01:27:30 INFO - SUITE-START | Running 2 tests 01:27:30 INFO - TEST-START | dromaeo_css 01:27:30 INFO - operating with platform_type : linux_ 01:27:30 INFO - Initialising browser for dromaeo_css test... 01:27:30 INFO - TEST-INFO | started process 3330 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWq8d9U/profile http://localhost:55570/getInfo.html) 01:27:36 INFO - PROCESS | 3330 | __metrics Screen width/height:1600/1200 01:27:36 INFO - PROCESS | 3330 | colorDepth:24 01:27:36 INFO - PROCESS | 3330 | Browser inner width/height: 1024/697 01:27:36 INFO - PROCESS | 3330 | __metrics 01:27:37 ERROR - PROCESS | 3330 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 01:27:37 INFO - TEST-INFO | 3330: exit 0 01:27:37 INFO - Browser initialized. 01:27:37 INFO - Running cycle 1/1 for dromaeo_css test... 01:27:37 INFO - TEST-INFO | started process 3452 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWq8d9U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:27:49 INFO - PROCESS | 3452 | RSS: Main: 168222720 01:27:49 INFO - PROCESS | 3452 | 01:28:39 INFO - PROCESS | 3452 | 1467707319112 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] 01:30:46 INFO - PROCESS | 3452 | Cycle 1(1): loaded http://localhost:55570/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55570/tests/dromaeo/cssquery-ext.html) 01:30:47 INFO - PROCESS | 3452 | RSS: Main: 171782144 01:30:47 INFO - PROCESS | 3452 | 01:33:49 INFO - PROCESS | 3452 | Cycle 1(1): loaded http://localhost:55570/tests/dromaeo/cssquery-ext.html (next: http://localhost:55570/tests/dromaeo/cssquery-jquery.html) 01:33:50 INFO - PROCESS | 3452 | RSS: Main: 168734720 01:33:50 INFO - PROCESS | 3452 | 01:36:52 INFO - PROCESS | 3452 | Cycle 1(1): loaded http://localhost:55570/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55570/tests/dromaeo/cssquery-mootools.html) 01:36:52 INFO - PROCESS | 3452 | RSS: Main: 172351488 01:36:52 INFO - PROCESS | 3452 | 01:39:54 INFO - PROCESS | 3452 | Cycle 1(1): loaded http://localhost:55570/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55570/tests/dromaeo/cssquery-prototype.html) 01:39:55 INFO - PROCESS | 3452 | RSS: Main: 168017920 01:39:55 INFO - PROCESS | 3452 | 01:42:57 INFO - PROCESS | 3452 | Cycle 1(1): loaded http://localhost:55570/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55570/tests/dromaeo/cssquery-yui.html) 01:42:58 INFO - PROCESS | 3452 | RSS: Main: 169857024 01:42:58 INFO - PROCESS | 3452 | 01:46:00 INFO - PROCESS | 3452 | Cycle 1(1): loaded http://localhost:55570/tests/dromaeo/cssquery-yui.html (next: http://localhost:55570/tests/dromaeo/cssquery-dojo.html) 01:46:00 INFO - PROCESS | 3452 | RSS: Main: 170983424 01:46:00 INFO - PROCESS | 3452 | 01:46:00 INFO - PROCESS | 3452 | __start_tp_report 01:46:00 INFO - PROCESS | 3452 | _x_x_mozilla_page_load 01:46:00 INFO - PROCESS | 3452 | _x_x_mozilla_page_load_details 01:46:00 INFO - PROCESS | 3452 | |i|pagename|runs| 01:46:00 INFO - PROCESS | 3452 | |0;dojo.html;3042.4371491274114;3070.125014370905;3085.413771383437;3112.1597168764433;3129.389768995047;5121.820736274231;5181.093308670982;5235.528802407783;5279;5302.125149350362;5151.150060240056;5156.561692256153;5229.189475631283;5263.605229607785;5276.103062479378;4676.508966558514;4762.166620841356;4814.711117332971;4888.364512613355;4919.926201106986;533.6040759748361;4698.694584851974;4705.764711764416;4789.305550695147;4845.588125009378;4724.59840913521;4760.642951778613;4787.712737235742;4801.231802911552;4834.806607735686;4790.113828941657;4796.664233503656;4796.880077998043;4801.1117943180625;4809.326694262806;4696.9060618787435;4699.013207226452;4762.2380419133115;4764.595009424203;4829.2997515360075;5190.06578815813;5211.817586384496;5250.133727934886;5250.579953603703;5254.264402983586;5625.156226566007;5630.943690563124;5643.040683083845;5644.5484361251;5675.602707810455;5438.755256013489;5532.917006244869;5611.018071837412;5624.268845050117;5661.5187709044785;5268.262443257985;5271.28837606922;5277.70972596507;5277.815276465305;5288.153895376721;5590.440955904377;5758.049921762862;5767.596268261182;5772.2207501986695;5830.5627077968475;5419.187121931742;5437.211604317431;5495.752691128909;5512.3385193777;5529.198266251371;5554.86112847174;5572.86067848307;5576.6375185613615;5582.8325150245555;5586.664800112007;5482.698451585201;5484.862878428071;5571;5571.220029195916;5619.690916999604;5552.056150454432;5578.609497335228;5596.608237423423;5608.635438696553;5641.689707066069;4248.723832950848;4273.87178384649;4289.313709806416;4317.266064768997;4333.523312435629;3824.2160357126722;3840.116773142193;3846.4230365445405;3863.9806800965816;3890.7665540067687;5224.320838291073;5267.868303292448;5284.630075894727;5324.494173053554;5458.563314934796;5593.105103183552;5593.244911936918;5596.300462442195;5655.095184770417;5660.575456840754;5196.194589838581;5332.200169974535;5367.1680889462195;5367.677939323653;5373.059714549938;4876.536729010738;4934.827281045146;4935.975320123376;4973.701577905337;4987.102321582078;5826.563007774349;5862.882742345129;5865.501432378211;5881.764729410861;5944.583879128506;5490.286262785812;5578.386377498391;5638.182463542681;5687.800926967537;5690.857728556736;5807.622504537191;5851.795187168429;5863.091220860773;5881.441263080001;5921.733521991607;5582.218489411567;5603.075492543685;5605.691686957257;5621.325440947113;5623.2408624835125;5520;5553.888922221614;5560.860978475571;5638.802641907513;5687.857803554944;5389.784408623768;5413.998410294108;5433.157860531624;5454.427285135003;5499.917501237404;5418.431064738145;5465.344158700822;5471.480209380103;5493.505584497414;5545.7781688732;5253.369595648546;5356.143017117242;5431.945680543144;5442.047641662773;5495.6153069286365;5449.836504904859;5535.474129957647;5552.7778888843995;5553.666779993213;5556.694381809039;5228.9738551307;5432.9185062223305;5437.238786569805;5442.401335852974;5446.264754258124 01:46:00 INFO - PROCESS | 3452 | |1;ext.html;580.4543728894838;609.1015751766145;616.4790751814717;627.159606127789;633.303366297073;33098;43491;44023;44465.555344446504;44574.10851782963;45613.43865613437;45737.31394029084;46280;46335.53664463355;46415.53584464154;8960.686375976826;9109.726708198732;9114.40756350835;9138.543072846363;9145.542722863864;8867.113288671146;8891.288696904265;8939.284857211407;8959.776005599848;8978.640854365818;8969.461832290051;8982.640694372218;8983.460992340448;9003.054679258681;9008.729738107868;8884.822303553925;8915.643374265022;8922.955385223033;8952.731418057469;8960.327975401839;9008.1892629663;9061.954690226572;9067.81864362709;9080.591373388148;9085.454872707593;43329.133417331795;43383.56616433858;43450.782746086385;43662.56337436617;43710.781446092886;3466.168119651291;3498.7201023918024;3585.085803120188;3651.361011822947;4221.2190744712325;32754.181145471317;33105.337893242;33305;33343.3331333372;33558.32883342344;4348.847790327323;4388.5830846069575;4429.800658970354;4495.258282383403;4574.72551646899;252086;252444;252695;253785;254382;34153;34942.65057349394;55093.72453137708;55869.720651396485;55986;36558.45162322514;36620.81689591535;36636.81681591575;36706.26587468236;36766;15141.318640661197;15154.318055687521;15176.696466070616;15201;15315.15766632846;12880.227186368847;12899.93550032244;12927.806082908764;12931.224126552437;12943.935280323538;8355.874661880076;8368.790780230422;8371.414001019992;8376.078631350547;8433.95783021081;3226.2902161524426;3235.854386552611;3248;3271.5910511186103;3309.1396236978558;1024.1499555369026;1056.4506456642503;1066.2855886556026;1104.7017305327518;1112.0825319111766;32290.35419291648;32429.837850810596;32834;33161.17097072592;33253;1057.5505410200633;1100.8733995590449;1139.3619573039125;1152.0553146419854;1175.0540814644123;16263;16328.183590820412;16495.175241237892;16532.917335413247;16920.069396183328;525285;528278;531319;532744;534068;56960.43039569551;58934;59082.70458647679;59097.40902590919;59292.703536482906;1350.5745690107585;1352.6685961939388;1355.3155656393458;1356.8914486841227;1368.904176707621;30100.397992040474;31067.22331941629;31218.687813121578;31347.216319592193;31850.36299274048;49041.754791225816;49208.753956229986;49263.75368123136;49545.752271238416;49771.50228497814;440945;441192;442406;443564;444111;27925.16224513268;28021.439571208055;28154;28245.858770706014;28474.288142796595;48215;49485;49642.25536617026;49782.75108624434;53365.46634533605;45084.77457612822;45298.32052519149;46374.53625463702;46675.29987050129;47474.28788568105;46411.75588543982;47218;47257.05485890332;47341.526584733714;47370.52629473799;45358.773206135076;45485;46041.76979115083;47099;48176.5182348172;39847.60152398439;40152.59847401606;40480.59519404768;40640.79679601583;40846.79576602098;30338.84830575833;30665.233369165948;30728.23179420443;30764.230894227825;30894 01:46:00 INFO - PROCESS | 3452 | |2;jquery.html;377.79599016531074;378.97157713171504;379.5843551311314;393.50221969208974;394.8164103691783;15736.842631573682;18533.721994170082;19215.32746353878;20065.197392104317;20650.277240296593;16098.59753506163;16143.112128832909;19793.307234246804;20640;20914.79085209151;6338.524610654208;6554.442872355856;6644;6698.531102822804;6708.496862735315;6523.608583485006;6908.861822763542;7249.637518124099;7255.600941948191;7303.5252708574035;7183.102112235971;7244.840825467926;7308.123025236979;7333.120025596909;7338.669759860819;7104.573725576456;7205.963970180168;7262.745803896864;7298.854022919512;7333.779986600411;6930.13373328334;7020.1575810902505;7068.081149450539;7085.893711594279;7126.429885609191;26388.472230555282;26639.46721065568;27193.1842044739;27701.584476232874;27862;2618.4763047390597;2922.488564501225;2985.939991303078;3004.324027093908;3371.157210697326;15667.373305067898;15900.602484937968;16033.919830400773;16672.33310667572;17209.483715488554;2119.8198153157;2131.05168200151;2140.657494800824;2216.789405006522;2237.4182712494867;97005;99076.50461747717;100414;101064.49467752615;101260.49369753104;16519.6696066078;17691.73462398065;18155.54611134732;18526;18643.720344194848;11680.182387232811;12372.876271237352;32075.679243207735;32204;32269.35461290761;7606.163322034572;7636.923630763621;7879.645415956295;7907.367410607138;8012.799680008046;7959.363250939911;7978.920210797818;8025.638846251933;8081.191880811989;8165.755027349189;3871.7289789715014;3949.980250098731;4112.506499220112;4130.834766609302;4165.91668166641;2001.2395289790077;2030.3604364625096;2055.9794402056086;2061.4331058958905;2088.4883203615213;963.4123184857232;969.1471505075489;979.8334283171878;992.731962370156;1014.8883622801486;19790.307339243056;19823.107960141828;19887.403377898685;19887.801121988883;19932.60134797296;992.5136683025265;993.7416271769248;1010.570507534295;1029.7734498410339;1038.6157121864958;10704.357738535713;10956.671299861016;10980.670579882617;11053.944730276296;11106.111511079256;487270;490956;502098;504475;510546;102206;103702.48148759209;106933.46533267284;107195.8416266341;108683.45658271817;994.8411946077031;1027.209049032256;1040.625374865048;1040.953157107932;1062.0919114157593;14675.339609717801;18161.909190453964;18162.4795889321;18202.544936376165;18512.72230916564;46341.30488042615;46930.296045560026;47025;47414.76292618653;47946.5205347942;64429;64999.67500162658;65029.67485162544;66510;66550.66898662096;8683.739487815375;8711.695090671796;8742.082081381617;8769.956150219208;8806.283660690206;9992.900070999198;13705.246211458465;13782.655433613838;13876.167429954236;14164.150150990974;8070.919290807017;12145.635630931087;12226.327551984727;12364.44360003784;12565.371731413576;11818.290902545874;12080.275183489019;12209.816852747394;12292.139550231755;12601.495940162291;12400.069994750249;12487.125901187193;12499.000079993397;12567.434465448894;12694.428750706425;7405.2224516425;8518.403711740119;8694.695685650971;8935.28517718568;9045.638174472948;11018.559257629606;12476.563320284109;12575.622731318075;12717.55488557896;12909.483620655445 01:46:00 INFO - PROCESS | 3452 | |3;mootools.html;1464.6265202373397;1493.3951749541436;1562.6015366081647;1691.5179173935423;1728.4900954218504;7370.299821516961;7904.6442910069045;7960.800979975504;8462.069172391031;8482.830343393136;7959.562224077674;8166.305864001552;8242.587870606461;8250.298724608401;8256.174382561741;2163.6321825289738;2184.8529522000917;2194.9451263718374;2194.9451263718374;2197.9780202198012;2121.1303365620097;2163.264490073375;2199.692043113965;2204.2836078274545;2205.0959106766227;2173.56528694261;2193.967090493644;2195.2536137713173;2200.2409168836807;2215.1582398688474;2148.4414052346347;2159.8920053997394;2170.750363708178;2171.2183613898983;2171.6091103601348;2051.5384038591346;2113.894305284745;2132.829373650104;2161.2651698422455;2171.2183613898983;8322.16778322169;8336.166383361677;8346.165383461666;8351.457155284887;8358.205970432798;4751.714897106184;4870.342503761982;4892.290617860426;4923.212286034253;4927.137750893579;3165.6201255849214;3169.6988786065285;3183.649798522161;3244.9837750811093;3256.739460843127;1030.5884230899655;1066.3122286125483;1075.510642657589;1108.3903852880883;1109.3233127792041;11230.382328971904;11245.212835101545;11251.493682784294;11279.266847654877;11289.717757056058;4184.225918205142;4193.958060419418;4347.760873151944;4354.172707185625;4356.041670832412;9620.086091821266;9684.56419461126;9713.36863103896;9716.125548700651;9804;4942.061008408391;4953.702777833341;4982.078315511642;5006.998600279959;5010.574101201366;3977.8209980550946;4586.931196032062;4607.470140933769;4608.446986361658;4611.746353950498;3721.925561488755;3725.962740372616;3823.7705737655274;3833.156705524836;3835.6931445484292;1147.4664281109324;1150.2006105756586;1152.0207823350254;1161.7269941563725;1187.0503597122267;864.8918885139358;905.3798148268457;975.3465178330536;1005.0803514784037;1008.2690049713899;5647.717614119278;5915.940840591539;5994.460498555151;6063.969680151571;6137.3862613738265;972.2756546372856;979.3683074416961;997.6408492942535;1018.6332920148741;1023.247912784103;4100.0569868930315;4101.610347017028;4165.416841642173;4176.394422808737;4188.434561334242;9891;10246.129079028366;10246.385216886862;10291.33106348085;10321.380717156995;10158.39049657023;10226.897731022744;10234.232432567587;10255.692329230134;10259;7495.925040749523;7517.887231691419;7604.771856844303;7796.883046754303;7808.375329973588;5791.884162316645;5953.791617293374;6049.51603871698;6073.058675905242;6227.657478838707;9386.389884657476;9512.381695190068;9567.9043209567;9628.47043412619;9637.18083962871;8722.563871806511;8920.152585504626;9042.412243204433;9214.2628589714;9631.08504692053;6737.32626737342;7036.2260151384335;7206.387457066208;7294.890576641461;7552.546847188966;8094.595270236582;8125.187481252064;8140.592970351578;8142.959285203536;8168.224018718212;7046.647667616701;7313.012743279589;7390.113186417664;7419.109706835215;7475.925240747523;6986.196587392515;7086.149662040588;7111.644417779194;7241.4206863449745;7241.855162896818;6411.8397040072505;6491.805245842632;6515.837104072436;6542.149520562297;6546.967265163834;4947.727874966768;4964.950350496449;5007.29897814299;5031.471695471922;5058.1401161803315;4886.633502487257;4916.188828843201;4970.9254361183885;4999.550040496373;5067.214581739836 01:46:00 INFO - PROCESS | 3452 | |4;prototype.html;291.85407296351826;302.5356078419626;304.34413838178733;306.24816076532113;306.32913918518443;5530.5299049580735;5566.888662226763;5750.223719797826;5786.247787787593;5815.273090863642;5649.288341596036;5686.2039314496005;5760.107183386582;5818.236337739571;5828.737706803194;4454.287314029756;4466.8883277917985;4472.1055788842195;4487.708298960573;4492.887677808065;4375.343698445243;4431.446069241345;4437.557793717055;4458.955410445887;4470.798814053375;4378.095528445137;4391.407160033403;4399.802008909607;4425.070735145608;4426.468823741139;4396.912061758747;4417.740943831025;4419.867403977886;4430.534793846632;4432.578905004019;3523.7533372663925;3743.3636281832155;3881.8835434936996;3887.61123887609;3888.0279930017496;5564.749586268627;5569.855605591836;5594.272744543224;5605.439456054402;5634.3520495143175;4907.484714105039;4911.705297682115;4942.481039490837;4959.380077490314;4978.327925730053;5728.598998070137;5890.234269544974;5921.200637913913;5930.822075337746;5946.405359464062;4067.410225517313;4085.569086393591;4087.5708050654553;4091.509018917719;4104.507459104897;6169.290531588835;6172.444479996821;6195.256569211679;6200.968995154995;6201.829359724105;4037.6971727120585;4125.587441255911;4126.741343890082;4133.318002529609;4166.312558427825;4199.3412602022645;4206.26390381682;4211.936820947688;4218.936715949263;4224.366345048267;4915.262710593368;4920.237363208708;4950.861301900511;4952.232403977389;4962.702237865739;5803.332616749128;5943.14728930116;5995.850103747354;5997.490213331828;6020.795840831851;1439.2372042817324;1448.5364683301243;1450.5358285348798;1460.49612883555;1463.3488097796592;877.657713491726;893.1916615463016;902.7968707040864;905.7410199822252;912.5346073502561;5085.415177254663;5101.897962040813;5126.846194614093;5131.179011358165;5182.689038657692;5441.673499590037;5443.482869127427;5453.672779633234;5458.099413596791;5502.899420115993;5146.588272938156;5167.974160129175;5195.974020129951;5370.543503802142;5807.477327040587;3262.200760813616;3291.6214635316765;3324.517944898025;3327.9168020799675;3333.2666813301034;6169.136320915076;6347.793919155346;6391.328910464427;6472.925360453747;6491.513136514686;6238.719257633417;6249.7187626556915;6282.340354262737;6302.873942521124;6316.494680425647;6301.212348456443;6320.304766475684;6331.461825744863;6363.745450182034;6401.0156851375295;5821.893840170354;6201.131841542278;6238.656873871981;6245.156903818108;6286.371362863677;6116.480099191618;6118.326984031664;6168.938310616836;6187.535934804998;6195.783147589813;6223.097650840512;6378.968105159444;6390.188317140443;6393.680315984089;6469.644169570719;4197.790110494402;4209.179210054132;4217.493900731809;4238.57614238586;4250.107477429774;6170.907436388368;6235.189425374672;6249.593776404519;6262.279837818527;6267.905981410191;5898.321693005188;5964.761409543569;5977.282726072899;5982.371850955587;6040;5943.881122377442;5985.371535988833;6000.609960352563;6031.185789918305;6054.75780968774;5622.425720798019;5923.815236952713;5937.554683398849;5939.584229103922;5993.730282137227;6035.547333949883;6046.7581296749395;6066.302375226729;6098.603590766586;6104.4505994460715;5950.613210141327;5983.970080149571;5994.490468310242;6005.969970150121;6017.097435384552 01:46:00 INFO - PROCESS | 3452 | |5;yui.html;646.3891622416818;693.3551796828947;715.5884668666595;808.5108509351842;855.8887344645195;14447.205403702792;15820.525384238492;15892.284847181876;15892.920535397336;15923.761143582855;14182.219977901212;14325.426982920697;14488.492902748407;14613.92693036536;14928.477503287388;773.3078894389532;789.159545084486;791.8812178173263;792.9484583502054;793.1275596843484;770.2528547309101;785.5561607691665;801.3589128697048;802.7070119406404;804.6097642643314;828.8010877389413;832.5213002523543;832.9333653307721;833.7332053742805;833.7498750374893;824.0070714788666;824.7938015496126;825.1500954017341;827.7682248970298;827.9337652987747;598.7994022002634;599.3048064245454;601.9337872833985;602.8251806975971;604.3925854516227;15024.699506009927;15090.924545377313;15102;15109.320080596399;15116;13598.864011359958;14494.565163045125;14606.780898286534;14696.338664760111;14948.47680331194;11067.667969960914;11093.1125509959;11104.55581776728;11229.157813164045;11285.830712539318;3841.1741475582885;3844.4233364995475;3952.051507638146;4022.0950286185666;4030.5767894371256;83378.58310708468;83850.16149838484;84081;84593;84638.15361846365;10331.431771252654;10494.511531277754;10505.31715438494;10538;10671.573137074585;19979.700304495444;20852.37442876716;20906.790932090484;21040.684389734168;21188.15247390087;8323;8405;8577.914220857836;8791.164839340252;8865.778355541162;4950.678205916676;5015.322931404214;5115.335006449138;5132.409772876093;5137;3337.466005439118;3445.7415693823064;3452.430348992438;3469.7918124912585;3476.443768996999;610.9450149486568;611.5871786544064;611.8409213604494;616.1681729665006;616.4328817487922;693.8716337477583;706.1279320039747;715.9355657990702;728.2135293882594;730.5981710059446;10092;10180.6436774714;10241.129503992095;10388.636397726043;10493.632722854663;650.9381608747161;666.6933210723025;710.4955481608116;714.8963400306926;735.8785800342883;4721.268203428474;4943.332650092191;4951.08684823969;4998.525140111684;5033.723145227048;115588;117263;117543;117771;120889.39555302344;99883.50058249662;101777.49111254397;102301;103326.48336758268;104109.47945260225;87191;90375;90380.54809726041;91026;91772.54113729388;9082.318826087938;9401.576929038072;9597.985216326368;9731.133135282336;9732.331184456913;53313.73343133259;53743;54647;54999.17501237565;55255.17117243164;67361.66319168372;74718.6264068698;75526.62236688781;76558.61720691361;78133.21866781487;11978.76042479163;11995.460204290654;12156.878431215575;12193.573224937085;12222.694432639255;13797.724045519235;13952;13956.581302560939;14308.427662893368;15196;12332.445039973401;12630;12721.55474558423;12864.871351286742;13089.738205235652;12544.310062946626;12911.870881291066;12947.935260323638;12958.611241662387;13477.056606037484;12485.687857803627;12573.622791316275;12608.180468269533;12844.935775321064;13057.542985995444;10049.949750251202;10195.643152489924;10404.895951040393;10538.525766340379;10710.250282480463;10971.780564388828;11011.657470383681;11137.721556961142;11349;11350.716232094264 01:46:00 INFO - PROCESS | 3452 | __end_tp_report 01:46:00 INFO - PROCESS | 3452 | __start_cc_report 01:46:00 INFO - PROCESS | 3452 | _x_x_mozilla_cycle_collect,360 01:46:00 INFO - PROCESS | 3452 | __end_cc_report 01:46:00 INFO - PROCESS | 3452 | __startTimestamp1467708360952__endTimestamp 01:46:00 INFO - PROCESS | 3452 | 01:46:00 INFO - PROCESS | 3452 | ------- Summary: start ------- 01:46:00 INFO - PROCESS | 3452 | Number of tests: 6 01:46:00 INFO - PROCESS | 3452 | 01:46:00 INFO - PROCESS | 3452 | [#0] dojo.html Cycles:165 Average:5193.75 Median:5432.92 stddev:687.52 (12.7%) stddev-sans-first:668.59 01:46:00 INFO - PROCESS | 3452 | Values: 3042.4 3070.1 3085.4 3112.2 3129.4 5121.8 5181.1 5235.5 5279.0 5302.1 5151.2 5156.6 5229.2 5263.6 5276.1 4676.5 4762.2 4814.7 4888.4 4919.9 533.6 4698.7 4705.8 4789.3 4845.6 4724.6 4760.6 4787.7 4801.2 4834.8 4790.1 4796.7 4796.9 4801.1 4809.3 4696.9 4699.0 4762.2 4764.6 4829.3 5190.1 5211.8 5250.1 5250.6 5254.3 5625.2 5630.9 5643.0 5644.5 5675.6 5438.8 5532.9 5611.0 5624.3 5661.5 5268.3 5271.3 5277.7 5277.8 5288.2 5590.4 5758.0 5767.6 5772.2 5830.6 5419.2 5437.2 5495.8 5512.3 5529.2 5554.9 5572.9 5576.6 5582.8 5586.7 5482.7 5484.9 5571.0 5571.2 5619.7 5552.1 5578.6 5596.6 5608.6 5641.7 4248.7 4273.9 4289.3 4317.3 4333.5 3824.2 3840.1 3846.4 3864.0 3890.8 5224.3 5267.9 5284.6 5324.5 5458.6 5593.1 5593.2 5596.3 5655.1 5660.6 5196.2 5332.2 5367.2 5367.7 5373.1 4876.5 4934.8 4936.0 4973.7 4987.1 5826.6 5862.9 5865.5 5881.8 5944.6 5490.3 5578.4 5638.2 5687.8 5690.9 5807.6 5851.8 5863.1 5881.4 5921.7 5582.2 5603.1 5605.7 5621.3 5623.2 5520.0 5553.9 5560.9 5638.8 5687.9 5389.8 5414.0 5433.2 5454.4 5499.9 5418.4 5465.3 5471.5 5493.5 5545.8 5253.4 5356.1 5431.9 5442.0 5495.6 5449.8 5535.5 5552.8 5553.7 5556.7 5229.0 5432.9 5437.2 5442.4 5446.3 01:46:00 INFO - PROCESS | 3452 | 01:46:00 INFO - PROCESS | 3452 | [#1] ext.html Cycles:180 Average:56917.57 Median:24205.79 stddev:112926.56 (466.5%) stddev-sans-first:113164.13 01:46:00 INFO - PROCESS | 3452 | Values: 580.5 609.1 616.5 627.2 633.3 33098.0 43491.0 44023.0 44465.6 44574.1 45613.4 45737.3 46280.0 46335.5 46415.5 8960.7 9109.7 9114.4 9138.5 9145.5 8867.1 8891.3 8939.3 8959.8 8978.6 8969.5 8982.6 8983.5 9003.1 9008.7 8884.8 8915.6 8923.0 8952.7 8960.3 9008.2 9062.0 9067.8 9080.6 9085.5 43329.1 43383.6 43450.8 43662.6 43710.8 3466.2 3498.7 3585.1 3651.4 4221.2 32754.2 33105.3 33305.0 33343.3 33558.3 4348.8 4388.6 4429.8 4495.3 4574.7 252086.0 252444.0 252695.0 253785.0 254382.0 34153.0 34942.7 55093.7 55869.7 55986.0 36558.5 36620.8 36636.8 36706.3 36766.0 15141.3 15154.3 15176.7 15201.0 15315.2 12880.2 12899.9 12927.8 12931.2 12943.9 8355.9 8368.8 8371.4 8376.1 8434.0 3226.3 3235.9 3248.0 3271.6 3309.1 1024.1 1056.5 1066.3 1104.7 1112.1 32290.4 32429.8 32834.0 33161.2 33253.0 1057.6 1100.9 1139.4 1152.1 1175.1 16263.0 16328.2 16495.2 16532.9 16920.1 525285.0 528278.0 531319.0 532744.0 534068.0 56960.4 58934.0 59082.7 59097.4 59292.7 1350.6 1352.7 1355.3 1356.9 1368.9 30100.4 31067.2 31218.7 31347.2 31850.4 49041.8 49208.8 49263.8 49545.8 49771.5 440945.0 441192.0 442406.0 443564.0 444111.0 27925.2 28021.4 28154.0 28245.9 28474.3 48215.0 49485.0 49642.3 49782.8 53365.5 45084.8 45298.3 46374.5 46675.3 47474.3 46411.8 47218.0 47257.1 47341.5 47370.5 45358.8 45485.0 46041.8 47099.0 48176.5 39847.6 40152.6 40480.6 40640.8 40846.8 30338.8 30665.2 30728.2 30764.2 30894.0 01:46:00 INFO - PROCESS | 3452 | 01:46:00 INFO - PROCESS | 3452 | [#2] jquery.html Cycles:180 Average:31479.06 Median:27781.79 stddev:82894.14 (298.4%) stddev-sans-first:83093.79 01:46:00 INFO - PROCESS | 3452 | Values: 377.8 379.0 379.6 393.5 394.8 15736.8 18533.7 19215.3 20065.2 20650.3 16098.6 16143.1 19793.3 20640.0 20914.8 6338.5 6554.4 6644.0 6698.5 6708.5 6523.6 6908.9 7249.6 7255.6 7303.5 7183.1 7244.8 7308.1 7333.1 7338.7 7104.6 7206.0 7262.7 7298.9 7333.8 6930.1 7020.2 7068.1 7085.9 7126.4 26388.5 26639.5 27193.2 27701.6 27862.0 2618.5 2922.5 2985.9 3004.3 3371.2 15667.4 15900.6 16033.9 16672.3 17209.5 2119.8 2131.1 2140.7 2216.8 2237.4 97005.0 99076.5 100414.0 101064.5 101260.5 16519.7 17691.7 18155.5 18526.0 18643.7 11680.2 12372.9 32075.7 32204.0 32269.4 7606.2 7636.9 7879.6 7907.4 8012.8 7959.4 7978.9 8025.6 8081.2 8165.8 3871.7 3950.0 4112.5 4130.8 4165.9 2001.2 2030.4 2056.0 2061.4 2088.5 963.4 969.1 979.8 992.7 1014.9 19790.3 19823.1 19887.4 19887.8 19932.6 992.5 993.7 1010.6 1029.8 1038.6 10704.4 10956.7 10980.7 11053.9 11106.1 487270.0 490956.0 502098.0 504475.0 510546.0 102206.0 103702.5 106933.5 107195.8 108683.5 994.8 1027.2 1040.6 1041.0 1062.1 14675.3 18161.9 18162.5 18202.5 18512.7 46341.3 46930.3 47025.0 47414.8 47946.5 64429.0 64999.7 65029.7 66510.0 66550.7 8683.7 8711.7 8742.1 8770.0 8806.3 9992.9 13705.2 13782.7 13876.2 14164.2 8070.9 12145.6 12226.3 12364.4 12565.4 11818.3 12080.3 12209.8 12292.1 12601.5 12400.1 12487.1 12499.0 12567.4 12694.4 7405.2 8518.4 8694.7 8935.3 9045.6 11018.6 12476.6 12575.6 12717.6 12909.5 01:46:00 INFO - PROCESS | 3452 | 01:46:00 INFO - PROCESS | 3452 | [#3] mootools.html Cycles:180 Average:5467.60 Median:4944.89 stddev:3047.72 (61.6%) stddev-sans-first:3041.42 01:46:00 INFO - PROCESS | 3452 | Values: 1464.6 1493.4 1562.6 1691.5 1728.5 7370.3 7904.6 7960.8 8462.1 8482.8 7959.6 8166.3 8242.6 8250.3 8256.2 2163.6 2184.9 2194.9 2194.9 2198.0 2121.1 2163.3 2199.7 2204.3 2205.1 2173.6 2194.0 2195.3 2200.2 2215.2 2148.4 2159.9 2170.8 2171.2 2171.6 2051.5 2113.9 2132.8 2161.3 2171.2 8322.2 8336.2 8346.2 8351.5 8358.2 4751.7 4870.3 4892.3 4923.2 4927.1 3165.6 3169.7 3183.6 3245.0 3256.7 1030.6 1066.3 1075.5 1108.4 1109.3 11230.4 11245.2 11251.5 11279.3 11289.7 4184.2 4194.0 4347.8 4354.2 4356.0 9620.1 9684.6 9713.4 9716.1 9804.0 4942.1 4953.7 4982.1 5007.0 5010.6 3977.8 4586.9 4607.5 4608.4 4611.7 3721.9 3726.0 3823.8 3833.2 3835.7 1147.5 1150.2 1152.0 1161.7 1187.1 864.9 905.4 975.3 1005.1 1008.3 5647.7 5915.9 5994.5 6064.0 6137.4 972.3 979.4 997.6 1018.6 1023.2 4100.1 4101.6 4165.4 4176.4 4188.4 9891.0 10246.1 10246.4 10291.3 10321.4 10158.4 10226.9 10234.2 10255.7 10259.0 7495.9 7517.9 7604.8 7796.9 7808.4 5791.9 5953.8 6049.5 6073.1 6227.7 9386.4 9512.4 9567.9 9628.5 9637.2 8722.6 8920.2 9042.4 9214.3 9631.1 6737.3 7036.2 7206.4 7294.9 7552.5 8094.6 8125.2 8140.6 8143.0 8168.2 7046.6 7313.0 7390.1 7419.1 7475.9 6986.2 7086.1 7111.6 7241.4 7241.9 6411.8 6491.8 6515.8 6542.1 6547.0 4947.7 4965.0 5007.3 5031.5 5058.1 4886.6 4916.2 4970.9 4999.6 5067.2 01:46:00 INFO - PROCESS | 3452 | 01:46:00 INFO - PROCESS | 3452 | [#4] prototype.html Cycles:180 Average:4967.18 Median:5628.39 stddev:1506.17 (26.8%) stddev-sans-first:1468.95 01:46:00 INFO - PROCESS | 3452 | Values: 291.9 302.5 304.3 306.2 306.3 5530.5 5566.9 5750.2 5786.2 5815.3 5649.3 5686.2 5760.1 5818.2 5828.7 4454.3 4466.9 4472.1 4487.7 4492.9 4375.3 4431.4 4437.6 4459.0 4470.8 4378.1 4391.4 4399.8 4425.1 4426.5 4396.9 4417.7 4419.9 4430.5 4432.6 3523.8 3743.4 3881.9 3887.6 3888.0 5564.7 5569.9 5594.3 5605.4 5634.4 4907.5 4911.7 4942.5 4959.4 4978.3 5728.6 5890.2 5921.2 5930.8 5946.4 4067.4 4085.6 4087.6 4091.5 4104.5 6169.3 6172.4 6195.3 6201.0 6201.8 4037.7 4125.6 4126.7 4133.3 4166.3 4199.3 4206.3 4211.9 4218.9 4224.4 4915.3 4920.2 4950.9 4952.2 4962.7 5803.3 5943.1 5995.9 5997.5 6020.8 1439.2 1448.5 1450.5 1460.5 1463.3 877.7 893.2 902.8 905.7 912.5 5085.4 5101.9 5126.8 5131.2 5182.7 5441.7 5443.5 5453.7 5458.1 5502.9 5146.6 5168.0 5196.0 5370.5 5807.5 3262.2 3291.6 3324.5 3327.9 3333.3 6169.1 6347.8 6391.3 6472.9 6491.5 6238.7 6249.7 6282.3 6302.9 6316.5 6301.2 6320.3 6331.5 6363.7 6401.0 5821.9 6201.1 6238.7 6245.2 6286.4 6116.5 6118.3 6168.9 6187.5 6195.8 6223.1 6379.0 6390.2 6393.7 6469.6 4197.8 4209.2 4217.5 4238.6 4250.1 6170.9 6235.2 6249.6 6262.3 6267.9 5898.3 5964.8 5977.3 5982.4 6040.0 5943.9 5985.4 6000.6 6031.2 6054.8 5622.4 5923.8 5937.6 5939.6 5993.7 6035.5 6046.8 6066.3 6098.6 6104.5 5950.6 5984.0 5994.5 6006.0 6017.1 01:46:00 INFO - PROCESS | 3452 | 01:46:00 INFO - PROCESS | 3452 | [#5] yui.html Cycles:180 Average:21221.85 Median:3898.24 stddev:31195.23 (800.2%) stddev-sans-first:31244.49 01:46:00 INFO - PROCESS | 3452 | Values: 646.4 693.4 715.6 808.5 855.9 14447.2 15820.5 15892.3 15892.9 15923.8 14182.2 14325.4 14488.5 14613.9 14928.5 773.3 789.2 791.9 792.9 793.1 770.3 785.6 801.4 802.7 804.6 828.8 832.5 832.9 833.7 833.7 824.0 824.8 825.2 827.8 827.9 598.8 599.3 601.9 602.8 604.4 15024.7 15090.9 15102.0 15109.3 15116.0 13598.9 14494.6 14606.8 14696.3 14948.5 11067.7 11093.1 11104.6 11229.2 11285.8 3841.2 3844.4 3952.1 4022.1 4030.6 83378.6 83850.2 84081.0 84593.0 84638.2 10331.4 10494.5 10505.3 10538.0 10671.6 19979.7 20852.4 20906.8 21040.7 21188.2 8323.0 8405.0 8577.9 8791.2 8865.8 4950.7 5015.3 5115.3 5132.4 5137.0 3337.5 3445.7 3452.4 3469.8 3476.4 610.9 611.6 611.8 616.2 616.4 693.9 706.1 715.9 728.2 730.6 10092.0 10180.6 10241.1 10388.6 10493.6 650.9 666.7 710.5 714.9 735.9 4721.3 4943.3 4951.1 4998.5 5033.7 115588.0 117263.0 117543.0 117771.0 120889.4 99883.5 101777.5 102301.0 103326.5 104109.5 87191.0 90375.0 90380.5 91026.0 91772.5 9082.3 9401.6 9598.0 9731.1 9732.3 53313.7 53743.0 54647.0 54999.2 55255.2 67361.7 74718.6 75526.6 76558.6 78133.2 11978.8 11995.5 12156.9 12193.6 12222.7 13797.7 13952.0 13956.6 14308.4 15196.0 12332.4 12630.0 12721.6 12864.9 13089.7 12544.3 12911.9 12947.9 12958.6 13477.1 12485.7 12573.6 12608.2 12844.9 13057.5 10049.9 10195.6 10404.9 10538.5 10710.3 10971.8 11011.7 11137.7 11349.0 11350.7 01:46:00 INFO - PROCESS | 3452 | -------- Summary: end -------- 01:46:00 INFO - PROCESS | 3452 | 01:46:01 INFO - TEST-INFO | 3452: exit 0 01:46:01 INFO - TEST-OK | dromaeo_css | took 1111106ms 01:46:01 INFO - TEST-START | kraken 01:46:01 INFO - operating with platform_type : linux_ 01:46:01 INFO - Initialising browser for kraken test... 01:46:01 INFO - TEST-INFO | started process 3698 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKbAsMh/profile http://localhost:55570/getInfo.html) 01:46:06 INFO - PROCESS | 3698 | __metrics Screen width/height:1600/1200 01:46:06 INFO - PROCESS | 3698 | colorDepth:24 01:46:06 INFO - PROCESS | 3698 | Browser inner width/height: 1024/697 01:46:06 INFO - PROCESS | 3698 | __metrics 01:46:06 ERROR - PROCESS | 3698 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 01:46:07 INFO - TEST-INFO | 3698: exit 0 01:46:07 INFO - Browser initialized. 01:46:07 INFO - Running cycle 1/1 for kraken test... 01:46:07 INFO - TEST-INFO | started process 3816 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKbAsMh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:46:19 INFO - PROCESS | 3816 | RSS: Main: 168390656 01:46:19 INFO - PROCESS | 3816 | 01:46:21 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:55570/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55570/tests/kraken/driver.html?testName=audio-beat-detection) 01:46:22 INFO - PROCESS | 3816 | RSS: Main: 173920256 01:46:22 INFO - PROCESS | 3816 | 01:46:25 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:55570/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55570/tests/kraken/driver.html?testName=audio-dft) 01:46:25 INFO - PROCESS | 3816 | RSS: Main: 173330432 01:46:25 INFO - PROCESS | 3816 | 01:46:28 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:55570/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55570/tests/kraken/driver.html?testName=audio-fft) 01:46:29 INFO - PROCESS | 3816 | RSS: Main: 168050688 01:46:29 INFO - PROCESS | 3816 | 01:46:31 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:55570/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55570/tests/kraken/driver.html?testName=audio-oscillator) 01:46:32 INFO - PROCESS | 3816 | RSS: Main: 169402368 01:46:32 INFO - PROCESS | 3816 | 01:46:34 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:55570/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55570/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:46:34 INFO - PROCESS | 3816 | RSS: Main: 169570304 01:46:34 INFO - PROCESS | 3816 | 01:46:38 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:55570/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55570/tests/kraken/driver.html?testName=imaging-darkroom) 01:46:38 INFO - PROCESS | 3816 | RSS: Main: 169619456 01:46:38 INFO - PROCESS | 3816 | 01:46:42 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:55570/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55570/tests/kraken/driver.html?testName=imaging-desaturate) 01:46:42 INFO - PROCESS | 3816 | RSS: Main: 170000384 01:46:42 INFO - PROCESS | 3816 | 01:46:45 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:55570/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55570/tests/kraken/driver.html?testName=json-parse-financial) 01:46:46 INFO - PROCESS | 3816 | RSS: Main: 170033152 01:46:46 INFO - PROCESS | 3816 | 01:46:47 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:55570/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55570/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:46:48 INFO - PROCESS | 3816 | RSS: Main: 169910272 01:46:48 INFO - PROCESS | 3816 | 01:46:50 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:55570/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55570/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:46:50 INFO - PROCESS | 3816 | RSS: Main: 169873408 01:46:50 INFO - PROCESS | 3816 | 01:46:52 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:55570/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55570/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:46:53 INFO - PROCESS | 3816 | RSS: Main: 169832448 01:46:53 INFO - PROCESS | 3816 | 01:46:56 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:55570/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55570/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:46:56 INFO - PROCESS | 3816 | RSS: Main: 170401792 01:46:56 INFO - PROCESS | 3816 | 01:46:59 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:55570/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55570/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:46:59 INFO - PROCESS | 3816 | RSS: Main: 170524672 01:46:59 INFO - PROCESS | 3816 | 01:47:01 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:55570/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55570/tests/kraken/driver.html?testName=ai-astar) 01:47:01 INFO - PROCESS | 3816 | RSS: Main: 171167744 01:47:01 INFO - PROCESS | 3816 | 01:47:01 INFO - PROCESS | 3816 | __start_tp_report 01:47:01 INFO - PROCESS | 3816 | _x_x_mozilla_page_load 01:47:01 INFO - PROCESS | 3816 | _x_x_mozilla_page_load_details 01:47:01 INFO - PROCESS | 3816 | |i|pagename|runs| 01:47:01 INFO - PROCESS | 3816 | |0;ai-astar;110;113;105;111;113;111;112;112;113;112 01:47:01 INFO - PROCESS | 3816 | |1;audio-beat-detection;145;116;140;170;117;147;146;117;185;117 01:47:01 INFO - PROCESS | 3816 | |2;audio-dft;162;165;161;162;163;165;175;169;162;162 01:47:01 INFO - PROCESS | 3816 | |3;audio-fft;76;75;74;167;76;75;76;77;163;76 01:47:01 INFO - PROCESS | 3816 | |4;audio-oscillator;85;86;154;85;85;85;138;85;85;133 01:47:01 INFO - PROCESS | 3816 | |5;imaging-gaussian-blur;118;117;117;117;118;117;118;118;118;118 01:47:01 INFO - PROCESS | 3816 | |6;imaging-darkroom;147;147;149;147;147;147;148;147;147;148 01:47:01 INFO - PROCESS | 3816 | |7;imaging-desaturate;96;97;96;95;95;95;96;96;97;96 01:47:01 INFO - PROCESS | 3816 | |8;json-parse-financial;56;55;55;55;55;55;56;55;61;56 01:47:01 INFO - PROCESS | 3816 | |9;json-stringify-tinderbox;61;60;62;61;61;61;61;61;61;61 01:47:01 INFO - PROCESS | 3816 | |10;stanford-crypto-aes;76;75;76;76;77;75;78;83;80;75 01:47:01 INFO - PROCESS | 3816 | |11;stanford-crypto-ccm;119;118;120;132;123;133;121;122;199;129 01:47:01 INFO - PROCESS | 3816 | |12;stanford-crypto-pbkdf2;157;159;159;157;155;162;156;162;157;155 01:47:01 INFO - PROCESS | 3816 | |13;stanford-crypto-sha256-iterative;63;65;64;62;63;63;64;63;62;64 01:47:01 INFO - PROCESS | 3816 | __end_tp_report 01:47:01 INFO - PROCESS | 3816 | __start_cc_report 01:47:01 INFO - PROCESS | 3816 | _x_x_mozilla_cycle_collect,966 01:47:01 INFO - PROCESS | 3816 | __end_cc_report 01:47:01 INFO - PROCESS | 3816 | __startTimestamp1467708421891__endTimestamp 01:47:01 INFO - PROCESS | 3816 | 01:47:01 INFO - PROCESS | 3816 | ------- Summary: start ------- 01:47:01 INFO - PROCESS | 3816 | Number of tests: 14 01:47:01 INFO - PROCESS | 3816 | 01:47:01 INFO - PROCESS | 3816 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:2.39 (2.1%) stddev-sans-first:2.50 01:47:01 INFO - PROCESS | 3816 | Values: 110.0 113.0 105.0 111.0 113.0 111.0 112.0 112.0 113.0 112.0 01:47:01 INFO - PROCESS | 3816 | 01:47:01 INFO - PROCESS | 3816 | [#1] audio-beat-detection Cycles:10 Average:140.00 Median:145.50 stddev:24.03 (16.5%) stddev-sans-first:25.42 01:47:01 INFO - PROCESS | 3816 | Values: 145.0 116.0 140.0 170.0 117.0 147.0 146.0 117.0 185.0 117.0 01:47:01 INFO - PROCESS | 3816 | 01:47:01 INFO - PROCESS | 3816 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:4.35 (2.7%) stddev-sans-first:4.51 01:47:01 INFO - PROCESS | 3816 | Values: 162.0 165.0 161.0 162.0 163.0 165.0 175.0 169.0 162.0 162.0 01:47:01 INFO - PROCESS | 3816 | 01:47:01 INFO - PROCESS | 3816 | [#3] audio-fft Cycles:10 Average:93.50 Median:76.00 stddev:37.70 (49.6%) stddev-sans-first:39.46 01:47:01 INFO - PROCESS | 3816 | Values: 76.0 75.0 74.0 167.0 76.0 75.0 76.0 77.0 163.0 76.0 01:47:01 INFO - PROCESS | 3816 | 01:47:01 INFO - PROCESS | 3816 | [#4] audio-oscillator Cycles:10 Average:102.10 Median:85.00 stddev:27.79 (32.7%) stddev-sans-first:28.78 01:47:01 INFO - PROCESS | 3816 | Values: 85.0 86.0 154.0 85.0 85.0 85.0 138.0 85.0 85.0 133.0 01:47:01 INFO - PROCESS | 3816 | 01:47:01 INFO - PROCESS | 3816 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 01:47:01 INFO - PROCESS | 3816 | Values: 118.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 118.0 118.0 01:47:01 INFO - PROCESS | 3816 | 01:47:01 INFO - PROCESS | 3816 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 01:47:01 INFO - PROCESS | 3816 | Values: 147.0 147.0 149.0 147.0 147.0 147.0 148.0 147.0 147.0 148.0 01:47:01 INFO - PROCESS | 3816 | 01:47:01 INFO - PROCESS | 3816 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 01:47:01 INFO - PROCESS | 3816 | Values: 96.0 97.0 96.0 95.0 95.0 95.0 96.0 96.0 97.0 96.0 01:47:01 INFO - PROCESS | 3816 | 01:47:01 INFO - PROCESS | 3816 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:55.50 stddev:1.85 (3.3%) stddev-sans-first:1.96 01:47:01 INFO - PROCESS | 3816 | Values: 56.0 55.0 55.0 55.0 55.0 55.0 56.0 55.0 61.0 56.0 01:47:01 INFO - PROCESS | 3816 | 01:47:01 INFO - PROCESS | 3816 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 01:47:01 INFO - PROCESS | 3816 | Values: 61.0 60.0 62.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 01:47:01 INFO - PROCESS | 3816 | 01:47:01 INFO - PROCESS | 3816 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:76.50 stddev:2.60 (3.4%) stddev-sans-first:2.73 01:47:01 INFO - PROCESS | 3816 | Values: 76.0 75.0 76.0 76.0 77.0 75.0 78.0 83.0 80.0 75.0 01:47:01 INFO - PROCESS | 3816 | 01:47:01 INFO - PROCESS | 3816 | [#11] stanford-crypto-ccm Cycles:10 Average:131.60 Median:126.00 stddev:24.29 (19.3%) stddev-sans-first:25.33 01:47:01 INFO - PROCESS | 3816 | Values: 119.0 118.0 120.0 132.0 123.0 133.0 121.0 122.0 199.0 129.0 01:47:01 INFO - PROCESS | 3816 | 01:47:01 INFO - PROCESS | 3816 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.90 Median:158.00 stddev:2.56 (1.6%) stddev-sans-first:2.69 01:47:01 INFO - PROCESS | 3816 | Values: 157.0 159.0 159.0 157.0 155.0 162.0 156.0 162.0 157.0 155.0 01:47:01 INFO - PROCESS | 3816 | 01:47:01 INFO - PROCESS | 3816 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.50 stddev:0.95 (1.5%) stddev-sans-first:1.00 01:47:01 INFO - PROCESS | 3816 | Values: 63.0 65.0 64.0 62.0 63.0 63.0 64.0 63.0 62.0 64.0 01:47:01 INFO - PROCESS | 3816 | -------- Summary: end -------- 01:47:01 INFO - PROCESS | 3816 | 01:47:02 INFO - TEST-INFO | 3816: exit 0 01:47:02 INFO - TEST-OK | kraken | took 61206ms 01:47:02 INFO - SUITE-END | took 1172s 01:47:03 INFO - Completed test suite (00:19:32) 01:47:03 INFO - javascript benchmark 01:47:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7272.793480955486, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3042.4371491274114, 3070.125014370905, 3085.413771383437, 3112.1597168764433, 3129.389768995047, 5121.820736274231, 5181.093308670982, 5235.528802407783, 5279.0, 5302.125149350362, 5151.150060240056, 5156.561692256153, 5229.189475631283, 5263.605229607785, 5276.103062479378, 4676.508966558514, 4762.166620841356, 4814.711117332971, 4888.364512613355, 4919.926201106986, 533.6040759748361, 4698.694584851974, 4705.764711764416, 4789.305550695147, 4845.588125009378, 4724.59840913521, 4760.642951778613, 4787.712737235742, 4801.231802911552, 4834.806607735686, 4790.113828941657, 4796.664233503656, 4796.880077998043, 4801.1117943180625, 4809.326694262806, 4696.9060618787435, 4699.013207226452, 4762.2380419133115, 4764.595009424203, 4829.2997515360075, 5190.06578815813, 5211.817586384496, 5250.133727934886, 5250.579953603703, 5254.264402983586, 5625.156226566007, 5630.943690563124, 5643.040683083845, 5644.5484361251, 5675.602707810455, 5438.755256013489, 5532.917006244869, 5611.018071837412, 5624.268845050117, 5661.5187709044785, 5268.262443257985, 5271.28837606922, 5277.70972596507, 5277.815276465305, 5288.153895376721, 5590.440955904377, 5758.049921762862, 5767.596268261182, 5772.2207501986695, 5830.5627077968475, 5419.187121931742, 5437.211604317431, 5495.752691128909, 5512.3385193777, 5529.198266251371, 5554.86112847174, 5572.86067848307, 5576.6375185613615, 5582.8325150245555, 5586.664800112007, 5482.698451585201, 5484.862878428071, 5571.0, 5571.220029195916, 5619.690916999604, 5552.056150454432, 5578.609497335228, 5596.608237423423, 5608.635438696553, 5641.689707066069, 4248.723832950848, 4273.87178384649, 4289.313709806416, 4317.266064768997, 4333.523312435629, 3824.2160357126722, 3840.116773142193, 3846.4230365445405, 3863.9806800965816, 3890.7665540067687, 5224.320838291073, 5267.868303292448, 5284.630075894727, 5324.494173053554, 5458.563314934796, 5593.105103183552, 5593.244911936918, 5596.300462442195, 5655.095184770417, 5660.575456840754, 5196.194589838581, 5332.200169974535, 5367.1680889462195, 5367.677939323653, 5373.059714549938, 4876.536729010738, 4934.827281045146, 4935.975320123376, 4973.701577905337, 4987.102321582078, 5826.563007774349, 5862.882742345129, 5865.501432378211, 5881.764729410861, 5944.583879128506, 5490.286262785812, 5578.386377498391, 5638.182463542681, 5687.800926967537, 5690.857728556736, 5807.622504537191, 5851.795187168429, 5863.091220860773, 5881.441263080001, 5921.733521991607, 5582.218489411567, 5603.075492543685, 5605.691686957257, 5621.325440947113, 5623.2408624835125, 5520.0, 5553.888922221614, 5560.860978475571, 5638.802641907513, 5687.857803554944, 5389.784408623768, 5413.998410294108, 5433.157860531624, 5454.427285135003, 5499.917501237404, 5418.431064738145, 5465.344158700822, 5471.480209380103, 5493.505584497414, 5545.7781688732, 5253.369595648546, 5356.143017117242, 5431.945680543144, 5442.047641662773, 5495.6153069286365, 5449.836504904859, 5535.474129957647, 5552.7778888843995, 5553.666779993213, 5556.694381809039, 5228.9738551307, 5432.9185062223305, 5437.238786569805, 5442.401335852974, 5446.264754258124], "value": 5150.227988550479, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.4543728894838, 609.1015751766145, 616.4790751814717, 627.159606127789, 633.303366297073, 33098.0, 43491.0, 44023.0, 44465.555344446504, 44574.10851782963, 45613.43865613437, 45737.31394029084, 46280.0, 46335.53664463355, 46415.53584464154, 8960.686375976826, 9109.726708198732, 9114.40756350835, 9138.543072846363, 9145.542722863864, 8867.113288671146, 8891.288696904265, 8939.284857211407, 8959.776005599848, 8978.640854365818, 8969.461832290051, 8982.640694372218, 8983.460992340448, 9003.054679258681, 9008.729738107868, 8884.822303553925, 8915.643374265022, 8922.955385223033, 8952.731418057469, 8960.327975401839, 9008.1892629663, 9061.954690226572, 9067.81864362709, 9080.591373388148, 9085.454872707593, 43329.133417331795, 43383.56616433858, 43450.782746086385, 43662.56337436617, 43710.781446092886, 3466.168119651291, 3498.7201023918024, 3585.085803120188, 3651.361011822947, 4221.2190744712325, 32754.181145471317, 33105.337893242, 33305.0, 33343.3331333372, 33558.32883342344, 4348.847790327323, 4388.5830846069575, 4429.800658970354, 4495.258282383403, 4574.72551646899, 252086.0, 252444.0, 252695.0, 253785.0, 254382.0, 34153.0, 34942.65057349394, 55093.72453137708, 55869.720651396485, 55986.0, 36558.45162322514, 36620.81689591535, 36636.81681591575, 36706.26587468236, 36766.0, 15141.318640661197, 15154.318055687521, 15176.696466070616, 15201.0, 15315.15766632846, 12880.227186368847, 12899.93550032244, 12927.806082908764, 12931.224126552437, 12943.935280323538, 8355.874661880076, 8368.790780230422, 8371.414001019992, 8376.078631350547, 8433.95783021081, 3226.2902161524426, 3235.854386552611, 3248.0, 3271.5910511186103, 3309.1396236978558, 1024.1499555369026, 1056.4506456642503, 1066.2855886556026, 1104.7017305327518, 1112.0825319111766, 32290.35419291648, 32429.837850810596, 32834.0, 33161.17097072592, 33253.0, 1057.5505410200633, 1100.8733995590449, 1139.3619573039125, 1152.0553146419854, 1175.0540814644123, 16263.0, 16328.183590820412, 16495.175241237892, 16532.917335413247, 16920.069396183328, 525285.0, 528278.0, 531319.0, 532744.0, 534068.0, 56960.43039569551, 58934.0, 59082.70458647679, 59097.40902590919, 59292.703536482906, 1350.5745690107585, 1352.6685961939388, 1355.3155656393458, 1356.8914486841227, 1368.904176707621, 30100.397992040474, 31067.22331941629, 31218.687813121578, 31347.216319592193, 31850.36299274048, 49041.754791225816, 49208.753956229986, 49263.75368123136, 49545.752271238416, 49771.50228497814, 440945.0, 441192.0, 442406.0, 443564.0, 444111.0, 27925.16224513268, 28021.439571208055, 28154.0, 28245.858770706014, 28474.288142796595, 48215.0, 49485.0, 49642.25536617026, 49782.75108624434, 53365.46634533605, 45084.77457612822, 45298.32052519149, 46374.53625463702, 46675.29987050129, 47474.28788568105, 46411.75588543982, 47218.0, 47257.05485890332, 47341.526584733714, 47370.52629473799, 45358.773206135076, 45485.0, 46041.76979115083, 47099.0, 48176.5182348172, 39847.60152398439, 40152.59847401606, 40480.59519404768, 40640.79679601583, 40846.79576602098, 30338.84830575833, 30665.233369165948, 30728.23179420443, 30764.230894227825, 30894.0], "value": 19093.378299057953, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.79599016531074, 378.97157713171504, 379.5843551311314, 393.50221969208974, 394.8164103691783, 15736.842631573682, 18533.721994170082, 19215.32746353878, 20065.197392104317, 20650.277240296593, 16098.59753506163, 16143.112128832909, 19793.307234246804, 20640.0, 20914.79085209151, 6338.524610654208, 6554.442872355856, 6644.0, 6698.531102822804, 6708.496862735315, 6523.608583485006, 6908.861822763542, 7249.637518124099, 7255.600941948191, 7303.5252708574035, 7183.102112235971, 7244.840825467926, 7308.123025236979, 7333.120025596909, 7338.669759860819, 7104.573725576456, 7205.963970180168, 7262.745803896864, 7298.854022919512, 7333.779986600411, 6930.13373328334, 7020.1575810902505, 7068.081149450539, 7085.893711594279, 7126.429885609191, 26388.472230555282, 26639.46721065568, 27193.1842044739, 27701.584476232874, 27862.0, 2618.4763047390597, 2922.488564501225, 2985.939991303078, 3004.324027093908, 3371.157210697326, 15667.373305067898, 15900.602484937968, 16033.919830400773, 16672.33310667572, 17209.483715488554, 2119.8198153157, 2131.05168200151, 2140.657494800824, 2216.789405006522, 2237.4182712494867, 97005.0, 99076.50461747717, 100414.0, 101064.49467752615, 101260.49369753104, 16519.6696066078, 17691.73462398065, 18155.54611134732, 18526.0, 18643.720344194848, 11680.182387232811, 12372.876271237352, 32075.679243207735, 32204.0, 32269.35461290761, 7606.163322034572, 7636.923630763621, 7879.645415956295, 7907.367410607138, 8012.799680008046, 7959.363250939911, 7978.920210797818, 8025.638846251933, 8081.191880811989, 8165.755027349189, 3871.7289789715014, 3949.980250098731, 4112.506499220112, 4130.834766609302, 4165.91668166641, 2001.2395289790077, 2030.3604364625096, 2055.9794402056086, 2061.4331058958905, 2088.4883203615213, 963.4123184857232, 969.1471505075489, 979.8334283171878, 992.731962370156, 1014.8883622801486, 19790.307339243056, 19823.107960141828, 19887.403377898685, 19887.801121988883, 19932.60134797296, 992.5136683025265, 993.7416271769248, 1010.570507534295, 1029.7734498410339, 1038.6157121864958, 10704.357738535713, 10956.671299861016, 10980.670579882617, 11053.944730276296, 11106.111511079256, 487270.0, 490956.0, 502098.0, 504475.0, 510546.0, 102206.0, 103702.48148759209, 106933.46533267284, 107195.8416266341, 108683.45658271817, 994.8411946077031, 1027.209049032256, 1040.625374865048, 1040.953157107932, 1062.0919114157593, 14675.339609717801, 18161.909190453964, 18162.4795889321, 18202.544936376165, 18512.72230916564, 46341.30488042615, 46930.296045560026, 47025.0, 47414.76292618653, 47946.5205347942, 64429.0, 64999.67500162658, 65029.67485162544, 66510.0, 66550.66898662096, 8683.739487815375, 8711.695090671796, 8742.082081381617, 8769.956150219208, 8806.283660690206, 9992.900070999198, 13705.246211458465, 13782.655433613838, 13876.167429954236, 14164.150150990974, 8070.919290807017, 12145.635630931087, 12226.327551984727, 12364.44360003784, 12565.371731413576, 11818.290902545874, 12080.275183489019, 12209.816852747394, 12292.139550231755, 12601.495940162291, 12400.069994750249, 12487.125901187193, 12499.000079993397, 12567.434465448894, 12694.428750706425, 7405.2224516425, 8518.403711740119, 8694.695685650971, 8935.28517718568, 9045.638174472948, 11018.559257629606, 12476.563320284109, 12575.622731318075, 12717.55488557896, 12909.483620655445], "value": 10200.827480620548, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1464.6265202373397, 1493.3951749541436, 1562.6015366081647, 1691.5179173935423, 1728.4900954218504, 7370.299821516961, 7904.6442910069045, 7960.800979975504, 8462.069172391031, 8482.830343393136, 7959.562224077674, 8166.305864001552, 8242.587870606461, 8250.298724608401, 8256.174382561741, 2163.6321825289738, 2184.8529522000917, 2194.9451263718374, 2194.9451263718374, 2197.9780202198012, 2121.1303365620097, 2163.264490073375, 2199.692043113965, 2204.2836078274545, 2205.0959106766227, 2173.56528694261, 2193.967090493644, 2195.2536137713173, 2200.2409168836807, 2215.1582398688474, 2148.4414052346347, 2159.8920053997394, 2170.750363708178, 2171.2183613898983, 2171.6091103601348, 2051.5384038591346, 2113.894305284745, 2132.829373650104, 2161.2651698422455, 2171.2183613898983, 8322.16778322169, 8336.166383361677, 8346.165383461666, 8351.457155284887, 8358.205970432798, 4751.714897106184, 4870.342503761982, 4892.290617860426, 4923.212286034253, 4927.137750893579, 3165.6201255849214, 3169.6988786065285, 3183.649798522161, 3244.9837750811093, 3256.739460843127, 1030.5884230899655, 1066.3122286125483, 1075.510642657589, 1108.3903852880883, 1109.3233127792041, 11230.382328971904, 11245.212835101545, 11251.493682784294, 11279.266847654877, 11289.717757056058, 4184.225918205142, 4193.958060419418, 4347.760873151944, 4354.172707185625, 4356.041670832412, 9620.086091821266, 9684.56419461126, 9713.36863103896, 9716.125548700651, 9804.0, 4942.061008408391, 4953.702777833341, 4982.078315511642, 5006.998600279959, 5010.574101201366, 3977.8209980550946, 4586.931196032062, 4607.470140933769, 4608.446986361658, 4611.746353950498, 3721.925561488755, 3725.962740372616, 3823.7705737655274, 3833.156705524836, 3835.6931445484292, 1147.4664281109324, 1150.2006105756586, 1152.0207823350254, 1161.7269941563725, 1187.0503597122267, 864.8918885139358, 905.3798148268457, 975.3465178330536, 1005.0803514784037, 1008.2690049713899, 5647.717614119278, 5915.940840591539, 5994.460498555151, 6063.969680151571, 6137.3862613738265, 972.2756546372856, 979.3683074416961, 997.6408492942535, 1018.6332920148741, 1023.247912784103, 4100.0569868930315, 4101.610347017028, 4165.416841642173, 4176.394422808737, 4188.434561334242, 9891.0, 10246.129079028366, 10246.385216886862, 10291.33106348085, 10321.380717156995, 10158.39049657023, 10226.897731022744, 10234.232432567587, 10255.692329230134, 10259.0, 7495.925040749523, 7517.887231691419, 7604.771856844303, 7796.883046754303, 7808.375329973588, 5791.884162316645, 5953.791617293374, 6049.51603871698, 6073.058675905242, 6227.657478838707, 9386.389884657476, 9512.381695190068, 9567.9043209567, 9628.47043412619, 9637.18083962871, 8722.563871806511, 8920.152585504626, 9042.412243204433, 9214.2628589714, 9631.08504692053, 6737.32626737342, 7036.2260151384335, 7206.387457066208, 7294.890576641461, 7552.546847188966, 8094.595270236582, 8125.187481252064, 8140.592970351578, 8142.959285203536, 8168.224018718212, 7046.647667616701, 7313.012743279589, 7390.113186417664, 7419.109706835215, 7475.925240747523, 6986.196587392515, 7086.149662040588, 7111.644417779194, 7241.4206863449745, 7241.855162896818, 6411.8397040072505, 6491.805245842632, 6515.837104072436, 6542.149520562297, 6546.967265163834, 4947.727874966768, 4964.950350496449, 5007.29897814299, 5031.471695471922, 5058.1401161803315, 4886.633502487257, 4916.188828843201, 4970.9254361183885, 4999.550040496373, 5067.214581739836], "value": 4408.442213814615, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.85407296351826, 302.5356078419626, 304.34413838178733, 306.24816076532113, 306.32913918518443, 5530.5299049580735, 5566.888662226763, 5750.223719797826, 5786.247787787593, 5815.273090863642, 5649.288341596036, 5686.2039314496005, 5760.107183386582, 5818.236337739571, 5828.737706803194, 4454.287314029756, 4466.8883277917985, 4472.1055788842195, 4487.708298960573, 4492.887677808065, 4375.343698445243, 4431.446069241345, 4437.557793717055, 4458.955410445887, 4470.798814053375, 4378.095528445137, 4391.407160033403, 4399.802008909607, 4425.070735145608, 4426.468823741139, 4396.912061758747, 4417.740943831025, 4419.867403977886, 4430.534793846632, 4432.578905004019, 3523.7533372663925, 3743.3636281832155, 3881.8835434936996, 3887.61123887609, 3888.0279930017496, 5564.749586268627, 5569.855605591836, 5594.272744543224, 5605.439456054402, 5634.3520495143175, 4907.484714105039, 4911.705297682115, 4942.481039490837, 4959.380077490314, 4978.327925730053, 5728.598998070137, 5890.234269544974, 5921.200637913913, 5930.822075337746, 5946.405359464062, 4067.410225517313, 4085.569086393591, 4087.5708050654553, 4091.509018917719, 4104.507459104897, 6169.290531588835, 6172.444479996821, 6195.256569211679, 6200.968995154995, 6201.829359724105, 4037.6971727120585, 4125.587441255911, 4126.741343890082, 4133.318002529609, 4166.312558427825, 4199.3412602022645, 4206.26390381682, 4211.936820947688, 4218.936715949263, 4224.366345048267, 4915.262710593368, 4920.237363208708, 4950.861301900511, 4952.232403977389, 4962.702237865739, 5803.332616749128, 5943.14728930116, 5995.850103747354, 5997.490213331828, 6020.795840831851, 1439.2372042817324, 1448.5364683301243, 1450.5358285348798, 1460.49612883555, 1463.3488097796592, 877.657713491726, 893.1916615463016, 902.7968707040864, 905.7410199822252, 912.5346073502561, 5085.415177254663, 5101.897962040813, 5126.846194614093, 5131.179011358165, 5182.689038657692, 5441.673499590037, 5443.482869127427, 5453.672779633234, 5458.099413596791, 5502.899420115993, 5146.588272938156, 5167.974160129175, 5195.974020129951, 5370.543503802142, 5807.477327040587, 3262.200760813616, 3291.6214635316765, 3324.517944898025, 3327.9168020799675, 3333.2666813301034, 6169.136320915076, 6347.793919155346, 6391.328910464427, 6472.925360453747, 6491.513136514686, 6238.719257633417, 6249.7187626556915, 6282.340354262737, 6302.873942521124, 6316.494680425647, 6301.212348456443, 6320.304766475684, 6331.461825744863, 6363.745450182034, 6401.0156851375295, 5821.893840170354, 6201.131841542278, 6238.656873871981, 6245.156903818108, 6286.371362863677, 6116.480099191618, 6118.326984031664, 6168.938310616836, 6187.535934804998, 6195.783147589813, 6223.097650840512, 6378.968105159444, 6390.188317140443, 6393.680315984089, 6469.644169570719, 4197.790110494402, 4209.179210054132, 4217.493900731809, 4238.57614238586, 4250.107477429774, 6170.907436388368, 6235.189425374672, 6249.593776404519, 6262.279837818527, 6267.905981410191, 5898.321693005188, 5964.761409543569, 5977.282726072899, 5982.371850955587, 6040.0, 5943.881122377442, 5985.371535988833, 6000.609960352563, 6031.185789918305, 6054.75780968774, 5622.425720798019, 5923.815236952713, 5937.554683398849, 5939.584229103922, 5993.730282137227, 6035.547333949883, 6046.7581296749395, 6066.302375226729, 6098.603590766586, 6104.4505994460715, 5950.613210141327, 5983.970080149571, 5994.490468310242, 6005.969970150121, 6017.097435384552], "value": 4462.7307478156035, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [646.3891622416818, 693.3551796828947, 715.5884668666595, 808.5108509351842, 855.8887344645195, 14447.205403702792, 15820.525384238492, 15892.284847181876, 15892.920535397336, 15923.761143582855, 14182.219977901212, 14325.426982920697, 14488.492902748407, 14613.92693036536, 14928.477503287388, 773.3078894389532, 789.159545084486, 791.8812178173263, 792.9484583502054, 793.1275596843484, 770.2528547309101, 785.5561607691665, 801.3589128697048, 802.7070119406404, 804.6097642643314, 828.8010877389413, 832.5213002523543, 832.9333653307721, 833.7332053742805, 833.7498750374893, 824.0070714788666, 824.7938015496126, 825.1500954017341, 827.7682248970298, 827.9337652987747, 598.7994022002634, 599.3048064245454, 601.9337872833985, 602.8251806975971, 604.3925854516227, 15024.699506009927, 15090.924545377313, 15102.0, 15109.320080596399, 15116.0, 13598.864011359958, 14494.565163045125, 14606.780898286534, 14696.338664760111, 14948.47680331194, 11067.667969960914, 11093.1125509959, 11104.55581776728, 11229.157813164045, 11285.830712539318, 3841.1741475582885, 3844.4233364995475, 3952.051507638146, 4022.0950286185666, 4030.5767894371256, 83378.58310708468, 83850.16149838484, 84081.0, 84593.0, 84638.15361846365, 10331.431771252654, 10494.511531277754, 10505.31715438494, 10538.0, 10671.573137074585, 19979.700304495444, 20852.37442876716, 20906.790932090484, 21040.684389734168, 21188.15247390087, 8323.0, 8405.0, 8577.914220857836, 8791.164839340252, 8865.778355541162, 4950.678205916676, 5015.322931404214, 5115.335006449138, 5132.409772876093, 5137.0, 3337.466005439118, 3445.7415693823064, 3452.430348992438, 3469.7918124912585, 3476.443768996999, 610.9450149486568, 611.5871786544064, 611.8409213604494, 616.1681729665006, 616.4328817487922, 693.8716337477583, 706.1279320039747, 715.9355657990702, 728.2135293882594, 730.5981710059446, 10092.0, 10180.6436774714, 10241.129503992095, 10388.636397726043, 10493.632722854663, 650.9381608747161, 666.6933210723025, 710.4955481608116, 714.8963400306926, 735.8785800342883, 4721.268203428474, 4943.332650092191, 4951.08684823969, 4998.525140111684, 5033.723145227048, 115588.0, 117263.0, 117543.0, 117771.0, 120889.39555302344, 99883.50058249662, 101777.49111254397, 102301.0, 103326.48336758268, 104109.47945260225, 87191.0, 90375.0, 90380.54809726041, 91026.0, 91772.54113729388, 9082.318826087938, 9401.576929038072, 9597.985216326368, 9731.133135282336, 9732.331184456913, 53313.73343133259, 53743.0, 54647.0, 54999.17501237565, 55255.17117243164, 67361.66319168372, 74718.6264068698, 75526.62236688781, 76558.61720691361, 78133.21866781487, 11978.76042479163, 11995.460204290654, 12156.878431215575, 12193.573224937085, 12222.694432639255, 13797.724045519235, 13952.0, 13956.581302560939, 14308.427662893368, 15196.0, 12332.445039973401, 12630.0, 12721.55474558423, 12864.871351286742, 13089.738205235652, 12544.310062946626, 12911.870881291066, 12947.935260323638, 12958.611241662387, 13477.056606037484, 12485.687857803627, 12573.622791316275, 12608.180468269533, 12844.935775321064, 13057.542985995444, 10049.949750251202, 10195.643152489924, 10404.895951040393, 10538.525766340379, 10710.250282480463, 10971.780564388828, 11011.657470383681, 11137.721556961142, 11349.0, 11350.716232094264], "value": 7497.767403618317, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 105.0, 111.0, 113.0, 111.0, 112.0, 112.0, 113.0, 112.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 116.0, 140.0, 170.0, 117.0, 147.0, 146.0, 117.0, 185.0, 117.0], "value": 140.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 161.0, 162.0, 163.0, 165.0, 175.0, 169.0, 162.0, 162.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 167.0, 76.0, 75.0, 76.0, 77.0, 163.0, 76.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 154.0, 85.0, 85.0, 85.0, 138.0, 85.0, 85.0, 133.0], "value": 102.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 149.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 97.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 55.0, 55.0, 55.0, 56.0, 55.0, 61.0, 56.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 76.0, 77.0, 75.0, 78.0, 83.0, 80.0, 75.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 120.0, 132.0, 123.0, 133.0, 121.0, 122.0, 199.0, 129.0], "value": 131.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 159.0, 159.0, 157.0, 155.0, 162.0, 156.0, 162.0, 157.0, 155.0], "value": 157.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 62.0, 63.0, 63.0, 64.0, 63.0, 62.0, 64.0], "value": 63.3, "unit": "score"}]}]} 01:47:03 INFO - Return code: 0 01:47:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:47:03 ERROR - # TBPL SUCCESS # 01:47:03 INFO - Running post-action listener: _resource_record_post_action 01:47:03 INFO - ##### 01:47:03 INFO - ##### Finished run-tests step (success) 01:47:03 INFO - ##### 01:47:03 INFO - Running post-run listener: _resource_record_post_run 01:47:03 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 7770112; Write bytes: 495927296; Read time: 1332; Write time: 366560 01:47:03 INFO - TinderboxPrint: CPU usage
13.3% 01:47:03 INFO - TinderboxPrint: I/O read bytes / time
7,770,112 / 1,332 01:47:03 INFO - TinderboxPrint: I/O write bytes / time
495,927,296 / 366,560 01:47:03 INFO - TinderboxPrint: CPU idle
8,235.5 (86.7%) 01:47:03 INFO - TinderboxPrint: CPU user
1,204.7 (12.7%) 01:47:03 INFO - TinderboxPrint: Swap in / out
0 / 0 01:47:03 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 126140416; Read time: 0; Write time: 68832 01:47:03 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 5529600; Write bytes: 339288064; Read time: 1184; Write time: 262304 01:47:03 INFO - Running post-run listener: _upload_blobber_files 01:47:03 INFO - Blob upload gear active. 01:47:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:47:03 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 01:47:03 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'] 01:47:03 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 01:47:04 INFO - (blobuploader) - INFO - Open directory for files ... 01:47:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:47:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:47:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:47:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:47:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:47:04 INFO - (blobuploader) - INFO - Done attempting. 01:47:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:47:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:47:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:47:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:47:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:47:08 INFO - (blobuploader) - INFO - Done attempting. 01:47:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:47:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:47:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:47:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:47:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:47:09 INFO - (blobuploader) - INFO - Done attempting. 01:47:09 INFO - (blobuploader) - INFO - Iteration through files over. 01:47:09 INFO - Return code: 0 01:47:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:47:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:47:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/11d15b10a622829c998344d6da2de1741afba709ab4937eae279f3c72aff8e093dab7285ef888acb51e42f159cc2f4de86d51a88741de28bab13d0bc2cd99c39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4c8be91ffcfcbce159d5f327159c741a184348bd550e512312b04dcba466e37a7601163febf6e206a330afa3e5023a223332d405d0506097e7f24927f3600459", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4b2f3265dbf15e0599905fd012ee8ecfdef00185f484d4acbab1979f5ffde70c5d438cdd80f0b57267ec9309b066a673377026c8c78db491dde4f29572df9a06"} 01:47:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:47:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:47:09 INFO - Contents: 01:47:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/11d15b10a622829c998344d6da2de1741afba709ab4937eae279f3c72aff8e093dab7285ef888acb51e42f159cc2f4de86d51a88741de28bab13d0bc2cd99c39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4c8be91ffcfcbce159d5f327159c741a184348bd550e512312b04dcba466e37a7601163febf6e206a330afa3e5023a223332d405d0506097e7f24927f3600459", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4b2f3265dbf15e0599905fd012ee8ecfdef00185f484d4acbab1979f5ffde70c5d438cdd80f0b57267ec9309b066a673377026c8c78db491dde4f29572df9a06"} 01:47:09 INFO - Running post-run listener: copy_logs_to_upload_dir 01:47:09 INFO - Copying logs to upload dir... 01:47:09 INFO - mkdir: /builds/slave/test/build/upload/logs 01:47:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.049893 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-05 01:47:09.250552) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 01:47:09.253686) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467705108.220271-1322865100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/11d15b10a622829c998344d6da2de1741afba709ab4937eae279f3c72aff8e093dab7285ef888acb51e42f159cc2f4de86d51a88741de28bab13d0bc2cd99c39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4c8be91ffcfcbce159d5f327159c741a184348bd550e512312b04dcba466e37a7601163febf6e206a330afa3e5023a223332d405d0506097e7f24927f3600459", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4b2f3265dbf15e0599905fd012ee8ecfdef00185f484d4acbab1979f5ffde70c5d438cdd80f0b57267ec9309b066a673377026c8c78db491dde4f29572df9a06"} build_url:https://queue.taskcluster.net/v1/task/QZnkR8GLR7me8Tv07f_loQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011224 build_url: 'https://queue.taskcluster.net/v1/task/QZnkR8GLR7me8Tv07f_loQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/11d15b10a622829c998344d6da2de1741afba709ab4937eae279f3c72aff8e093dab7285ef888acb51e42f159cc2f4de86d51a88741de28bab13d0bc2cd99c39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4c8be91ffcfcbce159d5f327159c741a184348bd550e512312b04dcba466e37a7601163febf6e206a330afa3e5023a223332d405d0506097e7f24927f3600459", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4b2f3265dbf15e0599905fd012ee8ecfdef00185f484d4acbab1979f5ffde70c5d438cdd80f0b57267ec9309b066a673377026c8c78db491dde4f29572df9a06"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 01:47:09.279302) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 01:47:09.279635) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467705108.220271-1322865100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 01:47:09.363319) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 01:47:09.363635) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 01:47:09.363920) ========= ========= Total master_lag: 0.17 =========