builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-001 starttime: 1468364898.22 results: success (0) buildid: 20160712145029 builduid: 2a7a1a2877914428a1793bcedbe1bfc1 revision: b4484a7069fbc7b6131fa370d96301b00a57b9e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 16:08:18.224474) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 16:08:18.226157) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 16:08:18.226697) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 16:08:18.280576) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 16:08:18.280948) ========= 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=8887e36bb8e381bfd44124ac000001a8-1468362027.160471-802018795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 16:08: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% 19.7M=0.001s 2016-07-12 16:08:18 (19.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123018 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 16:08:18.423795) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 16:08:18.424125) ========= 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=8887e36bb8e381bfd44124ac000001a8-1468362027.160471-802018795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022346 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 16:08:18.479020) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 16:08:18.479450) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b4484a7069fbc7b6131fa370d96301b00a57b9e8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev b4484a7069fbc7b6131fa370d96301b00a57b9e8 --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=8887e36bb8e381bfd44124ac000001a8-1468362027.160471-802018795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 16:08:18,928 truncating revision to first 12 chars 2016-07-12 16:08:18,928 Setting DEBUG logging. 2016-07-12 16:08:18,928 attempt 1/10 2016-07-12 16:08:18,928 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b4484a7069fb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 16:08:19,235 unpacking tar archive at: mozilla-central-b4484a7069fb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.713697 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 16:08:19.217571) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 16:08:19.217900) ========= script_repo_revision: b4484a7069fbc7b6131fa370d96301b00a57b9e8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 16:08:19.218371) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 16:08:19.218740) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 16:08:19.241143) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-12 16:08:19.241496) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=8887e36bb8e381bfd44124ac000001a8-1468362027.160471-802018795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:08:19 INFO - MultiFileLogger online at 20160712 16:08:19 in /builds/slave/test 16:08:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:08:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:08:19 INFO - {'append_to_log': False, 16:08:19 INFO - 'base_work_dir': '/builds/slave/test', 16:08:19 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:08:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:08:19 INFO - 'branch': 'Firefox-Non-PGO', 16:08:19 INFO - 'buildbot_json_path': 'buildprops.json', 16:08:19 INFO - 'config_files': ('talos/linux_config.py',), 16:08:19 INFO - 'default_actions': ('clobber', 16:08:19 INFO - 'read-buildbot-config', 16:08:19 INFO - 'download-and-extract', 16:08:19 INFO - 'populate-webroot', 16:08:19 INFO - 'create-virtualenv', 16:08:19 INFO - 'install', 16:08:19 INFO - 'run-tests'), 16:08:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:08:19 INFO - 'download_minidump_stackwalk': True, 16:08:19 INFO - 'download_symbols': 'ondemand', 16:08:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:08:19 INFO - 'tooltool.py': '/tools/tooltool.py', 16:08:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:08:19 INFO - '/tools/misc-python/virtualenv.py')}, 16:08:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:08:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:08:19 INFO - 'installer_path': 'installer.exe', 16:08:19 INFO - 'log_level': 'info', 16:08:19 INFO - 'log_name': 'talos', 16:08:19 INFO - 'log_to_console': True, 16:08:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:08:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:08:19 INFO - 'opt_config_files': (), 16:08:19 INFO - 'pip_index': False, 16:08:19 INFO - 'sps_profile': False, 16:08:19 INFO - 'sps_profile_interval': 0, 16:08:19 INFO - 'suite': 'dromaeojs-e10s', 16:08:19 INFO - 'system_bits': '32', 16:08:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:08:19 INFO - 'title': 'talos-linux64-ix-001', 16:08:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:08:19 INFO - 'use_talos_json': True, 16:08:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:08:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:08:19 INFO - 'work_dir': 'build'} 16:08:19 INFO - ##### 16:08:19 INFO - ##### Running clobber step. 16:08:19 INFO - ##### 16:08:19 INFO - Running pre-action listener: _resource_record_pre_action 16:08:19 INFO - Running main action method: clobber 16:08:19 INFO - rmtree: /builds/slave/test/build 16:08:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:08:20 INFO - Running post-action listener: _resource_record_post_action 16:08:20 INFO - ##### 16:08:20 INFO - ##### Finished clobber step (success) 16:08:20 INFO - ##### 16:08:20 INFO - ##### 16:08:20 INFO - ##### Running read-buildbot-config step. 16:08:20 INFO - ##### 16:08:20 INFO - Running pre-action listener: _resource_record_pre_action 16:08:20 INFO - Running main action method: read_buildbot_config 16:08:20 INFO - Using buildbot properties: 16:08:20 INFO - { 16:08:20 INFO - "project": "", 16:08:20 INFO - "product": "firefox", 16:08:20 INFO - "script_repo_revision": "production", 16:08:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:08:20 INFO - "repository": "", 16:08:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 16:08:20 INFO - "buildid": "20160712145029", 16:08:20 INFO - "pgo_build": "False", 16:08:20 INFO - "basedir": "/builds/slave/test", 16:08:20 INFO - "buildnumber": 120, 16:08:20 INFO - "slavename": "talos-linux64-ix-001", 16:08:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:08:20 INFO - "platform": "ubuntu64_hw", 16:08:20 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 16:08:20 INFO - "branch": "mozilla-central", 16:08:20 INFO - "repo_path": "mozilla-central", 16:08:20 INFO - "revision": "b4484a7069fbc7b6131fa370d96301b00a57b9e8", 16:08:20 INFO - "stage_platform": "linux64", 16:08:20 INFO - "builduid": "2a7a1a2877914428a1793bcedbe1bfc1", 16:08:20 INFO - "slavebuilddir": "test" 16:08:20 INFO - } 16:08:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/DvdM9SxWQPWrnxE38w1ljQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:08:20 INFO - Running post-action listener: _resource_record_post_action 16:08:20 INFO - ##### 16:08:20 INFO - ##### Finished read-buildbot-config step (success) 16:08:20 INFO - ##### 16:08:20 INFO - ##### 16:08:20 INFO - ##### Running download-and-extract step. 16:08:20 INFO - ##### 16:08:20 INFO - Running pre-action listener: _resource_record_pre_action 16:08:20 INFO - Running main action method: download_and_extract 16:08:20 INFO - mkdir: /builds/slave/test/build/tests 16:08: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')]} 16:08:20 INFO - https://queue.taskcluster.net/v1/task/DvdM9SxWQPWrnxE38w1ljQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:08:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvdM9SxWQPWrnxE38w1ljQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:08:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvdM9SxWQPWrnxE38w1ljQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:08:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvdM9SxWQPWrnxE38w1ljQ/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 16:08:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvdM9SxWQPWrnxE38w1ljQ/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 16:08:27 INFO - Downloaded 1361 bytes. 16:08:27 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:08:27 INFO - Using the following test package requirements: 16:08:27 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:08:27 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:08:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:08:27 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:08:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:08:27 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:08:27 INFO - u'jsshell-linux-x86_64.zip'], 16:08:27 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:08:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:08:27 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:08:27 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:08:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:08:27 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:08:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:08:27 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:08:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:08:27 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:08:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:08:27 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:08:27 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')]} 16:08:27 INFO - https://queue.taskcluster.net/v1/task/DvdM9SxWQPWrnxE38w1ljQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:08:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvdM9SxWQPWrnxE38w1ljQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:08:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvdM9SxWQPWrnxE38w1ljQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:08:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvdM9SxWQPWrnxE38w1ljQ/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 16:08:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvdM9SxWQPWrnxE38w1ljQ/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 16:08:30 INFO - Downloaded 22700490 bytes. 16:08:30 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'] 16:08:30 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 16:08:31 INFO - Return code: 0 16:08:31 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 16:08:31 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')]} 16:08:31 INFO - https://queue.taskcluster.net/v1/task/DvdM9SxWQPWrnxE38w1ljQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:08:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvdM9SxWQPWrnxE38w1ljQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:08:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvdM9SxWQPWrnxE38w1ljQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:08:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvdM9SxWQPWrnxE38w1ljQ/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 16:08:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvdM9SxWQPWrnxE38w1ljQ/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 16:08:32 INFO - Downloaded 22700490 bytes. 16:08:32 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'] 16:08:32 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 16:08:33 INFO - Return code: 0 16:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:33 INFO - https://queue.taskcluster.net/v1/task/DvdM9SxWQPWrnxE38w1ljQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:08:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvdM9SxWQPWrnxE38w1ljQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:08:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvdM9SxWQPWrnxE38w1ljQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:08:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvdM9SxWQPWrnxE38w1ljQ/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 16:08:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvdM9SxWQPWrnxE38w1ljQ/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 16:08:35 INFO - Downloaded 14403317 bytes. 16:08:35 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'] 16:08:35 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 16:08:35 INFO - Return code: 0 16:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:35 INFO - https://queue.taskcluster.net/v1/task/DvdM9SxWQPWrnxE38w1ljQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:08:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvdM9SxWQPWrnxE38w1ljQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:08:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvdM9SxWQPWrnxE38w1ljQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:08:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvdM9SxWQPWrnxE38w1ljQ/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 16:08:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DvdM9SxWQPWrnxE38w1ljQ/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 16:08:36 INFO - Downloaded 56659183 bytes. 16:08:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DvdM9SxWQPWrnxE38w1ljQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:08:36 INFO - mkdir: /builds/slave/test/properties 16:08:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:08:36 INFO - Writing to file /builds/slave/test/properties/build_url 16:08:36 INFO - Contents: 16:08:36 INFO - build_url:https://queue.taskcluster.net/v1/task/DvdM9SxWQPWrnxE38w1ljQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:08:37 INFO - Running post-action listener: _resource_record_post_action 16:08:37 INFO - Running post-action listener: set_extra_try_arguments 16:08:37 INFO - ##### 16:08:37 INFO - ##### Finished download-and-extract step (success) 16:08:37 INFO - ##### 16:08:37 INFO - ##### 16:08:37 INFO - ##### Running populate-webroot step. 16:08:37 INFO - ##### 16:08:37 INFO - Running pre-action listener: _resource_record_pre_action 16:08:37 INFO - Running main action method: populate_webroot 16:08:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:08:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:08:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:08:37 INFO - '--tppagecycles', 16:08:37 INFO - '7'], 16:08:37 INFO - 'tests': ['tsvgm']}}, 16:08:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:08:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:08:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:08:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:08:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:08:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:08:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:08:37 INFO - 'talos_options': ['--disable-e10s'], 16:08:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:08:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:08:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:08:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:08:37 INFO - 'talos_options': ['--disable-e10s'], 16:08:37 INFO - 'tests': ['damp', 'tps']}, 16:08:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:08:37 INFO - 'tests': ['damp', 'tps']}, 16:08:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:08:37 INFO - 'tests': ['dromaeo_dom']}, 16:08:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:08:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:08:37 INFO - 'tests': ['basic_compositor_video']}, 16:08:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:08:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:08:37 INFO - 'tests': ['a11yr', 16:08:37 INFO - 'ts_paint', 16:08:37 INFO - 'tpaint', 16:08:37 INFO - 'sessionrestore', 16:08:37 INFO - 'sessionrestore_no_auto_restore', 16:08:37 INFO - 'tabpaint']}, 16:08:37 INFO - 'other-e10s': {'tests': ['a11yr', 16:08:37 INFO - 'ts_paint', 16:08:37 INFO - 'tpaint', 16:08:37 INFO - 'sessionrestore', 16:08:37 INFO - 'sessionrestore_no_auto_restore', 16:08:37 INFO - 'tabpaint']}, 16:08:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:08:37 INFO - 'ts_paint', 16:08:37 INFO - 'tpaint', 16:08:37 INFO - 'sessionrestore', 16:08:37 INFO - 'sessionrestore_no_auto_restore', 16:08:37 INFO - 'tabpaint']}, 16:08:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:08:37 INFO - 'ts_paint', 16:08:37 INFO - 'tpaint', 16:08:37 INFO - 'sessionrestore', 16:08:37 INFO - 'sessionrestore_no_auto_restore', 16:08:37 INFO - 'tabpaint']}, 16:08:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:08:37 INFO - 'tests': ['a11yr', 16:08:37 INFO - 'ts_paint', 16:08:37 INFO - 'tpaint', 16:08:37 INFO - 'sessionrestore', 16:08:37 INFO - 'sessionrestore_no_auto_restore', 16:08:37 INFO - 'tabpaint']}, 16:08:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:08:37 INFO - 'tests': ['a11yr', 16:08:37 INFO - 'ts_paint', 16:08:37 INFO - 'tpaint', 16:08:37 INFO - 'sessionrestore', 16:08:37 INFO - 'sessionrestore_no_auto_restore', 16:08:37 INFO - 'tabpaint']}, 16:08:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:08:37 INFO - 'tests': ['tsvgx', 16:08:37 INFO - 'tsvgr_opacity', 16:08:37 INFO - 'tart', 16:08:37 INFO - 'tscrollx', 16:08:37 INFO - 'cart']}, 16:08:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:08:37 INFO - 'tsvgr_opacity', 16:08:37 INFO - 'tart', 16:08:37 INFO - 'tscrollx', 16:08:37 INFO - 'cart']}, 16:08:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:08:37 INFO - 'talos_options': ['--disable-e10s'], 16:08:37 INFO - 'tests': ['tp5o']}, 16:08:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:08:37 INFO - 'tests': ['tp5o']}, 16:08:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:08:37 INFO - 'talos_options': ['--disable-e10s', 16:08:37 INFO - '--xperf_path', 16:08:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:08:37 INFO - 'tests': ['tp5n']}, 16:08:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:08:37 INFO - 'talos_options': ['--xperf_path', 16:08:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:08:37 INFO - 'tests': ['tp5n']}}, 16:08:37 INFO - 'talos.zip': {'path': '', 16:08:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:08:37 INFO - Running post-action listener: _resource_record_post_action 16:08:37 INFO - ##### 16:08:37 INFO - ##### Finished populate-webroot step (success) 16:08:37 INFO - ##### 16:08:37 INFO - ##### 16:08:37 INFO - ##### Running create-virtualenv step. 16:08:37 INFO - ##### 16:08:37 INFO - Running pre-action listener: _resource_record_pre_action 16:08:37 INFO - Running main action method: create_virtualenv 16:08:37 INFO - Creating virtualenv /builds/slave/test/build/venv 16:08:37 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 16:08:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:08:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:08:37 INFO - Using real prefix '/usr' 16:08:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:08:38 INFO - Installing distribute.............................................................................................................................................................................................done. 16:08:40 INFO - Installing pip.................done. 16:08:40 INFO - Return code: 0 16:08:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xba3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe61570>, '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 0xe62470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe62900>, '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': '8887e36bb8e381bfd44124ac000001a8-1468362027.160471-802018795', '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 16:08:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:08:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:08:40 INFO - Using env: {'DISPLAY': ':0', 16:08:40 INFO - 'HOME': '/home/cltbld', 16:08:40 INFO - 'LANG': 'en_US.UTF-8', 16:08:40 INFO - 'LANGUAGE': 'en_US:en', 16:08:40 INFO - 'LOGNAME': 'cltbld', 16:08:40 INFO - 'MAIL': '/var/mail/cltbld', 16:08:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:40 INFO - 'MOZ_NO_REMOTE': '1', 16:08:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:40 INFO - 'NO_EM_RESTART': '1', 16:08:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:40 INFO - 'PWD': '/builds/slave/test', 16:08:40 INFO - 'SHELL': '/bin/bash', 16:08:40 INFO - 'SHLVL': '1', 16:08:40 INFO - 'TERM': 'linux', 16:08:40 INFO - 'TMOUT': '86400', 16:08:40 INFO - 'USER': 'cltbld', 16:08:40 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468362027.160471-802018795', 16:08:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:40 INFO - '_': '/tools/buildbot/bin/python'} 16:08:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:40 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 16:08:40 INFO - Cleaning up... 16:08:40 INFO - Return code: 0 16:08:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xba3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe61570>, '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 0xe62470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe62900>, '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': '8887e36bb8e381bfd44124ac000001a8-1468362027.160471-802018795', '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 16:08:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:08:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:08:40 INFO - Using env: {'DISPLAY': ':0', 16:08:40 INFO - 'HOME': '/home/cltbld', 16:08:40 INFO - 'LANG': 'en_US.UTF-8', 16:08:40 INFO - 'LANGUAGE': 'en_US:en', 16:08:40 INFO - 'LOGNAME': 'cltbld', 16:08:40 INFO - 'MAIL': '/var/mail/cltbld', 16:08:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:40 INFO - 'MOZ_NO_REMOTE': '1', 16:08:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:40 INFO - 'NO_EM_RESTART': '1', 16:08:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:40 INFO - 'PWD': '/builds/slave/test', 16:08:40 INFO - 'SHELL': '/bin/bash', 16:08:40 INFO - 'SHLVL': '1', 16:08:40 INFO - 'TERM': 'linux', 16:08:40 INFO - 'TMOUT': '86400', 16:08:40 INFO - 'USER': 'cltbld', 16:08:40 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468362027.160471-802018795', 16:08:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:40 INFO - '_': '/tools/buildbot/bin/python'} 16:08:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:40 INFO - Downloading/unpacking psutil>=3.1.1 16:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:08:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:08:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:08:42 INFO - Installing collected packages: psutil 16:08:42 INFO - Running setup.py install for psutil 16:08:42 INFO - building 'psutil._psutil_linux' extension 16:08:42 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 16:08:42 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 16:08:42 INFO - building 'psutil._psutil_posix' extension 16:08:42 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 16:08:43 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 16:08:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:08:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:08:43 INFO - Successfully installed psutil 16:08:43 INFO - Cleaning up... 16:08:43 INFO - Return code: 0 16:08:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:08: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')]} 16:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08: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')]} 16:08:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:43 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 0xba3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe61570>, '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 0xe62470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe62900>, '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': '8887e36bb8e381bfd44124ac000001a8-1468362027.160471-802018795', '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 16:08:43 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 16:08:43 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 16:08:43 INFO - Using env: {'DISPLAY': ':0', 16:08:43 INFO - 'HOME': '/home/cltbld', 16:08:43 INFO - 'LANG': 'en_US.UTF-8', 16:08:43 INFO - 'LANGUAGE': 'en_US:en', 16:08:43 INFO - 'LOGNAME': 'cltbld', 16:08:43 INFO - 'MAIL': '/var/mail/cltbld', 16:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:43 INFO - 'MOZ_NO_REMOTE': '1', 16:08:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:43 INFO - 'NO_EM_RESTART': '1', 16:08:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:43 INFO - 'PWD': '/builds/slave/test', 16:08:43 INFO - 'SHELL': '/bin/bash', 16:08:43 INFO - 'SHLVL': '1', 16:08:43 INFO - 'TERM': 'linux', 16:08:43 INFO - 'TMOUT': '86400', 16:08:43 INFO - 'USER': 'cltbld', 16:08:43 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468362027.160471-802018795', 16:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:43 INFO - '_': '/tools/buildbot/bin/python'} 16:08:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:08:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:08:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:08:45 INFO - Installing collected packages: mozsystemmonitor 16:08:45 INFO - Running setup.py install for mozsystemmonitor 16:08:45 INFO - Successfully installed mozsystemmonitor 16:08:45 INFO - Cleaning up... 16:08:45 INFO - Return code: 0 16:08:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:08:45 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')]} 16:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:45 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')]} 16:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:45 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 0xba3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe61570>, '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 0xe62470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe62900>, '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': '8887e36bb8e381bfd44124ac000001a8-1468362027.160471-802018795', '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 16:08:45 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 16:08:45 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 16:08:45 INFO - Using env: {'DISPLAY': ':0', 16:08:45 INFO - 'HOME': '/home/cltbld', 16:08:45 INFO - 'LANG': 'en_US.UTF-8', 16:08:45 INFO - 'LANGUAGE': 'en_US:en', 16:08:45 INFO - 'LOGNAME': 'cltbld', 16:08:45 INFO - 'MAIL': '/var/mail/cltbld', 16:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:45 INFO - 'MOZ_NO_REMOTE': '1', 16:08:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:45 INFO - 'NO_EM_RESTART': '1', 16:08:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:45 INFO - 'PWD': '/builds/slave/test', 16:08:45 INFO - 'SHELL': '/bin/bash', 16:08:45 INFO - 'SHLVL': '1', 16:08:45 INFO - 'TERM': 'linux', 16:08:45 INFO - 'TMOUT': '86400', 16:08:45 INFO - 'USER': 'cltbld', 16:08:45 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468362027.160471-802018795', 16:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:45 INFO - '_': '/tools/buildbot/bin/python'} 16:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:45 INFO - Downloading/unpacking jsonschema==2.5.1 16:08:45 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 16:08:45 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 16:08:45 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 16:08:45 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 16:08:45 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 16:08:45 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 16:08:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:08:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:08:47 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 16:08:47 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 16:08:47 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 16:08:47 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 16:08:47 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 16:08:47 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 16:08:47 INFO - Downloading functools32-3.2.3-2.tar.gz 16:08:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:08:47 INFO - warning: no files found matching '*.txt' 16:08:47 INFO - no previously-included directories found matching 'build' 16:08:47 INFO - no previously-included directories found matching 'dist' 16:08:47 INFO - no previously-included directories found matching '.git*' 16:08:47 INFO - Installing collected packages: jsonschema, functools32 16:08:47 INFO - Running setup.py install for functools32 16:08:47 INFO - warning: no files found matching '*.txt' 16:08:47 INFO - no previously-included directories found matching 'build' 16:08:47 INFO - no previously-included directories found matching 'dist' 16:08:47 INFO - no previously-included directories found matching '.git*' 16:08:47 INFO - Successfully installed jsonschema functools32 16:08:47 INFO - Cleaning up... 16:08:48 INFO - Return code: 0 16:08:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:48 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 0xba3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe61570>, '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 0xe62470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe62900>, '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': '8887e36bb8e381bfd44124ac000001a8-1468362027.160471-802018795', '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 16:08:48 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 16:08:48 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 16:08:48 INFO - Using env: {'DISPLAY': ':0', 16:08:48 INFO - 'HOME': '/home/cltbld', 16:08:48 INFO - 'LANG': 'en_US.UTF-8', 16:08:48 INFO - 'LANGUAGE': 'en_US:en', 16:08:48 INFO - 'LOGNAME': 'cltbld', 16:08:48 INFO - 'MAIL': '/var/mail/cltbld', 16:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:48 INFO - 'MOZ_NO_REMOTE': '1', 16:08:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:48 INFO - 'NO_EM_RESTART': '1', 16:08:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:48 INFO - 'PWD': '/builds/slave/test', 16:08:48 INFO - 'SHELL': '/bin/bash', 16:08:48 INFO - 'SHLVL': '1', 16:08:48 INFO - 'TERM': 'linux', 16:08:48 INFO - 'TMOUT': '86400', 16:08:48 INFO - 'USER': 'cltbld', 16:08:48 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468362027.160471-802018795', 16:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:48 INFO - '_': '/tools/buildbot/bin/python'} 16:08:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:48 INFO - Downloading/unpacking blobuploader==1.2.4 16:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:50 INFO - Downloading blobuploader-1.2.4.tar.gz 16:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:08:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:08:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:50 INFO - Downloading docopt-0.6.1.tar.gz 16:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:08:50 INFO - Installing collected packages: blobuploader, requests, docopt 16:08:50 INFO - Running setup.py install for blobuploader 16:08:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:08:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:08:51 INFO - Running setup.py install for requests 16:08:51 INFO - Running setup.py install for docopt 16:08:51 INFO - Successfully installed blobuploader requests docopt 16:08:51 INFO - Cleaning up... 16:08:51 INFO - Return code: 0 16:08:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:51 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 0xba3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe61570>, '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 0xe62470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe62900>, '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': '8887e36bb8e381bfd44124ac000001a8-1468362027.160471-802018795', '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 16:08:51 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 16:08:51 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 16:08:51 INFO - Using env: {'DISPLAY': ':0', 16:08:51 INFO - 'HOME': '/home/cltbld', 16:08:51 INFO - 'LANG': 'en_US.UTF-8', 16:08:51 INFO - 'LANGUAGE': 'en_US:en', 16:08:51 INFO - 'LOGNAME': 'cltbld', 16:08:51 INFO - 'MAIL': '/var/mail/cltbld', 16:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:51 INFO - 'MOZ_NO_REMOTE': '1', 16:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:51 INFO - 'NO_EM_RESTART': '1', 16:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:51 INFO - 'PWD': '/builds/slave/test', 16:08:51 INFO - 'SHELL': '/bin/bash', 16:08:51 INFO - 'SHLVL': '1', 16:08:51 INFO - 'TERM': 'linux', 16:08:51 INFO - 'TMOUT': '86400', 16:08:51 INFO - 'USER': 'cltbld', 16:08:51 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468362027.160471-802018795', 16:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:51 INFO - '_': '/tools/buildbot/bin/python'} 16:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:08:51 INFO - Running setup.py (path:/tmp/pip-4yzi0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:08:51 INFO - Running setup.py (path:/tmp/pip-XHZIZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:08:51 INFO - Running setup.py (path:/tmp/pip-rIdsms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:08:51 INFO - Running setup.py (path:/tmp/pip-tVH4LO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:08:52 INFO - Running setup.py (path:/tmp/pip-EhnCJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:08:52 INFO - Running setup.py (path:/tmp/pip-RrmOZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:08:52 INFO - Running setup.py (path:/tmp/pip-Tlws_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:08:52 INFO - Running setup.py (path:/tmp/pip-4FrkEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:08:52 INFO - Running setup.py (path:/tmp/pip-__8xUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:08:52 INFO - Running setup.py (path:/tmp/pip-4jNlSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:08:52 INFO - Running setup.py (path:/tmp/pip-VCcSfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:08:52 INFO - Running setup.py (path:/tmp/pip-r_1nug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:08:52 INFO - Running setup.py (path:/tmp/pip-oi4Lsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:08:52 INFO - Running setup.py (path:/tmp/pip-KHMdaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:08:52 INFO - Running setup.py (path:/tmp/pip-GCWKOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:08:52 INFO - Running setup.py (path:/tmp/pip-qnjsFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:08:52 INFO - Running setup.py (path:/tmp/pip-NPTLj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:08:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:08:52 INFO - Running setup.py install for manifestparser 16:08:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:08:53 INFO - Running setup.py install for mozcrash 16:08:53 INFO - Running setup.py install for mozdebug 16:08:53 INFO - Running setup.py install for mozdevice 16:08:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:08:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:08:53 INFO - Running setup.py install for mozfile 16:08:53 INFO - Running setup.py install for mozhttpd 16:08:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:08:53 INFO - Running setup.py install for mozinfo 16:08:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:08:53 INFO - Running setup.py install for mozInstall 16:08:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:08:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:08:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:08:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:08:53 INFO - Running setup.py install for mozleak 16:08:53 INFO - Running setup.py install for mozlog 16:08:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:08:54 INFO - Running setup.py install for moznetwork 16:08:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:08:54 INFO - Running setup.py install for mozprocess 16:08:54 INFO - Running setup.py install for mozprofile 16:08:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:08:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:08:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:08:54 INFO - Running setup.py install for mozrunner 16:08:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:08:54 INFO - Running setup.py install for mozscreenshot 16:08:54 INFO - Running setup.py install for moztest 16:08:54 INFO - Running setup.py install for mozversion 16:08:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:08:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:08:54 INFO - Cleaning up... 16:08:54 INFO - Return code: 0 16:08:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:54 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 0xba3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe61570>, '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 0xe62470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe62900>, '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': '8887e36bb8e381bfd44124ac000001a8-1468362027.160471-802018795', '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 16:08:54 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 16:08:54 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 16:08:54 INFO - Using env: {'DISPLAY': ':0', 16:08:54 INFO - 'HOME': '/home/cltbld', 16:08:54 INFO - 'LANG': 'en_US.UTF-8', 16:08:54 INFO - 'LANGUAGE': 'en_US:en', 16:08:54 INFO - 'LOGNAME': 'cltbld', 16:08:54 INFO - 'MAIL': '/var/mail/cltbld', 16:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:54 INFO - 'MOZ_NO_REMOTE': '1', 16:08:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:54 INFO - 'NO_EM_RESTART': '1', 16:08:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:54 INFO - 'PWD': '/builds/slave/test', 16:08:54 INFO - 'SHELL': '/bin/bash', 16:08:54 INFO - 'SHLVL': '1', 16:08:54 INFO - 'TERM': 'linux', 16:08:54 INFO - 'TMOUT': '86400', 16:08:54 INFO - 'USER': 'cltbld', 16:08:54 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468362027.160471-802018795', 16:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:54 INFO - '_': '/tools/buildbot/bin/python'} 16:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:08:54 INFO - Running setup.py (path:/tmp/pip-k7Turd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:08:55 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)) 16:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:08:55 INFO - Running setup.py (path:/tmp/pip-ZV7SFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:08:55 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)) 16:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:08:55 INFO - Running setup.py (path:/tmp/pip-VOQoIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:08:55 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)) 16:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:08:55 INFO - Running setup.py (path:/tmp/pip-H2tfKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:08:55 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)) 16:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:08:55 INFO - Running setup.py (path:/tmp/pip-o6Ml2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:08:55 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)) 16:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:08:55 INFO - Running setup.py (path:/tmp/pip-1Fr1yV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:08:55 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)) 16:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:08:55 INFO - Running setup.py (path:/tmp/pip-HFK1a0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:08:55 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)) 16:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:08:55 INFO - Running setup.py (path:/tmp/pip-8fFPN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:08:55 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)) 16:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:08:55 INFO - Running setup.py (path:/tmp/pip-6gMg1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:08:55 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)) 16:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:08:55 INFO - Running setup.py (path:/tmp/pip-djKWDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:08:55 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)) 16:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:08:55 INFO - Running setup.py (path:/tmp/pip-RO4omy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:08:55 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)) 16:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:08:55 INFO - Running setup.py (path:/tmp/pip-ncA5rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:08:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:08:55 INFO - Running setup.py (path:/tmp/pip-LHTZ1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:08:55 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)) 16:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:08:55 INFO - Running setup.py (path:/tmp/pip-22lYJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:08:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:08:56 INFO - Running setup.py (path:/tmp/pip-ETFwvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:08:56 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)) 16:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:08:56 INFO - Running setup.py (path:/tmp/pip-6jvOEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:08:56 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)) 16:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:08:56 INFO - Running setup.py (path:/tmp/pip-Ug6C_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:08:56 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)) 16:08:56 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)) 16:08:56 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)) 16:08:56 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)) 16:08:56 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)) 16:08:56 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)) 16:08:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:58 INFO - Downloading blessings-1.6.tar.gz 16:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:08:58 INFO - Installing collected packages: blessings 16:08:58 INFO - Running setup.py install for blessings 16:08:58 INFO - Successfully installed blessings 16:08:58 INFO - Cleaning up... 16:08:58 INFO - Return code: 0 16:08:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:08:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:08:58 INFO - Reading from file tmpfile_stdout 16:08:58 INFO - Current package versions: 16:08:58 INFO - argparse == 1.2.1 16:08:58 INFO - blessings == 1.6 16:08:58 INFO - blobuploader == 1.2.4 16:08:58 INFO - docopt == 0.6.1 16:08:58 INFO - functools32 == 3.2.3-2 16:08:58 INFO - jsonschema == 2.5.1 16:08:58 INFO - manifestparser == 1.1 16:08:58 INFO - mozInstall == 1.12 16:08:58 INFO - mozcrash == 0.17 16:08:58 INFO - mozdebug == 0.1 16:08:58 INFO - mozdevice == 0.48 16:08:58 INFO - mozfile == 1.2 16:08:58 INFO - mozhttpd == 0.7 16:08:58 INFO - mozinfo == 0.9 16:08:58 INFO - mozleak == 0.1 16:08:58 INFO - mozlog == 3.2 16:08:58 INFO - moznetwork == 0.27 16:08:58 INFO - mozprocess == 0.23 16:08:58 INFO - mozprofile == 0.28 16:08:58 INFO - mozrunner == 6.12 16:08:58 INFO - mozscreenshot == 0.1 16:08:58 INFO - mozsystemmonitor == 0.3 16:08:58 INFO - moztest == 0.7 16:08:58 INFO - mozversion == 1.4 16:08:58 INFO - psutil == 3.1.1 16:08:58 INFO - requests == 1.2.3 16:08:58 INFO - wsgiref == 0.1.2 16:08:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:08:58 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')]} 16:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:58 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')]} 16:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:58 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 0xba3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe61570>, '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 0xe62470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe62900>, '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': '8887e36bb8e381bfd44124ac000001a8-1468362027.160471-802018795', '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 16:08:58 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 16:08:58 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 16:08:58 INFO - Using env: {'DISPLAY': ':0', 16:08:58 INFO - 'HOME': '/home/cltbld', 16:08:58 INFO - 'LANG': 'en_US.UTF-8', 16:08:58 INFO - 'LANGUAGE': 'en_US:en', 16:08:58 INFO - 'LOGNAME': 'cltbld', 16:08:58 INFO - 'MAIL': '/var/mail/cltbld', 16:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:58 INFO - 'MOZ_NO_REMOTE': '1', 16:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:58 INFO - 'NO_EM_RESTART': '1', 16:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:58 INFO - 'PWD': '/builds/slave/test', 16:08:58 INFO - 'SHELL': '/bin/bash', 16:08:58 INFO - 'SHLVL': '1', 16:08:58 INFO - 'TERM': 'linux', 16:08:58 INFO - 'TMOUT': '86400', 16:08:58 INFO - 'USER': 'cltbld', 16:08:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468362027.160471-802018795', 16:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:58 INFO - '_': '/tools/buildbot/bin/python'} 16:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:58 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)) 16:08:58 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)) 16:08:58 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)) 16:08:58 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)) 16:08:58 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)) 16:08:58 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)) 16:08:58 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)) 16:08:58 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)) 16:08:58 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)) 16:08:58 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)) 16:08:58 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)) 16:08:58 INFO - Cleaning up... 16:08:58 INFO - Return code: 0 16:08:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:08:58 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')]} 16:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:58 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')]} 16:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:58 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 0xba3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe61570>, '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 0xe62470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe62900>, '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': '8887e36bb8e381bfd44124ac000001a8-1468362027.160471-802018795', '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 16:08:58 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 16:08:58 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 16:08:58 INFO - Using env: {'DISPLAY': ':0', 16:08:58 INFO - 'HOME': '/home/cltbld', 16:08:58 INFO - 'LANG': 'en_US.UTF-8', 16:08:58 INFO - 'LANGUAGE': 'en_US:en', 16:08:58 INFO - 'LOGNAME': 'cltbld', 16:08:58 INFO - 'MAIL': '/var/mail/cltbld', 16:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:58 INFO - 'MOZ_NO_REMOTE': '1', 16:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:58 INFO - 'NO_EM_RESTART': '1', 16:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:58 INFO - 'PWD': '/builds/slave/test', 16:08:58 INFO - 'SHELL': '/bin/bash', 16:08:58 INFO - 'SHLVL': '1', 16:08:58 INFO - 'TERM': 'linux', 16:08:58 INFO - 'TMOUT': '86400', 16:08:58 INFO - 'USER': 'cltbld', 16:08:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468362027.160471-802018795', 16:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:58 INFO - '_': '/tools/buildbot/bin/python'} 16:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:08:59 INFO - Cleaning up... 16:08:59 INFO - Return code: 0 16:08:59 INFO - Running post-action listener: _resource_record_post_action 16:08:59 INFO - Running post-action listener: _start_resource_monitoring 16:08:59 INFO - Starting resource monitoring. 16:08:59 INFO - ##### 16:08:59 INFO - ##### Finished create-virtualenv step (success) 16:08:59 INFO - ##### 16:08:59 INFO - ##### 16:08:59 INFO - ##### Running install step. 16:08:59 INFO - ##### 16:08:59 INFO - Running pre-action listener: _resource_record_pre_action 16:08:59 INFO - Running main action method: install 16:08:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:08:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:08:59 INFO - Reading from file tmpfile_stdout 16:08:59 INFO - Detecting whether we're running mozinstall >=1.0... 16:08:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:08:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:08:59 INFO - Reading from file tmpfile_stdout 16:08:59 INFO - Output received: 16:08:59 INFO - Usage: mozinstall [options] installer 16:08:59 INFO - Options: 16:08:59 INFO - -h, --help show this help message and exit 16:08:59 INFO - -d DEST, --destination=DEST 16:08:59 INFO - Directory to install application into. [default: 16:08:59 INFO - "/builds/slave/test"] 16:08:59 INFO - --app=APP Application being installed. [default: firefox] 16:08:59 INFO - mkdir: /builds/slave/test/build/application 16:08:59 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'] 16:08:59 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 16:09:15 INFO - Reading from file tmpfile_stdout 16:09:15 INFO - Output received: 16:09:15 INFO - /builds/slave/test/build/application/firefox/firefox 16:09:15 INFO - Running post-action listener: _resource_record_post_action 16:09:15 INFO - ##### 16:09:15 INFO - ##### Finished install step (success) 16:09:15 INFO - ##### 16:09:15 INFO - ##### 16:09:15 INFO - ##### Running run-tests step. 16:09:15 INFO - ##### 16:09:15 INFO - Running pre-action listener: _resource_record_pre_action 16:09:15 INFO - Running main action method: run_tests 16:09:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:09:15 INFO - Python 2.7.3 16:09:15 INFO - Return code: 0 16:09:15 INFO - grabbing minidump binary from tooltool 16:09:15 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')]} 16:09:15 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 0xe61570>, '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 0xe62470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe62900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:09:15 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 16:09:15 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 16:09:15 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 16:09:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:09:15 INFO - Return code: 0 16:09:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:09:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:09:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:09:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:09:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:09:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DvdM9SxWQPWrnxE38w1ljQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 16:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DvdM9SxWQPWrnxE38w1ljQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 16:09:15 INFO - Using env: {'DISPLAY': ':0', 16:09:15 INFO - 'HOME': '/home/cltbld', 16:09:15 INFO - 'LANG': 'en_US.UTF-8', 16:09:15 INFO - 'LANGUAGE': 'en_US:en', 16:09:15 INFO - 'LOGNAME': 'cltbld', 16:09:15 INFO - 'MAIL': '/var/mail/cltbld', 16:09:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:09:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:15 INFO - 'MOZ_NO_REMOTE': '1', 16:09:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:09:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:09:15 INFO - 'NO_EM_RESTART': '1', 16:09:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:09:15 INFO - 'PWD': '/builds/slave/test', 16:09:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:09:15 INFO - 'SHELL': '/bin/bash', 16:09:15 INFO - 'SHLVL': '1', 16:09:15 INFO - 'TERM': 'linux', 16:09:15 INFO - 'TMOUT': '86400', 16:09:15 INFO - 'USER': 'cltbld', 16:09:15 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468362027.160471-802018795', 16:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:15 INFO - '_': '/tools/buildbot/bin/python'} 16:09:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DvdM9SxWQPWrnxE38w1ljQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 16:09:16 INFO - mozversion application_buildid: 20160712145029 16:09:16 INFO - mozversion application_changeset: b4484a7069fbc7b6131fa370d96301b00a57b9e8 16:09:16 INFO - mozversion application_display_name: Nightly 16:09:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:09:16 INFO - mozversion application_name: Firefox 16:09:16 INFO - mozversion application_remotingname: firefox 16:09:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:09:16 INFO - mozversion application_vendor: Mozilla 16:09:16 INFO - mozversion application_version: 50.0a1 16:09:16 INFO - mozversion platform_buildid: 20160712145029 16:09:16 INFO - mozversion platform_changeset: b4484a7069fbc7b6131fa370d96301b00a57b9e8 16:09:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:09:16 INFO - mozversion platform_version: 50.0a1 16:09:16 INFO - using testdate: 1468364956 16:09:16 INFO - actual date: 1468364956 16:09:16 INFO - starting webserver on 'localhost:43926' 16:09:16 INFO - SUITE-START | Running 2 tests 16:09:16 INFO - TEST-START | dromaeo_css 16:09:16 INFO - operating with platform_type : linux_ 16:09:16 INFO - Initialising browser for dromaeo_css test... 16:09:16 INFO - TEST-INFO | started process 12210 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmfc48Q/profile http://localhost:43926/getInfo.html) 16:09:21 INFO - PROCESS | 12210 | __metrics Screen width/height:1600/1200 16:09:21 INFO - PROCESS | 12210 | colorDepth:24 16:09:21 INFO - PROCESS | 12210 | Browser inner width/height: 1024/697 16:09:21 INFO - PROCESS | 12210 | __metrics 16:09:21 ERROR - PROCESS | 12210 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 16:09:22 INFO - TEST-INFO | 12210: exit 0 16:09:22 INFO - Browser initialized. 16:09:22 INFO - Running cycle 1/1 for dromaeo_css test... 16:09:22 INFO - TEST-INFO | started process 12332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmfc48Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:09:34 INFO - PROCESS | 12332 | RSS: Main: 168775680 16:09:34 INFO - PROCESS | 12332 | 16:10:24 INFO - PROCESS | 12332 | 1468365024065 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] 16:12:35 INFO - PROCESS | 12332 | Cycle 1(1): loaded http://localhost:43926/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43926/tests/dromaeo/cssquery-ext.html) 16:12:36 INFO - PROCESS | 12332 | RSS: Main: 169193472 16:12:36 INFO - PROCESS | 12332 | 16:15:39 INFO - PROCESS | 12332 | Cycle 1(1): loaded http://localhost:43926/tests/dromaeo/cssquery-ext.html (next: http://localhost:43926/tests/dromaeo/cssquery-jquery.html) 16:15:39 INFO - PROCESS | 12332 | RSS: Main: 168398848 16:15:39 INFO - PROCESS | 12332 | 16:18:41 INFO - PROCESS | 12332 | Cycle 1(1): loaded http://localhost:43926/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43926/tests/dromaeo/cssquery-mootools.html) 16:18:42 INFO - PROCESS | 12332 | RSS: Main: 171352064 16:18:42 INFO - PROCESS | 12332 | 16:21:44 INFO - PROCESS | 12332 | Cycle 1(1): loaded http://localhost:43926/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43926/tests/dromaeo/cssquery-prototype.html) 16:21:44 INFO - PROCESS | 12332 | RSS: Main: 166879232 16:21:44 INFO - PROCESS | 12332 | 16:24:47 INFO - PROCESS | 12332 | Cycle 1(1): loaded http://localhost:43926/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43926/tests/dromaeo/cssquery-yui.html) 16:24:48 INFO - PROCESS | 12332 | RSS: Main: 168493056 16:24:48 INFO - PROCESS | 12332 | 16:27:51 INFO - PROCESS | 12332 | Cycle 1(1): loaded http://localhost:43926/tests/dromaeo/cssquery-yui.html (next: http://localhost:43926/tests/dromaeo/cssquery-dojo.html) 16:27:51 INFO - PROCESS | 12332 | RSS: Main: 170074112 16:27:51 INFO - PROCESS | 12332 | 16:27:51 INFO - PROCESS | 12332 | __start_tp_report 16:27:51 INFO - PROCESS | 12332 | _x_x_mozilla_page_load 16:27:51 INFO - PROCESS | 12332 | _x_x_mozilla_page_load_details 16:27:51 INFO - PROCESS | 12332 | |i|pagename|runs| 16:27:51 INFO - PROCESS | 12332 | |0;dojo.html;2607.608858671199;2627.5927231279156;2635.8286711363753;2654.81416300859;2656.203139058282;4594.425696787902;4597.885052873676;4667.7199368037855;4671.626269898408;4677.766111694419;4626.653001024928;4699.788509517071;4729.31424943383;4735.28970654402;4742.715437073769;4255.659547236221;4311.6335111515555;4364.388985542027;4383.254846676056;4409.88975275619;4389.956100438987;4414.271645178542;4431.556844315559;4437.156940181355;4462.3752674625575;4255.744655320691;4290.377895205178;4306.9447985243505;4332.1335732853395;4349.347597860315;4328.826846926119;4344.131173765228;4344.717593356453;4356.106998065389;4393.07745373472;4330.30715085588;4344.500382456026;4345.326474396474;4365.890852728676;4379.802908869108;4547.226971414867;4647.837325693585;4701.341812146302;4708.458527269339;4716.9056618867435;5038.459810620999;5039.44566097729;5042.193249080166;5061.797528098871;5099.515546023122;4920.114379411704;5073.974630126862;5083.008813281412;5086.338775959139;5147.356580427447;4723.527647235283;4759.333693282909;4767.284907263938;4767.69010014348;4774.904501909942;5185.533302002837;5211.661242019257;5219.321488206509;5242.397124330674;5286.5506431952945;4921.926171107436;4923.409190897044;5007.949920500749;5016.197408414636;5019.322391477177;4858.708477491362;4889.559939605452;5027.321311622957;5036.798528058836;5127.53852153308;4891.902161956741;4909.607231421478;4970.130227210224;4981.227909674007;4982.651214415028;4802.615790736802;4935.037667654845;4936.777844996984;4949.7772600233075;4982.950170498249;4217.030083080847;4233.343831706091;4234.6823988201;4251.893702657459;4284.592963668447;3697.0572504011307;3704.759190652599;3718.925621487555;3721.497597824259;3722.9813850930573;4382.189294980439;4419.138268037702;4428.114377124523;4429.224885645;4458.71018383804;5073.746312684351;5078.111330517145;5079.568236699848;5086.949130508721;5100.668456550312;4359.694821362475;4427.822887084545;4429;4434.935615452268;4474.619657329098;4411.338299255073;4497.617702495325;4523.321501774694;4530.818767249273;4538.9546104539195;4788.11419887322;4797.880052998633;4817.8313759018265;4818.229083346648;4832.226843704991;4934.851954441372;5086.694798312114;5094.770735316845;5095.15929871567;5138.691678499302;4736.668433209642;4766;4792.017636384463;4794.5924596409695;4796.328514008112;4964.975175124101;4985.152524070989;4987.251912213197;5021.623378246573;5041.294218809443;4886.9022619546695;5049.671771334852;5059.645824792229;5074.974625126998;5141.100307446107;4794.640401969936;4815.6147508198555;4926.556609905126;4957.281194226744;5010.624203184849;4810.158222311012;4879;4884.633652476007;4887.34020907173;4918.655694101379;4744.4069491313585;4762.52374762521;4772.093302272557;4804.447488538863;4805.255185446262;4952.2819191217795;4988.700677959334;4993.076280888047;4999.375078115236;5001.399832020181;4833.419989601271;4846.176150054429;4860.052289803454;4877.365942427462;4886.804527818847 16:27:51 INFO - PROCESS | 12332 | |1;ext.html;528.0126164073183;551.8206582860571;553.54885768099;568.7298533196732;568.8890666320069;29373.412531749353;32345.191370215758;39210.80394598027;40619.390709139385;40660.18679626413;41776.79111604438;42159.36760948588;42198.78012198786;42231.57768422315;42248.36627450583;7774.650140743666;7885.211478852127;7930.167332430098;7940.36477081835;7944.08643006053;7885.921140788576;7943.4836735612;7952.642131104114;7953.12515623281;7968.6015699215095;7984.481008734414;7998.080220774598;8029.558374289411;8040.276375126237;8051.677932882707;7914.762557123296;7915.445918785687;7932.365410767125;7942.682292708285;7962.920370796305;7777.688892444296;7782.883256751154;7806.414518911104;7811.453198276123;7845.37237021037;39779.602203977876;40020.59979400227;40060.399094013614;40063.79968100141;40169.79915100406;2908.5346344584764;2989.9551506727416;3064.509678451437;3102.348506813572;3250.9349813003846;29860.253493662833;30219.244518887204;30223.848880755675;30291.242718931982;30905.536416953764;3453.4647129694936;3523.242502861897;3533.134382076382;3596.9100772480897;3600.4959305697225;265375;266399;266822;267486;267976;29908.401831963238;53148.73425632847;53926.73036634792;54018.729906350214;54152.72923635357;31773.841130794197;33065.50401743976;33173.83413082967;33190.834045829615;33222;11299.717507062225;11352.091832653368;11488.253263537843;11492.310461372344;11497.942510287396;10061.79876402468;10095.24285678577;10131.392116473035;10186.134178594753;10251.948740256252;7912.802179945547;7963;7970.7210247642215;8046.718364857202;8067.83864322722;3142.638596561379;3166.5883435153282;3194.08968443997;3197.2965947491516;3204.967950320467;836.1346006882846;933.8459154239611;966.8259713251541;988.7330420786491;1002.2132625888643;28492.572611410844;29028;29170.85414572956;29322.413551728845;29393.412131757246;971.577363846729;973.1290495006929;988.5008070924138;1006.114619135171;1026.43033116621;14559.199244041467;14607.488737894122;14919.477818276308;14969.925150374178;15618;403297;409958;411175;412524;414821;50643.24035139402;51135.488645113815;51273.23090153651;51309.48690513122;51459.74270128625;1151.648747132116;1184.3486082654506;1206.3546002888588;1216.2155409760655;1220.0788404754353;27154.72845271601;28398.290042749097;28654.283642909093;28776.280592985342;29077;44100.55899441093;44778.55221447744;44784.77607611941;44807;44907;355037;356215;356573;357259;357982;25130.24609261725;25350.74649253484;26131.608025880007;26201.868990654926;26561.867190664696;42918.57081429146;43257.3511397323;43761.49908007416;44464.11071778611;44757.77621111873;36775.632243677224;37135.81432092822;37137.442938356486;37464.5648032877;37819.432708508844;36803.631963681095;36928.26143477169;37287.81356093202;37520.437193441576;37627.81186094052;36368.454473183454;36919.630803691616;37366.62633373631;37555.436668449445;40198.79900600478;31434.52848207233;33857.83071084629;34088;34439;34626.65373346234;26007.739922600533;26226.86886565555;26419.60370594481;26502.734972650025;26505.867470662524 16:27:51 INFO - PROCESS | 12332 | |2;jquery.html;360.9819509024549;364.6645086520401;372.6348178784791;384.77298393947564;384.9153186299013;16123.516294511168;17226.741598876026;18115;18120.4563863084;18123.184456699448;15972.361105555792;16193.757093643604;16968.575785605368;17007.914960425212;17919;4678.157931572316;4875.488073752258;4905.9264111038365;4909.803607855682;4912.042151780404;3507.754457187998;4850.44219914709;5355.518003379695;5628.943710562903;5633.7183140843;5596.776128954837;5670.036093864032;5691.260136182311;5705.828825135252;5728.828135155952;5601.383847776741;5638.520725738317;5651.1523271509195;5681.488666020078;5689.687067211302;5282.788688452457;5449.863753406157;5481.739199984026;5493.285872836505;5506.229127922094;13114.86885131146;13706.657333566642;20857.478563035893;21718.13127474899;21761.673574896387;1745.4938067960277;1835.1191428114446;1851.0837135617821;1901.6481950839138;1908.532409559653;9461.952690236574;9655.758606034906;9812.264080193943;12087.637370878887;12406;1743.529247103275;1816.7638207033;1861.4694811978657;1888.8394486468528;1946.7955864634293;68645.3135468649;68947.65526172388;69516.65241673759;73064.26935730627;73951.26048739444;10089.243306751876;10167.7458063549;10332.586696532055;10349.379037257788;10374.740631484274;14013.649658758408;14132.929335353463;14136.293185340692;14262.714745705236;14263.42946282137;6952.826179345557;7032.26161253061;7173.282671732785;7292.307230813064;7300.525465844703;6548.8035358939305;6609.86780264392;6635.9336406636285;6721.798346049626;6820.420264277592;4348.478182618042;4382.737035777864;4450.706477206908;4535.9773201133785;4559.635229181657;1714.2457318779698;1773.361589827661;1832.6792811257976;1872.0826794870416;1882.5011371986434;789.1831953927657;838.3712215838121;838.7730575322529;860.0883063952231;928.3223247029571;17166.485005449857;17195.398161064302;17306.307747689953;17673.911630441766;17806.46580602584;843.5908584336592;845.7547311279783;858.1204265627781;896.0009589307875;913.4382354851718;9540.141387275178;9829.311948163702;9874;9957.153641940371;9958.153556947596;366186.7050635943;368410;372410;380811;382029;77078.2292177071;79110.60444697854;79166;79349.60325198453;80748;884.7937213295669;890.5858775669345;899.2536194958169;899.9010108888148;908.150878928191;15371.461998829987;15472.92263538675;15744.055356678637;15777.921110394374;15979.600509987344;34703.30593388169;35729.28541429209;37116.6288337124;37267.44098838465;38746.6125338743;50248;50750.74624626853;51034.744826277114;52817.47182528125;53069.73465132649;6949.444044476329;7025.156981162293;7078.858422831618;7151.928480715126;7181.748638797617;9742.853857192005;10482.423466709404;10767.300125491818;10849.132069434268;10921.617743379262;9096.772580685536;9402.858957115786;9455.05449455049;9654.75863103428;9771.511424428609;9020.954895225745;9041;9129.087091290818;9179.357444978787;9184.632614695605;9416.576254068721;9652.613895444103;9722.951385243028;9747.512624368896;9869;7201.171865235565;7203.603801790951;7310.597917114397;7326.487145899736;7511.661975211238;9273;9333.626654933727;9556.283278754261;9740.17208537254;9787.951060244653 16:27:51 INFO - PROCESS | 12332 | |3;mootools.html;1353.1204716933994;1377.476558907615;1464.9487267945624;1665.0592415285355;1689.2989409395102;6498;7168.498205125643;7196.71213151474;7672.539647621146;7692.269234422735;7234.638268086588;7451.850962980737;7485.850282994337;7500.849983000337;7515.098188217422;2163.7187165668443;2179.3244094330807;2190.7152070230927;2193.111789725164;2194.7695491973354;2151.408362700254;2160.0387827416807;2195.407240045187;2198.373463562885;2199.1533259694975;2155.084089262057;2166.8374871884594;2173.0438607012866;2174.2172817785586;2213.6236839737285;2091.2471510256373;2092.8325733941324;2110.7150534677776;2116.481462041802;2123.968140477894;2097.6958341040463;2121.660534314518;2126.8723876567456;2137.326742076241;2141.4111119442123;7482.625868706597;7547.16981132075;7614.162442131361;7614.809629759245;7622.390208783284;4230.280852255124;4371.431713877176;4383.802728877208;4387.605115539584;4400.515943246241;2714.4028313770937;2776.2226576558596;2808.49447099522;2809.8033137680372;2899.5795609636693;887.8756974023642;890.2922176869405;907.9455232685993;930.1442672741027;935.4153653966271;10014.499275036293;10044.296899217057;10044.497775111287;10051.69844904654;10078.244131690153;3956.4263181839046;4015.2170326785995;4181.080162364275;4181.937270940938;4189.601987811153;8705.825883482295;8738.737837864746;8745.212930836127;8754.824903501894;8767.25478334336;4511.120331535319;4521.299198624219;4537.319402089713;4539.7049191802425;4541.931871021938;3556.5020897074432;3991.241664083873;4118.217538667704;4119.526254480773;4167.749935003849;3419.452887537982;3447.5345828313357;3505.7020153286744;3515.876944306937;3581.122624956902;1102.6581759654532;1108.905743011853;1115.9609413670482;1121.831725241204;1124.7581769919507;785.1363500149789;807.1081454992267;841.8400503904238;846.95341756204;849.9022612399654;4932;5055.848324550269;5063.417706963673;5065.772040258197;5098.082345177903;402.94157347184495;413.16128259632393;414.933610622299;417.8224254691744;424.74939785526686;3363.545921300642;3549.875754348637;3765.6987441004653;3767.7174211934216;3834.501514803058;9090.90909090914;9230.49232292217;9261.72214833556;9332.58003389849;9348.158665720119;9280.257579393632;9281.443113413217;9289.860652090225;9294.90705092954;9302.581383837743;6972.930270697329;6999.545029573062;7123.89314160288;7150.034745309421;7155.92844071563;5103.387593488656;5250.65870718402;5472.288602481652;5480.780768769205;5527.198556209247;8428.662853485792;8482.533460659723;8571.357148214034;8581.699640512552;8643.481391116553;8362.749117526484;8590.355723320901;8597.355198360023;8780.209781119729;8805.779855503664;5764.308283006066;6131.080337949344;6345.809625711236;6577.868442631025;6686.398224159849;7064.964675176591;7077.186123595647;7079.716811327489;7140.500164988401;7141;6332.620042797447;6414.262359828679;6482.157319548429;6482.870342593216;6590.538662293593;6353.555251132377;6460.25707043696;6527.15147030902;6545;6599.571027883364;5875.676837773793;5895.734691938959;5921.733521991607;5932.584719069624;5948.791792287249;4275.46556680415;4525.63794896414;4533.705309154894;4589.059242855274;4600.516945720651;4338.4360033196745;4355.782210889506;4433.689641725177;4508.436445444319;4511.954880451285 16:27:51 INFO - PROCESS | 12332 | |4;prototype.html;292.1746067359709;298.1086551211877;298.50597261532164;304.4778205377779;305.37703085705164;5071.84784456466;5072.528966599686;5109.948900510994;5113.207452844806;5126.154184559553;4968;4978.278149668296;4993.950060499394;4999.800007999685;5058.620603454738;3747.7563958342757;3778.3199024175638;3910.061585219541;3919.2945269851416;3939.468171796799;3893.1240470893963;3922.8234729437245;3936.7637941723447;3945.5462621798574;3950.2297052074855;3917.2165566886592;3934.173823497069;3940.4483372327895;3942.5268967723914;3955.663768579674;3836.2135762168687;3905.9218815623813;3911.9217615647813;3943.1916457126363;3953.1105501262273;3408.1479630092476;3425.2464457819488;3447.1382154461385;3447.5690538682666;3451.6720911513366;4932.753362331869;4933.136701077297;4935.2843837643695;4941.838667913037;4957.677750946213;4326.805293761757;4480.185524862436;4517.119161763458;4519.367288579601;4525.932111018337;5254.185601231815;5254.7635356409055;5278.736063196825;5286.471352864722;5297.417284098746;3748.5876553579083;3757.924841503182;3772.849086036555;3787.1857550626746;3789.9431508527396;5424.457554244584;5536.204216870495;5572.136318870582;5593.272874526327;5602;3839.6736277416176;3861.4400911867624;3873.573906870242;3878.2243551289853;3879.165979314461;3894.1432884765873;3912.882613521599;3927.4108883667677;3935.3900145477496;3939.2318497893207;4436;4492.326151077299;4497.235469970113;4497.415336006298;4498.3927169832305;5188.818391356284;5223.328534868881;5271.920921186185;5294.279359208195;5323;1299.8050292456207;1312.875276848698;1313.5402609086743;1315.7236980234259;1318.637374721959;844.6536919862826;865.4504389712451;866.1425189062909;884.5179377239419;899.865020246955;4528.547145285445;4681.555252251031;4686.27362758773;4704.435467743892;4709.976450117728;5424.267723857308;5429.619926605179;5472.2338872557875;5473.644213126134;5475.233467314579;4495.527969563214;4686.109639168547;4695.2252878275385;4696.694714843524;4720.91418973638;2870.8851645934346;2891.797574169788;2897.463969165711;2908.8254704717783;2927.9121626351243;5127.3847138343635;5140.640155189176;5158.303629010035;5165.25518998723;5168.61235407346;5394.32570928634;5564.443555644484;5572.331320241597;5576.358718747315;5583.944160558423;5102.158143906288;5116.411612664591;5120.771014956384;5148.2277658350795;5151.793928242978;5436.7281635918835;5443.7822487100075;5467.949518930401;5484.808031718871;5513.421090785409;5110.565601923878;5248.6325957182635;5325.946740532545;5330.200469929541;5334.839954801362;5117.360329958755;5131.743412829418;5136.357955255593;5150.330457040711;5157.974210128926;3841.9807900961437;3876.2053778975805;3886.417037444406;3909.9609003909595;3921.588233235583;5225.16397376418;5492.873960838098;5510.118381059011;5534.446555344433;5565.526930210977;5336.226247194213;5344.076132592341;5376.274202982548;5383.946160538501;5410.83767486976;5207.359681700253;5251.133562962068;5271.706807538733;5292.311999440049;5294.735263236746;5248.527632513092;5254.765130194478;5256.448072952285;5259.60552958522;5263.184206448007;5047.444781074152;5223.138182199895;5362.1420572708175;5382.165764306539;5388.56891448691;5220.7650655721345;5226.189940559219;5246.42289348179;5254.238135470412;5256.816011439581 16:27:51 INFO - PROCESS | 12332 | |5;yui.html;639.6449970266501;725.7459889038834;744.4081954845897;757.4508481351021;768.1435199752276;11799.823002654955;12133;12486.06354523411;12561.811572826415;12625.431855566498;12192.329421881794;12383.56657516987;12420.316882571455;12424.068194885374;12434.191777534454;621.7233331167632;761.0866959648416;774.9263819937125;791.6358475101431;794.2970471133032;796.2475460689651;798.0742338886893;798.8162722573811;799.3085980626745;799.532273619933;833.1335411172373;835.2107258640588;835.4402550291289;836.3100442135262;838.2832678060262;826.4710585225461;827.1645637905729;829.5644786487112;829.9170082991712;831.9792005199857;613.239582917184;613.4846728747873;613.5030625193563;613.929398119213;614.1034090228272;12192.573259935949;12203.694907627292;12223.327716975562;12224.755504889852;12274.570390036395;13635.318234088256;13945.16329020262;14043.71912561743;14063.367148478343;14201.431942722278;10384.117350025257;10456.163506919429;10522.05301522859;10842;10921;4245.12974840157;4320.330348795942;4374.868753937387;4403.889902752425;4458.4426946631675;64534;64600;64981;65138.674306628636;67753;10105.595776168871;10223.335483193569;10399.584016639401;10422.530986105643;10585.364878107339;15550;15597.220138993005;15650.843491564938;15658.843411565966;17186.22661980214;6891.138607674041;7084.964575177194;7090.397316228075;7186.928130718626;7315.963420182865;3750.099976005739;3841.2701586698995;3857.267119247334;3876.592957739453;3877.3990031545154;2745.8627068646488;2843.2749648839413;2865.126136528337;2867.225849020753;2871.655401351851;482.944461386945;499.3209235439799;500.059887411671;509.26157072245394;509.71455984648713;570.2785975740692;629.3203340392365;629.5781826176382;636.853523689554;642.0048924167615;8135.308498777552;8194.467359621605;8359.832803344021;8741.868871966926;8862.689805856764;605.833395816154;611.8042226487481;618.3785295777715;630.1146888621494;634.6160572853449;3981.5421226559315;3983.322835118037;4055.986003499125;4063.5326937401987;4078.7756673382655;92130.53934730284;98816;101038.49480752696;101781.49109254406;101853.49073254735;50002.74998624984;70056.6497167511;82499;83991.16008839956;84190;74442.62778686071;75514;76768.61615691886;76952.61523692346;78429.99999999886;7374.520656157332;7557.35762460175;7637.262490324881;7732.458727888994;7877.448578599443;43587.34618980654;44521.77739111284;45672.31491527696;45804.31293530533;45835;63846.36153638404;65891.34108658852;65966.67016664887;66151;66595;9791.314607977658;10061.69814905554;10095.091441770275;10098.091171794575;10278.743031424274;11253.381064041556;11300.152488563555;11385.601503947322;11551.76896462083;12023.338716370683;10891.292066015683;11248.662540123809;11692.298462092302;11707.356095414494;11974.58088966882;11045.502952367002;11282.492287846902;11325.603603873826;11350.091992640404;11770.058395328182;10232.437215953194;11284.32294062359;11504.137189710638;11515.654530364103;11627.88372116268;9866.605335786488;9908.702738917844;10250.282480226313;10295.485225738534;10687.893121069;8831;8893.28853691716;8911.866322005304;9088.136627020422;9657.9034209657 16:27:51 INFO - PROCESS | 12332 | __end_tp_report 16:27:51 INFO - PROCESS | 12332 | __start_cc_report 16:27:51 INFO - PROCESS | 12332 | _x_x_mozilla_cycle_collect,402 16:27:51 INFO - PROCESS | 12332 | __end_cc_report 16:27:51 INFO - PROCESS | 12332 | __startTimestamp1468366071436__endTimestamp 16:27:51 INFO - PROCESS | 12332 | 16:27:51 INFO - PROCESS | 12332 | ------- Summary: start ------- 16:27:51 INFO - PROCESS | 12332 | Number of tests: 6 16:27:51 INFO - PROCESS | 12332 | 16:27:51 INFO - PROCESS | 12332 | [#0] dojo.html Cycles:165 Average:4662.68 Median:4794.59 stddev:486.37 (10.1%) stddev-sans-first:460.37 16:27:51 INFO - PROCESS | 12332 | Values: 2607.6 2627.6 2635.8 2654.8 2656.2 4594.4 4597.9 4667.7 4671.6 4677.8 4626.7 4699.8 4729.3 4735.3 4742.7 4255.7 4311.6 4364.4 4383.3 4409.9 4390.0 4414.3 4431.6 4437.2 4462.4 4255.7 4290.4 4306.9 4332.1 4349.3 4328.8 4344.1 4344.7 4356.1 4393.1 4330.3 4344.5 4345.3 4365.9 4379.8 4547.2 4647.8 4701.3 4708.5 4716.9 5038.5 5039.4 5042.2 5061.8 5099.5 4920.1 5074.0 5083.0 5086.3 5147.4 4723.5 4759.3 4767.3 4767.7 4774.9 5185.5 5211.7 5219.3 5242.4 5286.6 4921.9 4923.4 5007.9 5016.2 5019.3 4858.7 4889.6 5027.3 5036.8 5127.5 4891.9 4909.6 4970.1 4981.2 4982.7 4802.6 4935.0 4936.8 4949.8 4983.0 4217.0 4233.3 4234.7 4251.9 4284.6 3697.1 3704.8 3718.9 3721.5 3723.0 4382.2 4419.1 4428.1 4429.2 4458.7 5073.7 5078.1 5079.6 5086.9 5100.7 4359.7 4427.8 4429.0 4434.9 4474.6 4411.3 4497.6 4523.3 4530.8 4539.0 4788.1 4797.9 4817.8 4818.2 4832.2 4934.9 5086.7 5094.8 5095.2 5138.7 4736.7 4766.0 4792.0 4794.6 4796.3 4965.0 4985.2 4987.3 5021.6 5041.3 4886.9 5049.7 5059.6 5075.0 5141.1 4794.6 4815.6 4926.6 4957.3 5010.6 4810.2 4879.0 4884.6 4887.3 4918.7 4744.4 4762.5 4772.1 4804.4 4805.3 4952.3 4988.7 4993.1 4999.4 5001.4 4833.4 4846.2 4860.1 4877.4 4886.8 16:27:51 INFO - PROCESS | 12332 | 16:27:51 INFO - PROCESS | 12332 | [#1] ext.html Cycles:180 Average:48816.43 Median:37032.04 stddev:92446.09 (249.6%) stddev-sans-first:92634.33 16:27:51 INFO - PROCESS | 12332 | Values: 528.0 551.8 553.5 568.7 568.9 29373.4 32345.2 39210.8 40619.4 40660.2 41776.8 42159.4 42198.8 42231.6 42248.4 7774.7 7885.2 7930.2 7940.4 7944.1 7885.9 7943.5 7952.6 7953.1 7968.6 7984.5 7998.1 8029.6 8040.3 8051.7 7914.8 7915.4 7932.4 7942.7 7962.9 7777.7 7782.9 7806.4 7811.5 7845.4 39779.6 40020.6 40060.4 40063.8 40169.8 2908.5 2990.0 3064.5 3102.3 3250.9 29860.3 30219.2 30223.8 30291.2 30905.5 3453.5 3523.2 3533.1 3596.9 3600.5 265375.0 266399.0 266822.0 267486.0 267976.0 29908.4 53148.7 53926.7 54018.7 54152.7 31773.8 33065.5 33173.8 33190.8 33222.0 11299.7 11352.1 11488.3 11492.3 11497.9 10061.8 10095.2 10131.4 10186.1 10251.9 7912.8 7963.0 7970.7 8046.7 8067.8 3142.6 3166.6 3194.1 3197.3 3205.0 836.1 933.8 966.8 988.7 1002.2 28492.6 29028.0 29170.9 29322.4 29393.4 971.6 973.1 988.5 1006.1 1026.4 14559.2 14607.5 14919.5 14969.9 15618.0 403297.0 409958.0 411175.0 412524.0 414821.0 50643.2 51135.5 51273.2 51309.5 51459.7 1151.6 1184.3 1206.4 1216.2 1220.1 27154.7 28398.3 28654.3 28776.3 29077.0 44100.6 44778.6 44784.8 44807.0 44907.0 355037.0 356215.0 356573.0 357259.0 357982.0 25130.2 25350.7 26131.6 26201.9 26561.9 42918.6 43257.4 43761.5 44464.1 44757.8 36775.6 37135.8 37137.4 37464.6 37819.4 36803.6 36928.3 37287.8 37520.4 37627.8 36368.5 36919.6 37366.6 37555.4 40198.8 31434.5 33857.8 34088.0 34439.0 34626.7 26007.7 26226.9 26419.6 26502.7 26505.9 16:27:51 INFO - PROCESS | 12332 | 16:27:51 INFO - PROCESS | 12332 | [#2] jquery.html Cycles:180 Average:23860.03 Median:5465.80 stddev:61983.12 (1134.0%) stddev-sans-first:62131.89 16:27:51 INFO - PROCESS | 12332 | Values: 361.0 364.7 372.6 384.8 384.9 16123.5 17226.7 18115.0 18120.5 18123.2 15972.4 16193.8 16968.6 17007.9 17919.0 4678.2 4875.5 4905.9 4909.8 4912.0 3507.8 4850.4 5355.5 5628.9 5633.7 5596.8 5670.0 5691.3 5705.8 5728.8 5601.4 5638.5 5651.2 5681.5 5689.7 5282.8 5449.9 5481.7 5493.3 5506.2 13114.9 13706.7 20857.5 21718.1 21761.7 1745.5 1835.1 1851.1 1901.6 1908.5 9462.0 9655.8 9812.3 12087.6 12406.0 1743.5 1816.8 1861.5 1888.8 1946.8 68645.3 68947.7 69516.7 73064.3 73951.3 10089.2 10167.7 10332.6 10349.4 10374.7 14013.6 14132.9 14136.3 14262.7 14263.4 6952.8 7032.3 7173.3 7292.3 7300.5 6548.8 6609.9 6635.9 6721.8 6820.4 4348.5 4382.7 4450.7 4536.0 4559.6 1714.2 1773.4 1832.7 1872.1 1882.5 789.2 838.4 838.8 860.1 928.3 17166.5 17195.4 17306.3 17673.9 17806.5 843.6 845.8 858.1 896.0 913.4 9540.1 9829.3 9874.0 9957.2 9958.2 366186.7 368410.0 372410.0 380811.0 382029.0 77078.2 79110.6 79166.0 79349.6 80748.0 884.8 890.6 899.3 899.9 908.2 15371.5 15472.9 15744.1 15777.9 15979.6 34703.3 35729.3 37116.6 37267.4 38746.6 50248.0 50750.7 51034.7 52817.5 53069.7 6949.4 7025.2 7078.9 7151.9 7181.7 9742.9 10482.4 10767.3 10849.1 10921.6 9096.8 9402.9 9455.1 9654.8 9771.5 9021.0 9041.0 9129.1 9179.4 9184.6 9416.6 9652.6 9723.0 9747.5 9869.0 7201.2 7203.6 7310.6 7326.5 7511.7 9273.0 9333.6 9556.3 9740.2 9788.0 16:27:51 INFO - PROCESS | 12332 | 16:27:51 INFO - PROCESS | 12332 | [#3] mootools.html Cycles:180 Average:4942.82 Median:4993.92 stddev:2748.08 (55.0%) stddev-sans-first:2742.55 16:27:51 INFO - PROCESS | 12332 | Values: 1353.1 1377.5 1464.9 1665.1 1689.3 6498.0 7168.5 7196.7 7672.5 7692.3 7234.6 7451.9 7485.9 7500.8 7515.1 2163.7 2179.3 2190.7 2193.1 2194.8 2151.4 2160.0 2195.4 2198.4 2199.2 2155.1 2166.8 2173.0 2174.2 2213.6 2091.2 2092.8 2110.7 2116.5 2124.0 2097.7 2121.7 2126.9 2137.3 2141.4 7482.6 7547.2 7614.2 7614.8 7622.4 4230.3 4371.4 4383.8 4387.6 4400.5 2714.4 2776.2 2808.5 2809.8 2899.6 887.9 890.3 907.9 930.1 935.4 10014.5 10044.3 10044.5 10051.7 10078.2 3956.4 4015.2 4181.1 4181.9 4189.6 8705.8 8738.7 8745.2 8754.8 8767.3 4511.1 4521.3 4537.3 4539.7 4541.9 3556.5 3991.2 4118.2 4119.5 4167.7 3419.5 3447.5 3505.7 3515.9 3581.1 1102.7 1108.9 1116.0 1121.8 1124.8 785.1 807.1 841.8 847.0 849.9 4932.0 5055.8 5063.4 5065.8 5098.1 402.9 413.2 414.9 417.8 424.7 3363.5 3549.9 3765.7 3767.7 3834.5 9090.9 9230.5 9261.7 9332.6 9348.2 9280.3 9281.4 9289.9 9294.9 9302.6 6972.9 6999.5 7123.9 7150.0 7155.9 5103.4 5250.7 5472.3 5480.8 5527.2 8428.7 8482.5 8571.4 8581.7 8643.5 8362.7 8590.4 8597.4 8780.2 8805.8 5764.3 6131.1 6345.8 6577.9 6686.4 7065.0 7077.2 7079.7 7140.5 7141.0 6332.6 6414.3 6482.2 6482.9 6590.5 6353.6 6460.3 6527.2 6545.0 6599.6 5875.7 5895.7 5921.7 5932.6 5948.8 4275.5 4525.6 4533.7 4589.1 4600.5 4338.4 4355.8 4433.7 4508.4 4512.0 16:27:51 INFO - PROCESS | 12332 | 16:27:51 INFO - PROCESS | 12332 | [#4] prototype.html Cycles:180 Average:4398.04 Median:5065.23 stddev:1286.95 (25.4%) stddev-sans-first:1253.12 16:27:51 INFO - PROCESS | 12332 | Values: 292.2 298.1 298.5 304.5 305.4 5071.8 5072.5 5109.9 5113.2 5126.2 4968.0 4978.3 4994.0 4999.8 5058.6 3747.8 3778.3 3910.1 3919.3 3939.5 3893.1 3922.8 3936.8 3945.5 3950.2 3917.2 3934.2 3940.4 3942.5 3955.7 3836.2 3905.9 3911.9 3943.2 3953.1 3408.1 3425.2 3447.1 3447.6 3451.7 4932.8 4933.1 4935.3 4941.8 4957.7 4326.8 4480.2 4517.1 4519.4 4525.9 5254.2 5254.8 5278.7 5286.5 5297.4 3748.6 3757.9 3772.8 3787.2 3789.9 5424.5 5536.2 5572.1 5593.3 5602.0 3839.7 3861.4 3873.6 3878.2 3879.2 3894.1 3912.9 3927.4 3935.4 3939.2 4436.0 4492.3 4497.2 4497.4 4498.4 5188.8 5223.3 5271.9 5294.3 5323.0 1299.8 1312.9 1313.5 1315.7 1318.6 844.7 865.5 866.1 884.5 899.9 4528.5 4681.6 4686.3 4704.4 4710.0 5424.3 5429.6 5472.2 5473.6 5475.2 4495.5 4686.1 4695.2 4696.7 4720.9 2870.9 2891.8 2897.5 2908.8 2927.9 5127.4 5140.6 5158.3 5165.3 5168.6 5394.3 5564.4 5572.3 5576.4 5583.9 5102.2 5116.4 5120.8 5148.2 5151.8 5436.7 5443.8 5467.9 5484.8 5513.4 5110.6 5248.6 5325.9 5330.2 5334.8 5117.4 5131.7 5136.4 5150.3 5158.0 3842.0 3876.2 3886.4 3910.0 3921.6 5225.2 5492.9 5510.1 5534.4 5565.5 5336.2 5344.1 5376.3 5383.9 5410.8 5207.4 5251.1 5271.7 5292.3 5294.7 5248.5 5254.8 5256.4 5259.6 5263.2 5047.4 5223.1 5362.1 5382.2 5388.6 5220.8 5226.2 5246.4 5254.2 5256.8 16:27:51 INFO - PROCESS | 12332 | 16:27:51 INFO - PROCESS | 12332 | [#5] yui.html Cycles:180 Average:17588.21 Median:491.13 stddev:25357.59 (5163.1%) stddev-sans-first:25396.79 16:27:51 INFO - PROCESS | 12332 | Values: 639.6 725.7 744.4 757.5 768.1 11799.8 12133.0 12486.1 12561.8 12625.4 12192.3 12383.6 12420.3 12424.1 12434.2 621.7 761.1 774.9 791.6 794.3 796.2 798.1 798.8 799.3 799.5 833.1 835.2 835.4 836.3 838.3 826.5 827.2 829.6 829.9 832.0 613.2 613.5 613.5 613.9 614.1 12192.6 12203.7 12223.3 12224.8 12274.6 13635.3 13945.2 14043.7 14063.4 14201.4 10384.1 10456.2 10522.1 10842.0 10921.0 4245.1 4320.3 4374.9 4403.9 4458.4 64534.0 64600.0 64981.0 65138.7 67753.0 10105.6 10223.3 10399.6 10422.5 10585.4 15550.0 15597.2 15650.8 15658.8 17186.2 6891.1 7085.0 7090.4 7186.9 7316.0 3750.1 3841.3 3857.3 3876.6 3877.4 2745.9 2843.3 2865.1 2867.2 2871.7 482.9 499.3 500.1 509.3 509.7 570.3 629.3 629.6 636.9 642.0 8135.3 8194.5 8359.8 8741.9 8862.7 605.8 611.8 618.4 630.1 634.6 3981.5 3983.3 4056.0 4063.5 4078.8 92130.5 98816.0 101038.5 101781.5 101853.5 50002.7 70056.6 82499.0 83991.2 84190.0 74442.6 75514.0 76768.6 76952.6 78430.0 7374.5 7557.4 7637.3 7732.5 7877.4 43587.3 44521.8 45672.3 45804.3 45835.0 63846.4 65891.3 65966.7 66151.0 66595.0 9791.3 10061.7 10095.1 10098.1 10278.7 11253.4 11300.2 11385.6 11551.8 12023.3 10891.3 11248.7 11692.3 11707.4 11974.6 11045.5 11282.5 11325.6 11350.1 11770.1 10232.4 11284.3 11504.1 11515.7 11627.9 9866.6 9908.7 10250.3 10295.5 10687.9 8831.0 8893.3 8911.9 9088.1 9657.9 16:27:51 INFO - PROCESS | 12332 | -------- Summary: end -------- 16:27:51 INFO - PROCESS | 12332 | 16:27:52 INFO - TEST-INFO | 12332: exit 0 16:27:52 INFO - TEST-OK | dromaeo_css | took 1116226ms 16:27:52 INFO - TEST-START | kraken 16:27:52 INFO - operating with platform_type : linux_ 16:27:52 INFO - Initialising browser for kraken test... 16:27:52 INFO - TEST-INFO | started process 12578 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2hDMvL/profile http://localhost:43926/getInfo.html) 16:27:57 INFO - PROCESS | 12578 | __metrics Screen width/height:1600/1200 16:27:57 INFO - PROCESS | 12578 | colorDepth:24 16:27:57 INFO - PROCESS | 12578 | Browser inner width/height: 1024/697 16:27:57 INFO - PROCESS | 12578 | __metrics 16:27:57 ERROR - PROCESS | 12578 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 16:27:58 INFO - TEST-INFO | 12578: exit 0 16:27:58 INFO - Browser initialized. 16:27:58 INFO - Running cycle 1/1 for kraken test... 16:27:58 INFO - TEST-INFO | started process 12697 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2hDMvL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:28:10 INFO - PROCESS | 12697 | RSS: Main: 168595456 16:28:10 INFO - PROCESS | 12697 | 16:28:13 INFO - PROCESS | 12697 | Cycle 1(1): loaded http://localhost:43926/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43926/tests/kraken/driver.html?testName=audio-beat-detection) 16:28:14 INFO - PROCESS | 12697 | RSS: Main: 173977600 16:28:14 INFO - PROCESS | 12697 | 16:28:17 INFO - PROCESS | 12697 | Cycle 1(1): loaded http://localhost:43926/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43926/tests/kraken/driver.html?testName=audio-dft) 16:28:17 INFO - PROCESS | 12697 | RSS: Main: 173453312 16:28:17 INFO - PROCESS | 12697 | 16:28:20 INFO - PROCESS | 12697 | Cycle 1(1): loaded http://localhost:43926/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43926/tests/kraken/driver.html?testName=audio-fft) 16:28:21 INFO - PROCESS | 12697 | RSS: Main: 168198144 16:28:21 INFO - PROCESS | 12697 | 16:28:23 INFO - PROCESS | 12697 | Cycle 1(1): loaded http://localhost:43926/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43926/tests/kraken/driver.html?testName=audio-oscillator) 16:28:24 INFO - PROCESS | 12697 | RSS: Main: 168890368 16:28:24 INFO - PROCESS | 12697 | 16:28:26 INFO - PROCESS | 12697 | Cycle 1(1): loaded http://localhost:43926/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43926/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:28:27 INFO - PROCESS | 12697 | RSS: Main: 169410560 16:28:27 INFO - PROCESS | 12697 | 16:28:30 INFO - PROCESS | 12697 | Cycle 1(1): loaded http://localhost:43926/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43926/tests/kraken/driver.html?testName=imaging-darkroom) 16:28:30 INFO - PROCESS | 12697 | RSS: Main: 169627648 16:28:30 INFO - PROCESS | 12697 | 16:28:34 INFO - PROCESS | 12697 | Cycle 1(1): loaded http://localhost:43926/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43926/tests/kraken/driver.html?testName=imaging-desaturate) 16:28:35 INFO - PROCESS | 12697 | RSS: Main: 166666240 16:28:35 INFO - PROCESS | 12697 | 16:28:38 INFO - PROCESS | 12697 | Cycle 1(1): loaded http://localhost:43926/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43926/tests/kraken/driver.html?testName=json-parse-financial) 16:28:38 INFO - PROCESS | 12697 | RSS: Main: 168042496 16:28:38 INFO - PROCESS | 12697 | 16:28:40 INFO - PROCESS | 12697 | Cycle 1(1): loaded http://localhost:43926/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43926/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:28:41 INFO - PROCESS | 12697 | RSS: Main: 168792064 16:28:41 INFO - PROCESS | 12697 | 16:28:43 INFO - PROCESS | 12697 | Cycle 1(1): loaded http://localhost:43926/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43926/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:28:43 INFO - PROCESS | 12697 | RSS: Main: 169103360 16:28:43 INFO - PROCESS | 12697 | 16:28:45 INFO - PROCESS | 12697 | Cycle 1(1): loaded http://localhost:43926/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43926/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:28:46 INFO - PROCESS | 12697 | RSS: Main: 169189376 16:28:46 INFO - PROCESS | 12697 | 16:28:49 INFO - PROCESS | 12697 | Cycle 1(1): loaded http://localhost:43926/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43926/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:28:50 INFO - PROCESS | 12697 | RSS: Main: 169222144 16:28:50 INFO - PROCESS | 12697 | 16:28:52 INFO - PROCESS | 12697 | Cycle 1(1): loaded http://localhost:43926/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43926/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:28:53 INFO - PROCESS | 12697 | RSS: Main: 168783872 16:28:53 INFO - PROCESS | 12697 | 16:28:55 INFO - PROCESS | 12697 | Cycle 1(1): loaded http://localhost:43926/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43926/tests/kraken/driver.html?testName=ai-astar) 16:28:55 INFO - PROCESS | 12697 | RSS: Main: 169877504 16:28:55 INFO - PROCESS | 12697 | 16:28:55 INFO - PROCESS | 12697 | __start_tp_report 16:28:55 INFO - PROCESS | 12697 | _x_x_mozilla_page_load 16:28:55 INFO - PROCESS | 12697 | _x_x_mozilla_page_load_details 16:28:55 INFO - PROCESS | 12697 | |i|pagename|runs| 16:28:55 INFO - PROCESS | 12697 | |0;ai-astar;106;118;108;115;116;116;117;114;116;116 16:28:55 INFO - PROCESS | 12697 | |1;audio-beat-detection;157;124;153;190;128;148;159;126;181;129 16:28:55 INFO - PROCESS | 12697 | |2;audio-dft;163;162;164;178;163;164;163;164;162;164 16:28:55 INFO - PROCESS | 12697 | |3;audio-fft;76;78;76;161;76;75;77;75;170;85 16:28:55 INFO - PROCESS | 12697 | |4;audio-oscillator;86;86;131;85;86;86;132;87;86;144 16:28:55 INFO - PROCESS | 12697 | |5;imaging-gaussian-blur;118;117;117;118;117;118;118;117;118;117 16:28:55 INFO - PROCESS | 12697 | |6;imaging-darkroom;148;149;149;147;148;149;149;147;148;148 16:28:55 INFO - PROCESS | 12697 | |7;imaging-desaturate;95;96;96;95;96;97;96;96;96;95 16:28:55 INFO - PROCESS | 12697 | |8;json-parse-financial;65;65;68;66;65;65;64;65;64;66 16:28:55 INFO - PROCESS | 12697 | |9;json-stringify-tinderbox;66;65;65;66;66;65;65;66;65;66 16:28:55 INFO - PROCESS | 12697 | |10;stanford-crypto-aes;82;80;81;80;80;79;79;80;80;80 16:28:55 INFO - PROCESS | 12697 | |11;stanford-crypto-ccm;132;131;130;132;137;156;138;147;175;142 16:28:55 INFO - PROCESS | 12697 | |12;stanford-crypto-pbkdf2;169;175;176;173;176;177;170;170;169;167 16:28:55 INFO - PROCESS | 12697 | |13;stanford-crypto-sha256-iterative;68;69;70;70;68;69;69;69;68;70 16:28:55 INFO - PROCESS | 12697 | __end_tp_report 16:28:55 INFO - PROCESS | 12697 | __start_cc_report 16:28:55 INFO - PROCESS | 12697 | _x_x_mozilla_cycle_collect,1046 16:28:55 INFO - PROCESS | 12697 | __end_cc_report 16:28:55 INFO - PROCESS | 12697 | __startTimestamp1468366135582__endTimestamp 16:28:55 INFO - PROCESS | 12697 | 16:28:55 INFO - PROCESS | 12697 | ------- Summary: start ------- 16:28:55 INFO - PROCESS | 12697 | Number of tests: 14 16:28:55 INFO - PROCESS | 12697 | 16:28:55 INFO - PROCESS | 12697 | [#0] ai-astar Cycles:10 Average:114.20 Median:116.00 stddev:3.97 (3.4%) stddev-sans-first:2.89 16:28:55 INFO - PROCESS | 12697 | Values: 106.0 118.0 108.0 115.0 116.0 116.0 117.0 114.0 116.0 116.0 16:28:55 INFO - PROCESS | 12697 | 16:28:55 INFO - PROCESS | 12697 | [#1] audio-beat-detection Cycles:10 Average:149.50 Median:155.00 stddev:23.28 (15.0%) stddev-sans-first:24.54 16:28:55 INFO - PROCESS | 12697 | Values: 157.0 124.0 153.0 190.0 128.0 148.0 159.0 126.0 181.0 129.0 16:28:55 INFO - PROCESS | 12697 | 16:28:55 INFO - PROCESS | 12697 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.00 stddev:4.74 (2.9%) stddev-sans-first:4.99 16:28:55 INFO - PROCESS | 12697 | Values: 163.0 162.0 164.0 178.0 163.0 164.0 163.0 164.0 162.0 164.0 16:28:55 INFO - PROCESS | 12697 | 16:28:55 INFO - PROCESS | 12697 | [#3] audio-fft Cycles:10 Average:94.90 Median:76.00 stddev:37.38 (49.2%) stddev-sans-first:39.02 16:28:55 INFO - PROCESS | 12697 | Values: 76.0 78.0 76.0 161.0 76.0 75.0 77.0 75.0 170.0 85.0 16:28:55 INFO - PROCESS | 12697 | 16:28:55 INFO - PROCESS | 12697 | [#4] audio-oscillator Cycles:10 Average:100.90 Median:86.00 stddev:24.24 (28.2%) stddev-sans-first:25.10 16:28:55 INFO - PROCESS | 12697 | Values: 86.0 86.0 131.0 85.0 86.0 86.0 132.0 87.0 86.0 144.0 16:28:55 INFO - PROCESS | 12697 | 16:28:55 INFO - PROCESS | 12697 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 16:28:55 INFO - PROCESS | 12697 | Values: 118.0 117.0 117.0 118.0 117.0 118.0 118.0 117.0 118.0 117.0 16:28:55 INFO - PROCESS | 12697 | 16:28:55 INFO - PROCESS | 12697 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 16:28:55 INFO - PROCESS | 12697 | Values: 148.0 149.0 149.0 147.0 148.0 149.0 149.0 147.0 148.0 148.0 16:28:55 INFO - PROCESS | 12697 | 16:28:55 INFO - PROCESS | 12697 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 16:28:55 INFO - PROCESS | 12697 | Values: 95.0 96.0 96.0 95.0 96.0 97.0 96.0 96.0 96.0 95.0 16:28:55 INFO - PROCESS | 12697 | 16:28:55 INFO - PROCESS | 12697 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.00 stddev:1.16 (1.8%) stddev-sans-first:1.22 16:28:55 INFO - PROCESS | 12697 | Values: 65.0 65.0 68.0 66.0 65.0 65.0 64.0 65.0 64.0 66.0 16:28:55 INFO - PROCESS | 12697 | 16:28:55 INFO - PROCESS | 12697 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 16:28:55 INFO - PROCESS | 12697 | Values: 66.0 65.0 65.0 66.0 66.0 65.0 65.0 66.0 65.0 66.0 16:28:55 INFO - PROCESS | 12697 | 16:28:55 INFO - PROCESS | 12697 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:80.00 stddev:0.88 (1.1%) stddev-sans-first:0.60 16:28:55 INFO - PROCESS | 12697 | Values: 82.0 80.0 81.0 80.0 80.0 79.0 79.0 80.0 80.0 80.0 16:28:55 INFO - PROCESS | 12697 | 16:28:55 INFO - PROCESS | 12697 | [#11] stanford-crypto-ccm Cycles:10 Average:142.00 Median:140.00 stddev:14.20 (10.1%) stddev-sans-first:14.60 16:28:55 INFO - PROCESS | 12697 | Values: 132.0 131.0 130.0 132.0 137.0 156.0 138.0 147.0 175.0 142.0 16:28:55 INFO - PROCESS | 12697 | 16:28:55 INFO - PROCESS | 12697 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:174.00 stddev:3.61 (2.1%) stddev-sans-first:3.64 16:28:55 INFO - PROCESS | 12697 | Values: 169.0 175.0 176.0 173.0 176.0 177.0 170.0 170.0 169.0 167.0 16:28:55 INFO - PROCESS | 12697 | 16:28:55 INFO - PROCESS | 12697 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 16:28:55 INFO - PROCESS | 12697 | Values: 68.0 69.0 70.0 70.0 68.0 69.0 69.0 69.0 68.0 70.0 16:28:55 INFO - PROCESS | 12697 | -------- Summary: end -------- 16:28:55 INFO - PROCESS | 12697 | 16:28:56 INFO - TEST-INFO | 12697: exit 0 16:28:56 INFO - TEST-OK | kraken | took 64414ms 16:28:56 INFO - SUITE-END | took 1180s 16:28:56 INFO - Completed test suite (00:19:40) 16:28:56 INFO - javascript benchmark 16:28:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6334.331373934169, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2607.608858671199, 2627.5927231279156, 2635.8286711363753, 2654.81416300859, 2656.203139058282, 4594.425696787902, 4597.885052873676, 4667.7199368037855, 4671.626269898408, 4677.766111694419, 4626.653001024928, 4699.788509517071, 4729.31424943383, 4735.28970654402, 4742.715437073769, 4255.659547236221, 4311.6335111515555, 4364.388985542027, 4383.254846676056, 4409.88975275619, 4389.956100438987, 4414.271645178542, 4431.556844315559, 4437.156940181355, 4462.3752674625575, 4255.744655320691, 4290.377895205178, 4306.9447985243505, 4332.1335732853395, 4349.347597860315, 4328.826846926119, 4344.131173765228, 4344.717593356453, 4356.106998065389, 4393.07745373472, 4330.30715085588, 4344.500382456026, 4345.326474396474, 4365.890852728676, 4379.802908869108, 4547.226971414867, 4647.837325693585, 4701.341812146302, 4708.458527269339, 4716.9056618867435, 5038.459810620999, 5039.44566097729, 5042.193249080166, 5061.797528098871, 5099.515546023122, 4920.114379411704, 5073.974630126862, 5083.008813281412, 5086.338775959139, 5147.356580427447, 4723.527647235283, 4759.333693282909, 4767.284907263938, 4767.69010014348, 4774.904501909942, 5185.533302002837, 5211.661242019257, 5219.321488206509, 5242.397124330674, 5286.5506431952945, 4921.926171107436, 4923.409190897044, 5007.949920500749, 5016.197408414636, 5019.322391477177, 4858.708477491362, 4889.559939605452, 5027.321311622957, 5036.798528058836, 5127.53852153308, 4891.902161956741, 4909.607231421478, 4970.130227210224, 4981.227909674007, 4982.651214415028, 4802.615790736802, 4935.037667654845, 4936.777844996984, 4949.7772600233075, 4982.950170498249, 4217.030083080847, 4233.343831706091, 4234.6823988201, 4251.893702657459, 4284.592963668447, 3697.0572504011307, 3704.759190652599, 3718.925621487555, 3721.497597824259, 3722.9813850930573, 4382.189294980439, 4419.138268037702, 4428.114377124523, 4429.224885645, 4458.71018383804, 5073.746312684351, 5078.111330517145, 5079.568236699848, 5086.949130508721, 5100.668456550312, 4359.694821362475, 4427.822887084545, 4429.0, 4434.935615452268, 4474.619657329098, 4411.338299255073, 4497.617702495325, 4523.321501774694, 4530.818767249273, 4538.9546104539195, 4788.11419887322, 4797.880052998633, 4817.8313759018265, 4818.229083346648, 4832.226843704991, 4934.851954441372, 5086.694798312114, 5094.770735316845, 5095.15929871567, 5138.691678499302, 4736.668433209642, 4766.0, 4792.017636384463, 4794.5924596409695, 4796.328514008112, 4964.975175124101, 4985.152524070989, 4987.251912213197, 5021.623378246573, 5041.294218809443, 4886.9022619546695, 5049.671771334852, 5059.645824792229, 5074.974625126998, 5141.100307446107, 4794.640401969936, 4815.6147508198555, 4926.556609905126, 4957.281194226744, 5010.624203184849, 4810.158222311012, 4879.0, 4884.633652476007, 4887.34020907173, 4918.655694101379, 4744.4069491313585, 4762.52374762521, 4772.093302272557, 4804.447488538863, 4805.255185446262, 4952.2819191217795, 4988.700677959334, 4993.076280888047, 4999.375078115236, 5001.399832020181, 4833.419989601271, 4846.176150054429, 4860.052289803454, 4877.365942427462, 4886.804527818847], "value": 4631.692888253706, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [528.0126164073183, 551.8206582860571, 553.54885768099, 568.7298533196732, 568.8890666320069, 29373.412531749353, 32345.191370215758, 39210.80394598027, 40619.390709139385, 40660.18679626413, 41776.79111604438, 42159.36760948588, 42198.78012198786, 42231.57768422315, 42248.36627450583, 7774.650140743666, 7885.211478852127, 7930.167332430098, 7940.36477081835, 7944.08643006053, 7885.921140788576, 7943.4836735612, 7952.642131104114, 7953.12515623281, 7968.6015699215095, 7984.481008734414, 7998.080220774598, 8029.558374289411, 8040.276375126237, 8051.677932882707, 7914.762557123296, 7915.445918785687, 7932.365410767125, 7942.682292708285, 7962.920370796305, 7777.688892444296, 7782.883256751154, 7806.414518911104, 7811.453198276123, 7845.37237021037, 39779.602203977876, 40020.59979400227, 40060.399094013614, 40063.79968100141, 40169.79915100406, 2908.5346344584764, 2989.9551506727416, 3064.509678451437, 3102.348506813572, 3250.9349813003846, 29860.253493662833, 30219.244518887204, 30223.848880755675, 30291.242718931982, 30905.536416953764, 3453.4647129694936, 3523.242502861897, 3533.134382076382, 3596.9100772480897, 3600.4959305697225, 265375.0, 266399.0, 266822.0, 267486.0, 267976.0, 29908.401831963238, 53148.73425632847, 53926.73036634792, 54018.729906350214, 54152.72923635357, 31773.841130794197, 33065.50401743976, 33173.83413082967, 33190.834045829615, 33222.0, 11299.717507062225, 11352.091832653368, 11488.253263537843, 11492.310461372344, 11497.942510287396, 10061.79876402468, 10095.24285678577, 10131.392116473035, 10186.134178594753, 10251.948740256252, 7912.802179945547, 7963.0, 7970.7210247642215, 8046.718364857202, 8067.83864322722, 3142.638596561379, 3166.5883435153282, 3194.08968443997, 3197.2965947491516, 3204.967950320467, 836.1346006882846, 933.8459154239611, 966.8259713251541, 988.7330420786491, 1002.2132625888643, 28492.572611410844, 29028.0, 29170.85414572956, 29322.413551728845, 29393.412131757246, 971.577363846729, 973.1290495006929, 988.5008070924138, 1006.114619135171, 1026.43033116621, 14559.199244041467, 14607.488737894122, 14919.477818276308, 14969.925150374178, 15618.0, 403297.0, 409958.0, 411175.0, 412524.0, 414821.0, 50643.24035139402, 51135.488645113815, 51273.23090153651, 51309.48690513122, 51459.74270128625, 1151.648747132116, 1184.3486082654506, 1206.3546002888588, 1216.2155409760655, 1220.0788404754353, 27154.72845271601, 28398.290042749097, 28654.283642909093, 28776.280592985342, 29077.0, 44100.55899441093, 44778.55221447744, 44784.77607611941, 44807.0, 44907.0, 355037.0, 356215.0, 356573.0, 357259.0, 357982.0, 25130.24609261725, 25350.74649253484, 26131.608025880007, 26201.868990654926, 26561.867190664696, 42918.57081429146, 43257.3511397323, 43761.49908007416, 44464.11071778611, 44757.77621111873, 36775.632243677224, 37135.81432092822, 37137.442938356486, 37464.5648032877, 37819.432708508844, 36803.631963681095, 36928.26143477169, 37287.81356093202, 37520.437193441576, 37627.81186094052, 36368.454473183454, 36919.630803691616, 37366.62633373631, 37555.436668449445, 40198.79900600478, 31434.52848207233, 33857.83071084629, 34088.0, 34439.0, 34626.65373346234, 26007.739922600533, 26226.86886565555, 26419.60370594481, 26502.734972650025, 26505.867470662524], "value": 16717.80227736986, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.9819509024549, 364.6645086520401, 372.6348178784791, 384.77298393947564, 384.9153186299013, 16123.516294511168, 17226.741598876026, 18115.0, 18120.4563863084, 18123.184456699448, 15972.361105555792, 16193.757093643604, 16968.575785605368, 17007.914960425212, 17919.0, 4678.157931572316, 4875.488073752258, 4905.9264111038365, 4909.803607855682, 4912.042151780404, 3507.754457187998, 4850.44219914709, 5355.518003379695, 5628.943710562903, 5633.7183140843, 5596.776128954837, 5670.036093864032, 5691.260136182311, 5705.828825135252, 5728.828135155952, 5601.383847776741, 5638.520725738317, 5651.1523271509195, 5681.488666020078, 5689.687067211302, 5282.788688452457, 5449.863753406157, 5481.739199984026, 5493.285872836505, 5506.229127922094, 13114.86885131146, 13706.657333566642, 20857.478563035893, 21718.13127474899, 21761.673574896387, 1745.4938067960277, 1835.1191428114446, 1851.0837135617821, 1901.6481950839138, 1908.532409559653, 9461.952690236574, 9655.758606034906, 9812.264080193943, 12087.637370878887, 12406.0, 1743.529247103275, 1816.7638207033, 1861.4694811978657, 1888.8394486468528, 1946.7955864634293, 68645.3135468649, 68947.65526172388, 69516.65241673759, 73064.26935730627, 73951.26048739444, 10089.243306751876, 10167.7458063549, 10332.586696532055, 10349.379037257788, 10374.740631484274, 14013.649658758408, 14132.929335353463, 14136.293185340692, 14262.714745705236, 14263.42946282137, 6952.826179345557, 7032.26161253061, 7173.282671732785, 7292.307230813064, 7300.525465844703, 6548.8035358939305, 6609.86780264392, 6635.9336406636285, 6721.798346049626, 6820.420264277592, 4348.478182618042, 4382.737035777864, 4450.706477206908, 4535.9773201133785, 4559.635229181657, 1714.2457318779698, 1773.361589827661, 1832.6792811257976, 1872.0826794870416, 1882.5011371986434, 789.1831953927657, 838.3712215838121, 838.7730575322529, 860.0883063952231, 928.3223247029571, 17166.485005449857, 17195.398161064302, 17306.307747689953, 17673.911630441766, 17806.46580602584, 843.5908584336592, 845.7547311279783, 858.1204265627781, 896.0009589307875, 913.4382354851718, 9540.141387275178, 9829.311948163702, 9874.0, 9957.153641940371, 9958.153556947596, 366186.7050635943, 368410.0, 372410.0, 380811.0, 382029.0, 77078.2292177071, 79110.60444697854, 79166.0, 79349.60325198453, 80748.0, 884.7937213295669, 890.5858775669345, 899.2536194958169, 899.9010108888148, 908.150878928191, 15371.461998829987, 15472.92263538675, 15744.055356678637, 15777.921110394374, 15979.600509987344, 34703.30593388169, 35729.28541429209, 37116.6288337124, 37267.44098838465, 38746.6125338743, 50248.0, 50750.74624626853, 51034.744826277114, 52817.47182528125, 53069.73465132649, 6949.444044476329, 7025.156981162293, 7078.858422831618, 7151.928480715126, 7181.748638797617, 9742.853857192005, 10482.423466709404, 10767.300125491818, 10849.132069434268, 10921.617743379262, 9096.772580685536, 9402.858957115786, 9455.05449455049, 9654.75863103428, 9771.511424428609, 9020.954895225745, 9041.0, 9129.087091290818, 9179.357444978787, 9184.632614695605, 9416.576254068721, 9652.613895444103, 9722.951385243028, 9747.512624368896, 9869.0, 7201.171865235565, 7203.603801790951, 7310.597917114397, 7326.487145899736, 7511.661975211238, 9273.0, 9333.626654933727, 9556.283278754261, 9740.17208537254, 9787.951060244653], "value": 8114.414435198957, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.1204716933994, 1377.476558907615, 1464.9487267945624, 1665.0592415285355, 1689.2989409395102, 6498.0, 7168.498205125643, 7196.71213151474, 7672.539647621146, 7692.269234422735, 7234.638268086588, 7451.850962980737, 7485.850282994337, 7500.849983000337, 7515.098188217422, 2163.7187165668443, 2179.3244094330807, 2190.7152070230927, 2193.111789725164, 2194.7695491973354, 2151.408362700254, 2160.0387827416807, 2195.407240045187, 2198.373463562885, 2199.1533259694975, 2155.084089262057, 2166.8374871884594, 2173.0438607012866, 2174.2172817785586, 2213.6236839737285, 2091.2471510256373, 2092.8325733941324, 2110.7150534677776, 2116.481462041802, 2123.968140477894, 2097.6958341040463, 2121.660534314518, 2126.8723876567456, 2137.326742076241, 2141.4111119442123, 7482.625868706597, 7547.16981132075, 7614.162442131361, 7614.809629759245, 7622.390208783284, 4230.280852255124, 4371.431713877176, 4383.802728877208, 4387.605115539584, 4400.515943246241, 2714.4028313770937, 2776.2226576558596, 2808.49447099522, 2809.8033137680372, 2899.5795609636693, 887.8756974023642, 890.2922176869405, 907.9455232685993, 930.1442672741027, 935.4153653966271, 10014.499275036293, 10044.296899217057, 10044.497775111287, 10051.69844904654, 10078.244131690153, 3956.4263181839046, 4015.2170326785995, 4181.080162364275, 4181.937270940938, 4189.601987811153, 8705.825883482295, 8738.737837864746, 8745.212930836127, 8754.824903501894, 8767.25478334336, 4511.120331535319, 4521.299198624219, 4537.319402089713, 4539.7049191802425, 4541.931871021938, 3556.5020897074432, 3991.241664083873, 4118.217538667704, 4119.526254480773, 4167.749935003849, 3419.452887537982, 3447.5345828313357, 3505.7020153286744, 3515.876944306937, 3581.122624956902, 1102.6581759654532, 1108.905743011853, 1115.9609413670482, 1121.831725241204, 1124.7581769919507, 785.1363500149789, 807.1081454992267, 841.8400503904238, 846.95341756204, 849.9022612399654, 4932.0, 5055.848324550269, 5063.417706963673, 5065.772040258197, 5098.082345177903, 402.94157347184495, 413.16128259632393, 414.933610622299, 417.8224254691744, 424.74939785526686, 3363.545921300642, 3549.875754348637, 3765.6987441004653, 3767.7174211934216, 3834.501514803058, 9090.90909090914, 9230.49232292217, 9261.72214833556, 9332.58003389849, 9348.158665720119, 9280.257579393632, 9281.443113413217, 9289.860652090225, 9294.90705092954, 9302.581383837743, 6972.930270697329, 6999.545029573062, 7123.89314160288, 7150.034745309421, 7155.92844071563, 5103.387593488656, 5250.65870718402, 5472.288602481652, 5480.780768769205, 5527.198556209247, 8428.662853485792, 8482.533460659723, 8571.357148214034, 8581.699640512552, 8643.481391116553, 8362.749117526484, 8590.355723320901, 8597.355198360023, 8780.209781119729, 8805.779855503664, 5764.308283006066, 6131.080337949344, 6345.809625711236, 6577.868442631025, 6686.398224159849, 7064.964675176591, 7077.186123595647, 7079.716811327489, 7140.500164988401, 7141.0, 6332.620042797447, 6414.262359828679, 6482.157319548429, 6482.870342593216, 6590.538662293593, 6353.555251132377, 6460.25707043696, 6527.15147030902, 6545.0, 6599.571027883364, 5875.676837773793, 5895.734691938959, 5921.733521991607, 5932.584719069624, 5948.791792287249, 4275.46556680415, 4525.63794896414, 4533.705309154894, 4589.059242855274, 4600.516945720651, 4338.4360033196745, 4355.782210889506, 4433.689641725177, 4508.436445444319, 4511.954880451285], "value": 3939.642004302761, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.1746067359709, 298.1086551211877, 298.50597261532164, 304.4778205377779, 305.37703085705164, 5071.84784456466, 5072.528966599686, 5109.948900510994, 5113.207452844806, 5126.154184559553, 4968.0, 4978.278149668296, 4993.950060499394, 4999.800007999685, 5058.620603454738, 3747.7563958342757, 3778.3199024175638, 3910.061585219541, 3919.2945269851416, 3939.468171796799, 3893.1240470893963, 3922.8234729437245, 3936.7637941723447, 3945.5462621798574, 3950.2297052074855, 3917.2165566886592, 3934.173823497069, 3940.4483372327895, 3942.5268967723914, 3955.663768579674, 3836.2135762168687, 3905.9218815623813, 3911.9217615647813, 3943.1916457126363, 3953.1105501262273, 3408.1479630092476, 3425.2464457819488, 3447.1382154461385, 3447.5690538682666, 3451.6720911513366, 4932.753362331869, 4933.136701077297, 4935.2843837643695, 4941.838667913037, 4957.677750946213, 4326.805293761757, 4480.185524862436, 4517.119161763458, 4519.367288579601, 4525.932111018337, 5254.185601231815, 5254.7635356409055, 5278.736063196825, 5286.471352864722, 5297.417284098746, 3748.5876553579083, 3757.924841503182, 3772.849086036555, 3787.1857550626746, 3789.9431508527396, 5424.457554244584, 5536.204216870495, 5572.136318870582, 5593.272874526327, 5602.0, 3839.6736277416176, 3861.4400911867624, 3873.573906870242, 3878.2243551289853, 3879.165979314461, 3894.1432884765873, 3912.882613521599, 3927.4108883667677, 3935.3900145477496, 3939.2318497893207, 4436.0, 4492.326151077299, 4497.235469970113, 4497.415336006298, 4498.3927169832305, 5188.818391356284, 5223.328534868881, 5271.920921186185, 5294.279359208195, 5323.0, 1299.8050292456207, 1312.875276848698, 1313.5402609086743, 1315.7236980234259, 1318.637374721959, 844.6536919862826, 865.4504389712451, 866.1425189062909, 884.5179377239419, 899.865020246955, 4528.547145285445, 4681.555252251031, 4686.27362758773, 4704.435467743892, 4709.976450117728, 5424.267723857308, 5429.619926605179, 5472.2338872557875, 5473.644213126134, 5475.233467314579, 4495.527969563214, 4686.109639168547, 4695.2252878275385, 4696.694714843524, 4720.91418973638, 2870.8851645934346, 2891.797574169788, 2897.463969165711, 2908.8254704717783, 2927.9121626351243, 5127.3847138343635, 5140.640155189176, 5158.303629010035, 5165.25518998723, 5168.61235407346, 5394.32570928634, 5564.443555644484, 5572.331320241597, 5576.358718747315, 5583.944160558423, 5102.158143906288, 5116.411612664591, 5120.771014956384, 5148.2277658350795, 5151.793928242978, 5436.7281635918835, 5443.7822487100075, 5467.949518930401, 5484.808031718871, 5513.421090785409, 5110.565601923878, 5248.6325957182635, 5325.946740532545, 5330.200469929541, 5334.839954801362, 5117.360329958755, 5131.743412829418, 5136.357955255593, 5150.330457040711, 5157.974210128926, 3841.9807900961437, 3876.2053778975805, 3886.417037444406, 3909.9609003909595, 3921.588233235583, 5225.16397376418, 5492.873960838098, 5510.118381059011, 5534.446555344433, 5565.526930210977, 5336.226247194213, 5344.076132592341, 5376.274202982548, 5383.946160538501, 5410.83767486976, 5207.359681700253, 5251.133562962068, 5271.706807538733, 5292.311999440049, 5294.735263236746, 5248.527632513092, 5254.765130194478, 5256.448072952285, 5259.60552958522, 5263.184206448007, 5047.444781074152, 5223.138182199895, 5362.1420572708175, 5382.165764306539, 5388.56891448691, 5220.7650655721345, 5226.189940559219, 5246.42289348179, 5254.238135470412, 5256.816011439581], "value": 3981.3843188498713, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [639.6449970266501, 725.7459889038834, 744.4081954845897, 757.4508481351021, 768.1435199752276, 11799.823002654955, 12133.0, 12486.06354523411, 12561.811572826415, 12625.431855566498, 12192.329421881794, 12383.56657516987, 12420.316882571455, 12424.068194885374, 12434.191777534454, 621.7233331167632, 761.0866959648416, 774.9263819937125, 791.6358475101431, 794.2970471133032, 796.2475460689651, 798.0742338886893, 798.8162722573811, 799.3085980626745, 799.532273619933, 833.1335411172373, 835.2107258640588, 835.4402550291289, 836.3100442135262, 838.2832678060262, 826.4710585225461, 827.1645637905729, 829.5644786487112, 829.9170082991712, 831.9792005199857, 613.239582917184, 613.4846728747873, 613.5030625193563, 613.929398119213, 614.1034090228272, 12192.573259935949, 12203.694907627292, 12223.327716975562, 12224.755504889852, 12274.570390036395, 13635.318234088256, 13945.16329020262, 14043.71912561743, 14063.367148478343, 14201.431942722278, 10384.117350025257, 10456.163506919429, 10522.05301522859, 10842.0, 10921.0, 4245.12974840157, 4320.330348795942, 4374.868753937387, 4403.889902752425, 4458.4426946631675, 64534.0, 64600.0, 64981.0, 65138.674306628636, 67753.0, 10105.595776168871, 10223.335483193569, 10399.584016639401, 10422.530986105643, 10585.364878107339, 15550.0, 15597.220138993005, 15650.843491564938, 15658.843411565966, 17186.22661980214, 6891.138607674041, 7084.964575177194, 7090.397316228075, 7186.928130718626, 7315.963420182865, 3750.099976005739, 3841.2701586698995, 3857.267119247334, 3876.592957739453, 3877.3990031545154, 2745.8627068646488, 2843.2749648839413, 2865.126136528337, 2867.225849020753, 2871.655401351851, 482.944461386945, 499.3209235439799, 500.059887411671, 509.26157072245394, 509.71455984648713, 570.2785975740692, 629.3203340392365, 629.5781826176382, 636.853523689554, 642.0048924167615, 8135.308498777552, 8194.467359621605, 8359.832803344021, 8741.868871966926, 8862.689805856764, 605.833395816154, 611.8042226487481, 618.3785295777715, 630.1146888621494, 634.6160572853449, 3981.5421226559315, 3983.322835118037, 4055.986003499125, 4063.5326937401987, 4078.7756673382655, 92130.53934730284, 98816.0, 101038.49480752696, 101781.49109254406, 101853.49073254735, 50002.74998624984, 70056.6497167511, 82499.0, 83991.16008839956, 84190.0, 74442.62778686071, 75514.0, 76768.61615691886, 76952.61523692346, 78429.99999999886, 7374.520656157332, 7557.35762460175, 7637.262490324881, 7732.458727888994, 7877.448578599443, 43587.34618980654, 44521.77739111284, 45672.31491527696, 45804.31293530533, 45835.0, 63846.36153638404, 65891.34108658852, 65966.67016664887, 66151.0, 66595.0, 9791.314607977658, 10061.69814905554, 10095.091441770275, 10098.091171794575, 10278.743031424274, 11253.381064041556, 11300.152488563555, 11385.601503947322, 11551.76896462083, 12023.338716370683, 10891.292066015683, 11248.662540123809, 11692.298462092302, 11707.356095414494, 11974.58088966882, 11045.502952367002, 11282.492287846902, 11325.603603873826, 11350.091992640404, 11770.058395328182, 10232.437215953194, 11284.32294062359, 11504.137189710638, 11515.654530364103, 11627.88372116268, 9866.605335786488, 9908.702738917844, 10250.282480226313, 10295.485225738534, 10687.893121069, 8831.0, 8893.28853691716, 8911.866322005304, 9088.136627020422, 9657.9034209657], "value": 6553.755373770228, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1579.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 108.0, 115.0, 116.0, 116.0, 117.0, 114.0, 116.0, 116.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 124.0, 153.0, 190.0, 128.0, 148.0, 159.0, 126.0, 181.0, 129.0], "value": 149.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 178.0, 163.0, 164.0, 163.0, 164.0, 162.0, 164.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 76.0, 161.0, 76.0, 75.0, 77.0, 75.0, 170.0, 85.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 131.0, 85.0, 86.0, 86.0, 132.0, 87.0, 86.0, 144.0], "value": 100.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 149.0, 147.0, 148.0, 149.0, 149.0, 147.0, 148.0, 148.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 97.0, 96.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 68.0, 66.0, 65.0, 65.0, 64.0, 65.0, 64.0, 66.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 66.0, 66.0, 65.0, 65.0, 66.0, 65.0, 66.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 81.0, 80.0, 80.0, 79.0, 79.0, 80.0, 80.0, 80.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 131.0, 130.0, 132.0, 137.0, 156.0, 138.0, 147.0, 175.0, 142.0], "value": 142.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 175.0, 176.0, 173.0, 176.0, 177.0, 170.0, 170.0, 169.0, 167.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 70.0, 70.0, 68.0, 69.0, 69.0, 69.0, 68.0, 70.0], "value": 69.0, "unit": "score"}]}]} 16:28:56 INFO - Return code: 0 16:28:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:28:56 ERROR - # TBPL SUCCESS # 16:28:56 INFO - Running post-action listener: _resource_record_post_action 16:28:56 INFO - ##### 16:28:56 INFO - ##### Finished run-tests step (success) 16:28:56 INFO - ##### 16:28:56 INFO - Running post-run listener: _resource_record_post_run 16:28:56 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540864512; Read time: 16; Write time: 384544 16:28:56 INFO - TinderboxPrint: CPU usage
13.3% 16:28:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 16:28:56 INFO - TinderboxPrint: I/O write bytes / time
540,864,512 / 384,544 16:28:56 INFO - TinderboxPrint: CPU idle
8,279.5 (86.7%) 16:28:56 INFO - TinderboxPrint: CPU user
1,219.3 (12.8%) 16:28:56 INFO - TinderboxPrint: Swap in / out
0 / 0 16:28:56 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 246390784; Read time: 0; Write time: 204804 16:28:56 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 294473728; Read time: 0; Write time: 179740 16:28:57 INFO - Running post-run listener: _upload_blobber_files 16:28:57 INFO - Blob upload gear active. 16:28:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:28:57 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 16:28:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:28:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:28:57 INFO - (blobuploader) - INFO - Open directory for files ... 16:28:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:28:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:28:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:29:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:29:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:29:02 INFO - (blobuploader) - INFO - Done attempting. 16:29:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:29:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:29:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:29:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:29:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:29:04 INFO - (blobuploader) - INFO - Done attempting. 16:29:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:29:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:29:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:29:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:29:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:29:05 INFO - (blobuploader) - INFO - Done attempting. 16:29:05 INFO - (blobuploader) - INFO - Iteration through files over. 16:29:05 INFO - Return code: 0 16:29:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:29:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:29:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e0abe62415dbef76f3fee48e98b1302b6197605f160145415a70442a342140f84d73ceadff2c555ea55c0b165bc0221fc232c97c5d16cea75629c0c71023980", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f660985a4b6b0b4704dc1fcbeb4b28e39931ceae7bb69ea43fdf56dd6e004da34a04ff07cc614fe336259e7e179e99483681e009fa05173d6c3f44713b5dcbd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5dcc00eefc3ccbc6cb028f92f9b5f4fd121bff652807caab521d6cd1cd81e3ee638999cdcc872e3d8a70fd8779221a9fa754a0de51e6a72ddeeff412b2693e31"} 16:29:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:29:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:29:05 INFO - Contents: 16:29:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e0abe62415dbef76f3fee48e98b1302b6197605f160145415a70442a342140f84d73ceadff2c555ea55c0b165bc0221fc232c97c5d16cea75629c0c71023980", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f660985a4b6b0b4704dc1fcbeb4b28e39931ceae7bb69ea43fdf56dd6e004da34a04ff07cc614fe336259e7e179e99483681e009fa05173d6c3f44713b5dcbd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5dcc00eefc3ccbc6cb028f92f9b5f4fd121bff652807caab521d6cd1cd81e3ee638999cdcc872e3d8a70fd8779221a9fa754a0de51e6a72ddeeff412b2693e31"} 16:29:05 INFO - Running post-run listener: copy_logs_to_upload_dir 16:29:05 INFO - Copying logs to upload dir... 16:29:05 INFO - mkdir: /builds/slave/test/build/upload/logs 16:29:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.936171 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-12 16:29:05.206471) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 16:29:05.209698) ========= 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=8887e36bb8e381bfd44124ac000001a8-1468362027.160471-802018795 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/Firefox-Non-PGO/sha512/5e0abe62415dbef76f3fee48e98b1302b6197605f160145415a70442a342140f84d73ceadff2c555ea55c0b165bc0221fc232c97c5d16cea75629c0c71023980", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f660985a4b6b0b4704dc1fcbeb4b28e39931ceae7bb69ea43fdf56dd6e004da34a04ff07cc614fe336259e7e179e99483681e009fa05173d6c3f44713b5dcbd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5dcc00eefc3ccbc6cb028f92f9b5f4fd121bff652807caab521d6cd1cd81e3ee638999cdcc872e3d8a70fd8779221a9fa754a0de51e6a72ddeeff412b2693e31"} build_url:https://queue.taskcluster.net/v1/task/DvdM9SxWQPWrnxE38w1ljQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011332 build_url: 'https://queue.taskcluster.net/v1/task/DvdM9SxWQPWrnxE38w1ljQ/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/Firefox-Non-PGO/sha512/5e0abe62415dbef76f3fee48e98b1302b6197605f160145415a70442a342140f84d73ceadff2c555ea55c0b165bc0221fc232c97c5d16cea75629c0c71023980", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f660985a4b6b0b4704dc1fcbeb4b28e39931ceae7bb69ea43fdf56dd6e004da34a04ff07cc614fe336259e7e179e99483681e009fa05173d6c3f44713b5dcbd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5dcc00eefc3ccbc6cb028f92f9b5f4fd121bff652807caab521d6cd1cd81e3ee638999cdcc872e3d8a70fd8779221a9fa754a0de51e6a72ddeeff412b2693e31"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 16:29:05.240063) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 16:29:05.240792) ========= 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=8887e36bb8e381bfd44124ac000001a8-1468362027.160471-802018795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 16:29:05.323797) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 16:29:05.324468) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 16:29:05.325090) ========= ========= Total master_lag: 0.20 =========