builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1467870212.98 results: success (0) buildid: 20160706193023 builduid: 8b6038ee6ca24ee1b4e709ad4e6496ee revision: 39ec98bf2580a236471714c28b336d8c974cc365 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 22:43:32.983759) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 22:43:32.984266) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 22:43:32.984551) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 22:43:32.999512) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 22:43:32.999779) ========= 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=1f5564757af27664ca02d71f000001b0-1467870121.805140-365441519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 22:43:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 55.5K=0.2s 2016-07-06 22:43:33 (55.5 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.323640 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 22:43:33.337800) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 22:43:33.338127) ========= 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=1f5564757af27664ca02d71f000001b0-1467870121.805140-365441519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020708 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 22:43:33.387849) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 22:43:33.388231) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 39ec98bf2580a236471714c28b336d8c974cc365 --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 39ec98bf2580a236471714c28b336d8c974cc365 --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=1f5564757af27664ca02d71f000001b0-1467870121.805140-365441519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 22:43:33,428 truncating revision to first 12 chars 2016-07-06 22:43:33,428 Setting DEBUG logging. 2016-07-06 22:43:33,428 attempt 1/10 2016-07-06 22:43:33,428 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/39ec98bf2580?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 22:43:33,999 unpacking tar archive at: mozilla-central-39ec98bf2580/testing/mozharness/ program finished with exit code 0 elapsedTime=0.996582 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 22:43:34.398411) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 22:43:34.398729) ========= script_repo_revision: 39ec98bf2580a236471714c28b336d8c974cc365 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 22:43:34.399143) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 22:43:34.399421) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 22:43:34.410377) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-06 22:43:34.410658) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1467870121.805140-365441519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:43:34 INFO - MultiFileLogger online at 20160706 22:43:34 in /builds/slave/test 22:43:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 22:43:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:43:34 INFO - {'append_to_log': False, 22:43:34 INFO - 'base_work_dir': '/builds/slave/test', 22:43:34 INFO - 'blob_upload_branch': 'Firefox', 22:43:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:43:34 INFO - 'branch': 'Firefox', 22:43:34 INFO - 'buildbot_json_path': 'buildprops.json', 22:43:34 INFO - 'config_files': ('talos/linux_config.py',), 22:43:34 INFO - 'default_actions': ('clobber', 22:43:34 INFO - 'read-buildbot-config', 22:43:34 INFO - 'download-and-extract', 22:43:34 INFO - 'populate-webroot', 22:43:34 INFO - 'create-virtualenv', 22:43:34 INFO - 'install', 22:43:34 INFO - 'run-tests'), 22:43:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:43:34 INFO - 'download_minidump_stackwalk': True, 22:43:34 INFO - 'download_symbols': 'ondemand', 22:43:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:43:34 INFO - 'tooltool.py': '/tools/tooltool.py', 22:43:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:43:34 INFO - '/tools/misc-python/virtualenv.py')}, 22:43:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:43:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:43:34 INFO - 'installer_path': 'installer.exe', 22:43:34 INFO - 'log_level': 'info', 22:43:34 INFO - 'log_name': 'talos', 22:43:34 INFO - 'log_to_console': True, 22:43:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:43:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:43:34 INFO - 'opt_config_files': (), 22:43:34 INFO - 'pip_index': False, 22:43:34 INFO - 'sps_profile': False, 22:43:34 INFO - 'sps_profile_interval': 0, 22:43:34 INFO - 'suite': 'dromaeojs-e10s', 22:43:34 INFO - 'system_bits': '32', 22:43:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:43:34 INFO - 'title': 'talos-linux64-ix-027', 22:43:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:43:34 INFO - 'use_talos_json': True, 22:43:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:43:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:43:34 INFO - 'work_dir': 'build'} 22:43:34 INFO - ##### 22:43:34 INFO - ##### Running clobber step. 22:43:34 INFO - ##### 22:43:34 INFO - Running pre-action listener: _resource_record_pre_action 22:43:34 INFO - Running main action method: clobber 22:43:34 INFO - rmtree: /builds/slave/test/build 22:43:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:43:35 INFO - Running post-action listener: _resource_record_post_action 22:43:35 INFO - ##### 22:43:35 INFO - ##### Finished clobber step (success) 22:43:35 INFO - ##### 22:43:35 INFO - ##### 22:43:35 INFO - ##### Running read-buildbot-config step. 22:43:35 INFO - ##### 22:43:35 INFO - Running pre-action listener: _resource_record_pre_action 22:43:35 INFO - Running main action method: read_buildbot_config 22:43:35 INFO - Using buildbot properties: 22:43:35 INFO - { 22:43:35 INFO - "project": "", 22:43:35 INFO - "product": "firefox", 22:43:35 INFO - "script_repo_revision": "production", 22:43:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 22:43:35 INFO - "repository": "", 22:43:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 22:43:35 INFO - "buildid": "20160706193023", 22:43:35 INFO - "pgo_build": "True", 22:43:35 INFO - "basedir": "/builds/slave/test", 22:43:35 INFO - "buildnumber": 765, 22:43:35 INFO - "slavename": "talos-linux64-ix-027", 22:43:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:43:35 INFO - "platform": "ubuntu64_hw", 22:43:35 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 22:43:35 INFO - "branch": "mozilla-central", 22:43:35 INFO - "repo_path": "mozilla-central", 22:43:35 INFO - "revision": "39ec98bf2580a236471714c28b336d8c974cc365", 22:43:35 INFO - "stage_platform": "linux64-pgo", 22:43:35 INFO - "builduid": "8b6038ee6ca24ee1b4e709ad4e6496ee", 22:43:35 INFO - "slavebuilddir": "test" 22:43:35 INFO - } 22:43:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 22:43:35 INFO - Running post-action listener: _resource_record_post_action 22:43:35 INFO - ##### 22:43:35 INFO - ##### Finished read-buildbot-config step (success) 22:43:35 INFO - ##### 22:43:35 INFO - ##### 22:43:35 INFO - ##### Running download-and-extract step. 22:43:35 INFO - ##### 22:43:35 INFO - Running pre-action listener: _resource_record_pre_action 22:43:35 INFO - Running main action method: download_and_extract 22:43:35 INFO - mkdir: /builds/slave/test/build/tests 22:43: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')]} 22:43:35 INFO - https://queue.taskcluster.net/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:43:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:43:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:43:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/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 22:43:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/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 22:43:36 INFO - Downloaded 1361 bytes. 22:43:36 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:43:36 INFO - Using the following test package requirements: 22:43:36 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:43:36 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:43:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:43:36 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:43:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:43:36 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:43:36 INFO - u'jsshell-linux-x86_64.zip'], 22:43:36 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:43:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:43:36 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:43:36 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:43:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:43:36 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:43:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:43:36 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:43:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:43:36 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:43:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:43:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:43:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:43:36 INFO - https://queue.taskcluster.net/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:43:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:43:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:43:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/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 22:43:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/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 22:43:38 INFO - Downloaded 24303067 bytes. 22:43:38 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'] 22:43:38 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 22:43:39 INFO - Return code: 0 22:43:39 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 22:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:43:39 INFO - https://queue.taskcluster.net/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:43:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:43:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:43:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/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 22:43:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/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 22:43:40 INFO - Downloaded 24303067 bytes. 22:43:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:43:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:43:41 INFO - Return code: 0 22:43:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:43:41 INFO - https://queue.taskcluster.net/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:43:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:43:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:43:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/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 22:43:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/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 22:43:43 INFO - Downloaded 14403333 bytes. 22:43:43 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'] 22:43:43 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 22:43:43 INFO - Return code: 0 22:43: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')]} 22:43:43 INFO - https://queue.taskcluster.net/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:43:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:43:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:43:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/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 22:43:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/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 22:43:46 INFO - Downloaded 60407637 bytes. 22:43:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:43:46 INFO - mkdir: /builds/slave/test/properties 22:43:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:43:46 INFO - Writing to file /builds/slave/test/properties/build_url 22:43:46 INFO - Contents: 22:43:46 INFO - build_url:https://queue.taskcluster.net/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:43:47 INFO - Running post-action listener: _resource_record_post_action 22:43:47 INFO - Running post-action listener: set_extra_try_arguments 22:43:47 INFO - ##### 22:43:47 INFO - ##### Finished download-and-extract step (success) 22:43:47 INFO - ##### 22:43:47 INFO - ##### 22:43:47 INFO - ##### Running populate-webroot step. 22:43:47 INFO - ##### 22:43:47 INFO - Running pre-action listener: _resource_record_pre_action 22:43:47 INFO - Running main action method: populate_webroot 22:43:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:43:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:43:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:43:47 INFO - '--tppagecycles', 22:43:47 INFO - '7'], 22:43:47 INFO - 'tests': ['tsvgm']}}, 22:43:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:43:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:43:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:43:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:43:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:43:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:43:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:43:47 INFO - 'talos_options': ['--disable-e10s'], 22:43:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:43:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:43:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:43:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:43:47 INFO - 'talos_options': ['--disable-e10s'], 22:43:47 INFO - 'tests': ['damp', 'tps']}, 22:43:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:43:47 INFO - 'tests': ['damp', 'tps']}, 22:43:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:43:47 INFO - 'tests': ['dromaeo_dom']}, 22:43:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:43:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:43:47 INFO - 'tests': ['basic_compositor_video']}, 22:43:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:43:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:43:47 INFO - 'tests': ['a11yr', 22:43:47 INFO - 'ts_paint', 22:43:47 INFO - 'tpaint', 22:43:47 INFO - 'sessionrestore', 22:43:47 INFO - 'sessionrestore_no_auto_restore', 22:43:47 INFO - 'tabpaint']}, 22:43:47 INFO - 'other-e10s': {'tests': ['a11yr', 22:43:47 INFO - 'ts_paint', 22:43:47 INFO - 'tpaint', 22:43:47 INFO - 'sessionrestore', 22:43:47 INFO - 'sessionrestore_no_auto_restore', 22:43:47 INFO - 'tabpaint']}, 22:43:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:43:47 INFO - 'ts_paint', 22:43:47 INFO - 'tpaint', 22:43:47 INFO - 'sessionrestore', 22:43:47 INFO - 'sessionrestore_no_auto_restore', 22:43:47 INFO - 'tabpaint']}, 22:43:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:43:47 INFO - 'ts_paint', 22:43:47 INFO - 'tpaint', 22:43:47 INFO - 'sessionrestore', 22:43:47 INFO - 'sessionrestore_no_auto_restore', 22:43:47 INFO - 'tabpaint']}, 22:43:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:43:47 INFO - 'tests': ['a11yr', 22:43:47 INFO - 'ts_paint', 22:43:47 INFO - 'tpaint', 22:43:47 INFO - 'sessionrestore', 22:43:47 INFO - 'sessionrestore_no_auto_restore', 22:43:47 INFO - 'tabpaint']}, 22:43:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:43:47 INFO - 'tests': ['a11yr', 22:43:47 INFO - 'ts_paint', 22:43:47 INFO - 'tpaint', 22:43:47 INFO - 'sessionrestore', 22:43:47 INFO - 'sessionrestore_no_auto_restore', 22:43:47 INFO - 'tabpaint']}, 22:43:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:43:47 INFO - 'tests': ['tsvgx', 22:43:47 INFO - 'tsvgr_opacity', 22:43:47 INFO - 'tart', 22:43:47 INFO - 'tscrollx', 22:43:47 INFO - 'cart']}, 22:43:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:43:47 INFO - 'tsvgr_opacity', 22:43:47 INFO - 'tart', 22:43:47 INFO - 'tscrollx', 22:43:47 INFO - 'cart']}, 22:43:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:43:47 INFO - 'talos_options': ['--disable-e10s'], 22:43:47 INFO - 'tests': ['tp5o']}, 22:43:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:43:47 INFO - 'tests': ['tp5o']}, 22:43:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:43:47 INFO - 'talos_options': ['--disable-e10s', 22:43:47 INFO - '--xperf_path', 22:43:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:43:47 INFO - 'tests': ['tp5n']}, 22:43:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:43:47 INFO - 'talos_options': ['--xperf_path', 22:43:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:43:47 INFO - 'tests': ['tp5n']}}, 22:43:47 INFO - 'talos.zip': {'path': '', 22:43:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:43:47 INFO - Running post-action listener: _resource_record_post_action 22:43:47 INFO - ##### 22:43:47 INFO - ##### Finished populate-webroot step (success) 22:43:47 INFO - ##### 22:43:47 INFO - ##### 22:43:47 INFO - ##### Running create-virtualenv step. 22:43:47 INFO - ##### 22:43:47 INFO - Running pre-action listener: _resource_record_pre_action 22:43:47 INFO - Running main action method: create_virtualenv 22:43:47 INFO - Creating virtualenv /builds/slave/test/build/venv 22:43:47 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 22:43:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:43:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:43:47 INFO - Using real prefix '/usr' 22:43:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:43:47 INFO - Installing distribute.............................................................................................................................................................................................done. 22:43:49 INFO - Installing pip.................done. 22:43:49 INFO - Return code: 0 22:43:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:43:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:43:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:43:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:43:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:43:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:49 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 0x157b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x183c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183a3b0>, '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 0x183b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183b740>, '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': '1f5564757af27664ca02d71f000001b0-1467870121.805140-365441519', '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 22:43:49 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 22:43:49 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 22:43:49 INFO - Using env: {'DISPLAY': ':0', 22:43:49 INFO - 'HOME': '/home/cltbld', 22:43:49 INFO - 'LANG': 'en_US.UTF-8', 22:43:49 INFO - 'LANGUAGE': 'en_US:en', 22:43:49 INFO - 'LOGNAME': 'cltbld', 22:43:49 INFO - 'MAIL': '/var/mail/cltbld', 22:43:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:43:49 INFO - 'MOZ_NO_REMOTE': '1', 22:43:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:43:49 INFO - 'NO_EM_RESTART': '1', 22:43:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:43:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:43:49 INFO - 'PWD': '/builds/slave/test', 22:43:49 INFO - 'SHELL': '/bin/bash', 22:43:49 INFO - 'SHLVL': '1', 22:43:49 INFO - 'TERM': 'linux', 22:43:49 INFO - 'TMOUT': '86400', 22:43:49 INFO - 'USER': 'cltbld', 22:43:49 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467870121.805140-365441519', 22:43:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:43:49 INFO - '_': '/tools/buildbot/bin/python'} 22:43:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:43:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:43:49 INFO - Cleaning up... 22:43:49 INFO - Return code: 0 22:43:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:43:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:43:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:43:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:43:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:43:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:49 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 0x157b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x183c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183a3b0>, '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 0x183b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183b740>, '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': '1f5564757af27664ca02d71f000001b0-1467870121.805140-365441519', '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 22:43:49 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 22:43:49 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 22:43:49 INFO - Using env: {'DISPLAY': ':0', 22:43:49 INFO - 'HOME': '/home/cltbld', 22:43:49 INFO - 'LANG': 'en_US.UTF-8', 22:43:49 INFO - 'LANGUAGE': 'en_US:en', 22:43:49 INFO - 'LOGNAME': 'cltbld', 22:43:49 INFO - 'MAIL': '/var/mail/cltbld', 22:43:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:43:49 INFO - 'MOZ_NO_REMOTE': '1', 22:43:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:43:49 INFO - 'NO_EM_RESTART': '1', 22:43:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:43:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:43:49 INFO - 'PWD': '/builds/slave/test', 22:43:49 INFO - 'SHELL': '/bin/bash', 22:43:49 INFO - 'SHLVL': '1', 22:43:49 INFO - 'TERM': 'linux', 22:43:49 INFO - 'TMOUT': '86400', 22:43:49 INFO - 'USER': 'cltbld', 22:43:49 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467870121.805140-365441519', 22:43:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:43:49 INFO - '_': '/tools/buildbot/bin/python'} 22:43:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:43:50 INFO - Downloading/unpacking psutil>=3.1.1 22:43: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 22:43: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 22:43: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 22:43: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 22:43: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 22:43: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 22:43:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:43:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:43:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:43:52 INFO - Installing collected packages: psutil 22:43:52 INFO - Running setup.py install for psutil 22:43:52 INFO - building 'psutil._psutil_linux' extension 22:43:52 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 22:43:52 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 22:43:52 INFO - building 'psutil._psutil_posix' extension 22:43:52 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 22:43:52 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 22:43:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:43:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:43:52 INFO - Successfully installed psutil 22:43:52 INFO - Cleaning up... 22:43:52 INFO - Return code: 0 22:43:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:43:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:43:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:43:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:43:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x183c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183a3b0>, '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 0x183b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183b740>, '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': '1f5564757af27664ca02d71f000001b0-1467870121.805140-365441519', '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 22:43:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:43:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:43:52 INFO - Using env: {'DISPLAY': ':0', 22:43:52 INFO - 'HOME': '/home/cltbld', 22:43:52 INFO - 'LANG': 'en_US.UTF-8', 22:43:52 INFO - 'LANGUAGE': 'en_US:en', 22:43:52 INFO - 'LOGNAME': 'cltbld', 22:43:52 INFO - 'MAIL': '/var/mail/cltbld', 22:43:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:43:52 INFO - 'MOZ_NO_REMOTE': '1', 22:43:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:43:52 INFO - 'NO_EM_RESTART': '1', 22:43:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:43:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:43:52 INFO - 'PWD': '/builds/slave/test', 22:43:52 INFO - 'SHELL': '/bin/bash', 22:43:52 INFO - 'SHLVL': '1', 22:43:52 INFO - 'TERM': 'linux', 22:43:52 INFO - 'TMOUT': '86400', 22:43:52 INFO - 'USER': 'cltbld', 22:43:52 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467870121.805140-365441519', 22:43:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:43:52 INFO - '_': '/tools/buildbot/bin/python'} 22:43:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:43:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:43:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:43:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:43:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:43:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:43:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:43:54 INFO - Installing collected packages: mozsystemmonitor 22:43:54 INFO - Running setup.py install for mozsystemmonitor 22:43:54 INFO - Successfully installed mozsystemmonitor 22:43:54 INFO - Cleaning up... 22:43:55 INFO - Return code: 0 22:43:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:43:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:43:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x157b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x183c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183a3b0>, '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 0x183b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183b740>, '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': '1f5564757af27664ca02d71f000001b0-1467870121.805140-365441519', '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 22:43:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:43:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:43:55 INFO - Using env: {'DISPLAY': ':0', 22:43:55 INFO - 'HOME': '/home/cltbld', 22:43:55 INFO - 'LANG': 'en_US.UTF-8', 22:43:55 INFO - 'LANGUAGE': 'en_US:en', 22:43:55 INFO - 'LOGNAME': 'cltbld', 22:43:55 INFO - 'MAIL': '/var/mail/cltbld', 22:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:43:55 INFO - 'MOZ_NO_REMOTE': '1', 22:43:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:43:55 INFO - 'NO_EM_RESTART': '1', 22:43:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:43:55 INFO - 'PWD': '/builds/slave/test', 22:43:55 INFO - 'SHELL': '/bin/bash', 22:43:55 INFO - 'SHLVL': '1', 22:43:55 INFO - 'TERM': 'linux', 22:43:55 INFO - 'TMOUT': '86400', 22:43:55 INFO - 'USER': 'cltbld', 22:43:55 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467870121.805140-365441519', 22:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:43:55 INFO - '_': '/tools/buildbot/bin/python'} 22:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:43:55 INFO - Downloading/unpacking jsonschema==2.5.1 22:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:43:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:43:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:43:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:43:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:43:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:43:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:43:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:43:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:43:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:43:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:43:57 INFO - Downloading functools32-3.2.3-2.tar.gz 22:43:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:43:57 INFO - warning: no files found matching '*.txt' 22:43:57 INFO - no previously-included directories found matching 'build' 22:43:57 INFO - no previously-included directories found matching 'dist' 22:43:57 INFO - no previously-included directories found matching '.git*' 22:43:57 INFO - Installing collected packages: jsonschema, functools32 22:43:57 INFO - Running setup.py install for functools32 22:43:57 INFO - warning: no files found matching '*.txt' 22:43:57 INFO - no previously-included directories found matching 'build' 22:43:57 INFO - no previously-included directories found matching 'dist' 22:43:57 INFO - no previously-included directories found matching '.git*' 22:43:57 INFO - Successfully installed jsonschema functools32 22:43:57 INFO - Cleaning up... 22:43:57 INFO - Return code: 0 22:43:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:43:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:43:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:43:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:57 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 0x157b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x183c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183a3b0>, '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 0x183b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183b740>, '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': '1f5564757af27664ca02d71f000001b0-1467870121.805140-365441519', '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 22:43:57 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 22:43:57 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 22:43:57 INFO - Using env: {'DISPLAY': ':0', 22:43:57 INFO - 'HOME': '/home/cltbld', 22:43:57 INFO - 'LANG': 'en_US.UTF-8', 22:43:57 INFO - 'LANGUAGE': 'en_US:en', 22:43:57 INFO - 'LOGNAME': 'cltbld', 22:43:57 INFO - 'MAIL': '/var/mail/cltbld', 22:43:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:43:57 INFO - 'MOZ_NO_REMOTE': '1', 22:43:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:43:57 INFO - 'NO_EM_RESTART': '1', 22:43:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:43:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:43:57 INFO - 'PWD': '/builds/slave/test', 22:43:57 INFO - 'SHELL': '/bin/bash', 22:43:57 INFO - 'SHLVL': '1', 22:43:57 INFO - 'TERM': 'linux', 22:43:57 INFO - 'TMOUT': '86400', 22:43:57 INFO - 'USER': 'cltbld', 22:43:57 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467870121.805140-365441519', 22:43:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:43:57 INFO - '_': '/tools/buildbot/bin/python'} 22:43:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:43:57 INFO - Downloading/unpacking blobuploader==1.2.4 22:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:43:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:43:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:43:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:43:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:43:58 INFO - Downloading blobuploader-1.2.4.tar.gz 22:43:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:43:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:43:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:43:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:43:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:44:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:44:00 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 22:44:00 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 22:44:00 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 22:44:00 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 22:44:00 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 22:44:00 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 22:44:00 INFO - Downloading docopt-0.6.1.tar.gz 22:44:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:44:00 INFO - Installing collected packages: blobuploader, requests, docopt 22:44:00 INFO - Running setup.py install for blobuploader 22:44:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:44:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:44:00 INFO - Running setup.py install for requests 22:44:00 INFO - Running setup.py install for docopt 22:44:00 INFO - Successfully installed blobuploader requests docopt 22:44:00 INFO - Cleaning up... 22:44:00 INFO - Return code: 0 22:44:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:00 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 0x157b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x183c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183a3b0>, '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 0x183b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183b740>, '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': '1f5564757af27664ca02d71f000001b0-1467870121.805140-365441519', '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 22:44:00 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 22:44:00 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 22:44:00 INFO - Using env: {'DISPLAY': ':0', 22:44:00 INFO - 'HOME': '/home/cltbld', 22:44:00 INFO - 'LANG': 'en_US.UTF-8', 22:44:00 INFO - 'LANGUAGE': 'en_US:en', 22:44:00 INFO - 'LOGNAME': 'cltbld', 22:44:00 INFO - 'MAIL': '/var/mail/cltbld', 22:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:44:00 INFO - 'MOZ_NO_REMOTE': '1', 22:44:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:44:00 INFO - 'NO_EM_RESTART': '1', 22:44:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:44:00 INFO - 'PWD': '/builds/slave/test', 22:44:00 INFO - 'SHELL': '/bin/bash', 22:44:00 INFO - 'SHLVL': '1', 22:44:00 INFO - 'TERM': 'linux', 22:44:00 INFO - 'TMOUT': '86400', 22:44:00 INFO - 'USER': 'cltbld', 22:44:00 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467870121.805140-365441519', 22:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:44:00 INFO - '_': '/tools/buildbot/bin/python'} 22:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:44:01 INFO - Running setup.py (path:/tmp/pip-Ywduf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:44:01 INFO - Running setup.py (path:/tmp/pip-yadPTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:44:01 INFO - Running setup.py (path:/tmp/pip-RiZesE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:44:01 INFO - Running setup.py (path:/tmp/pip-_MZTeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:44:01 INFO - Running setup.py (path:/tmp/pip-ZN6Ci6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:44:01 INFO - Running setup.py (path:/tmp/pip-QK0Wg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:44:01 INFO - Running setup.py (path:/tmp/pip-MaKMsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:44:01 INFO - Running setup.py (path:/tmp/pip-Q4k6Eh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:44:01 INFO - Running setup.py (path:/tmp/pip-25rJZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:44:01 INFO - Running setup.py (path:/tmp/pip-rONMrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:44:01 INFO - Running setup.py (path:/tmp/pip-5se4Gj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:44:01 INFO - Running setup.py (path:/tmp/pip-tfAoH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:44:02 INFO - Running setup.py (path:/tmp/pip-1BHgw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:44:02 INFO - Running setup.py (path:/tmp/pip-Zpwsj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:44:02 INFO - Running setup.py (path:/tmp/pip-D61i6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:44:02 INFO - Running setup.py (path:/tmp/pip-BPXuK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:44:02 INFO - Running setup.py (path:/tmp/pip-srX0At-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:44:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:44:02 INFO - Running setup.py install for manifestparser 22:44:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:44:02 INFO - Running setup.py install for mozcrash 22:44:02 INFO - Running setup.py install for mozdebug 22:44:02 INFO - Running setup.py install for mozdevice 22:44:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:44:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:44:02 INFO - Running setup.py install for mozfile 22:44:02 INFO - Running setup.py install for mozhttpd 22:44:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:44:03 INFO - Running setup.py install for mozinfo 22:44:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:44:03 INFO - Running setup.py install for mozInstall 22:44:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:44:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:44:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:44:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:44:03 INFO - Running setup.py install for mozleak 22:44:03 INFO - Running setup.py install for mozlog 22:44:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:44:03 INFO - Running setup.py install for moznetwork 22:44:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:44:03 INFO - Running setup.py install for mozprocess 22:44:03 INFO - Running setup.py install for mozprofile 22:44:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:44:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:44:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:44:03 INFO - Running setup.py install for mozrunner 22:44:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:44:03 INFO - Running setup.py install for mozscreenshot 22:44:03 INFO - Running setup.py install for moztest 22:44:04 INFO - Running setup.py install for mozversion 22:44:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:44:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:44:04 INFO - Cleaning up... 22:44:04 INFO - Return code: 0 22:44:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:44:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:44:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:44:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:04 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 0x157b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x183c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183a3b0>, '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 0x183b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183b740>, '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': '1f5564757af27664ca02d71f000001b0-1467870121.805140-365441519', '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 22:44:04 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 22:44:04 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 22:44:04 INFO - Using env: {'DISPLAY': ':0', 22:44:04 INFO - 'HOME': '/home/cltbld', 22:44:04 INFO - 'LANG': 'en_US.UTF-8', 22:44:04 INFO - 'LANGUAGE': 'en_US:en', 22:44:04 INFO - 'LOGNAME': 'cltbld', 22:44:04 INFO - 'MAIL': '/var/mail/cltbld', 22:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:44:04 INFO - 'MOZ_NO_REMOTE': '1', 22:44:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:44:04 INFO - 'NO_EM_RESTART': '1', 22:44:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:44:04 INFO - 'PWD': '/builds/slave/test', 22:44:04 INFO - 'SHELL': '/bin/bash', 22:44:04 INFO - 'SHLVL': '1', 22:44:04 INFO - 'TERM': 'linux', 22:44:04 INFO - 'TMOUT': '86400', 22:44:04 INFO - 'USER': 'cltbld', 22:44:04 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467870121.805140-365441519', 22:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:44:04 INFO - '_': '/tools/buildbot/bin/python'} 22:44:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:44:04 INFO - Running setup.py (path:/tmp/pip-d9njbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:44:04 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)) 22:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:44:04 INFO - Running setup.py (path:/tmp/pip-OIH4Uf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:44:04 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)) 22:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:44:04 INFO - Running setup.py (path:/tmp/pip-HUzZpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:44:04 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)) 22:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:44:04 INFO - Running setup.py (path:/tmp/pip-faLuol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:44:04 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)) 22:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:44:04 INFO - Running setup.py (path:/tmp/pip-z_1yOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:44:04 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)) 22:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:44:04 INFO - Running setup.py (path:/tmp/pip-xfnafK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:44:04 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)) 22:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:44:04 INFO - Running setup.py (path:/tmp/pip-HO0aI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:44:04 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)) 22:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:44:04 INFO - Running setup.py (path:/tmp/pip-qxMzXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:44:04 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)) 22:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:44:05 INFO - Running setup.py (path:/tmp/pip-LN_ufa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:44:05 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)) 22:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:44:05 INFO - Running setup.py (path:/tmp/pip-55KT_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:44:05 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)) 22:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:44:05 INFO - Running setup.py (path:/tmp/pip-AFcBAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:44:05 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)) 22:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:44:05 INFO - Running setup.py (path:/tmp/pip-h28ViX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:44:05 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)) 22:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:44:05 INFO - Running setup.py (path:/tmp/pip-OcnMj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:44:05 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)) 22:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:44:05 INFO - Running setup.py (path:/tmp/pip-w2YAB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:44:05 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)) 22:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:44:05 INFO - Running setup.py (path:/tmp/pip-kKIQwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:44:05 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)) 22:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:44:05 INFO - Running setup.py (path:/tmp/pip-jGdIDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:44:05 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)) 22:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:44:05 INFO - Running setup.py (path:/tmp/pip-ikB3FV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:44:05 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)) 22:44:05 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)) 22:44:05 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)) 22:44:05 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)) 22:44:05 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)) 22:44:05 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)) 22:44:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:44:05 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 22:44:05 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 22:44:05 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 22:44:05 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 22:44:05 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 22:44:05 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 22:44:07 INFO - Downloading blessings-1.6.tar.gz 22:44:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:44:07 INFO - Installing collected packages: blessings 22:44:07 INFO - Running setup.py install for blessings 22:44:07 INFO - Successfully installed blessings 22:44:07 INFO - Cleaning up... 22:44:07 INFO - Return code: 0 22:44:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:44:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:44:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:44:08 INFO - Reading from file tmpfile_stdout 22:44:08 INFO - Current package versions: 22:44:08 INFO - argparse == 1.2.1 22:44:08 INFO - blessings == 1.6 22:44:08 INFO - blobuploader == 1.2.4 22:44:08 INFO - docopt == 0.6.1 22:44:08 INFO - functools32 == 3.2.3-2 22:44:08 INFO - jsonschema == 2.5.1 22:44:08 INFO - manifestparser == 1.1 22:44:08 INFO - mozInstall == 1.12 22:44:08 INFO - mozcrash == 0.17 22:44:08 INFO - mozdebug == 0.1 22:44:08 INFO - mozdevice == 0.48 22:44:08 INFO - mozfile == 1.2 22:44:08 INFO - mozhttpd == 0.7 22:44:08 INFO - mozinfo == 0.9 22:44:08 INFO - mozleak == 0.1 22:44:08 INFO - mozlog == 3.2 22:44:08 INFO - moznetwork == 0.27 22:44:08 INFO - mozprocess == 0.23 22:44:08 INFO - mozprofile == 0.28 22:44:08 INFO - mozrunner == 6.12 22:44:08 INFO - mozscreenshot == 0.1 22:44:08 INFO - mozsystemmonitor == 0.3 22:44:08 INFO - moztest == 0.7 22:44:08 INFO - mozversion == 1.4 22:44:08 INFO - psutil == 3.1.1 22:44:08 INFO - requests == 1.2.3 22:44:08 INFO - wsgiref == 0.1.2 22:44:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:44:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:44:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:44:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:08 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 0x157b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x183c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183a3b0>, '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 0x183b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183b740>, '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': '1f5564757af27664ca02d71f000001b0-1467870121.805140-365441519', '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 22:44:08 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 22:44:08 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 22:44:08 INFO - Using env: {'DISPLAY': ':0', 22:44:08 INFO - 'HOME': '/home/cltbld', 22:44:08 INFO - 'LANG': 'en_US.UTF-8', 22:44:08 INFO - 'LANGUAGE': 'en_US:en', 22:44:08 INFO - 'LOGNAME': 'cltbld', 22:44:08 INFO - 'MAIL': '/var/mail/cltbld', 22:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:44:08 INFO - 'MOZ_NO_REMOTE': '1', 22:44:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:44:08 INFO - 'NO_EM_RESTART': '1', 22:44:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:44:08 INFO - 'PWD': '/builds/slave/test', 22:44:08 INFO - 'SHELL': '/bin/bash', 22:44:08 INFO - 'SHLVL': '1', 22:44:08 INFO - 'TERM': 'linux', 22:44:08 INFO - 'TMOUT': '86400', 22:44:08 INFO - 'USER': 'cltbld', 22:44:08 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467870121.805140-365441519', 22:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:44:08 INFO - '_': '/tools/buildbot/bin/python'} 22:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:44:08 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)) 22:44:08 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)) 22:44:08 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)) 22:44:08 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)) 22:44:08 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)) 22:44:08 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)) 22:44:08 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)) 22:44:08 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)) 22:44:08 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)) 22:44:08 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)) 22:44:08 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)) 22:44:08 INFO - Cleaning up... 22:44:08 INFO - Return code: 0 22:44:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:44:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:44:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:44:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:08 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 0x157b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x183c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183a3b0>, '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 0x183b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183b740>, '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': '1f5564757af27664ca02d71f000001b0-1467870121.805140-365441519', '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 22:44:08 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 22:44:08 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 22:44:08 INFO - Using env: {'DISPLAY': ':0', 22:44:08 INFO - 'HOME': '/home/cltbld', 22:44:08 INFO - 'LANG': 'en_US.UTF-8', 22:44:08 INFO - 'LANGUAGE': 'en_US:en', 22:44:08 INFO - 'LOGNAME': 'cltbld', 22:44:08 INFO - 'MAIL': '/var/mail/cltbld', 22:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:44:08 INFO - 'MOZ_NO_REMOTE': '1', 22:44:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:44:08 INFO - 'NO_EM_RESTART': '1', 22:44:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:44:08 INFO - 'PWD': '/builds/slave/test', 22:44:08 INFO - 'SHELL': '/bin/bash', 22:44:08 INFO - 'SHLVL': '1', 22:44:08 INFO - 'TERM': 'linux', 22:44:08 INFO - 'TMOUT': '86400', 22:44:08 INFO - 'USER': 'cltbld', 22:44:08 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467870121.805140-365441519', 22:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:44:08 INFO - '_': '/tools/buildbot/bin/python'} 22:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:44:08 INFO - Cleaning up... 22:44:08 INFO - Return code: 0 22:44:08 INFO - Running post-action listener: _resource_record_post_action 22:44:08 INFO - Running post-action listener: _start_resource_monitoring 22:44:08 INFO - Starting resource monitoring. 22:44:08 INFO - ##### 22:44:08 INFO - ##### Finished create-virtualenv step (success) 22:44:08 INFO - ##### 22:44:08 INFO - ##### 22:44:08 INFO - ##### Running install step. 22:44:08 INFO - ##### 22:44:08 INFO - Running pre-action listener: _resource_record_pre_action 22:44:08 INFO - Running main action method: install 22:44:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:44:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:44:08 INFO - Reading from file tmpfile_stdout 22:44:08 INFO - Detecting whether we're running mozinstall >=1.0... 22:44:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:44:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:44:08 INFO - Reading from file tmpfile_stdout 22:44:08 INFO - Output received: 22:44:08 INFO - Usage: mozinstall [options] installer 22:44:08 INFO - Options: 22:44:08 INFO - -h, --help show this help message and exit 22:44:08 INFO - -d DEST, --destination=DEST 22:44:08 INFO - Directory to install application into. [default: 22:44:08 INFO - "/builds/slave/test"] 22:44:08 INFO - --app=APP Application being installed. [default: firefox] 22:44:08 INFO - mkdir: /builds/slave/test/build/application 22:44:08 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'] 22:44:08 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 22:44:25 INFO - Reading from file tmpfile_stdout 22:44:25 INFO - Output received: 22:44:25 INFO - /builds/slave/test/build/application/firefox/firefox 22:44:25 INFO - Running post-action listener: _resource_record_post_action 22:44:25 INFO - ##### 22:44:25 INFO - ##### Finished install step (success) 22:44:25 INFO - ##### 22:44:25 INFO - ##### 22:44:25 INFO - ##### Running run-tests step. 22:44:25 INFO - ##### 22:44:25 INFO - Running pre-action listener: _resource_record_pre_action 22:44:25 INFO - Running main action method: run_tests 22:44:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:44:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:44:25 INFO - Python 2.7.3 22:44:25 INFO - Return code: 0 22:44:25 INFO - grabbing minidump binary from tooltool 22:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:44:25 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/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 0x183a3b0>, '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 0x183b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183b740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:44:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:44:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:44:25 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 22:44:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:44:25 INFO - Return code: 0 22:44:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:44:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:44:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:44:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:44:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:44:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 22:44:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 22:44:25 INFO - Using env: {'DISPLAY': ':0', 22:44:25 INFO - 'HOME': '/home/cltbld', 22:44:25 INFO - 'LANG': 'en_US.UTF-8', 22:44:25 INFO - 'LANGUAGE': 'en_US:en', 22:44:25 INFO - 'LOGNAME': 'cltbld', 22:44:25 INFO - 'MAIL': '/var/mail/cltbld', 22:44:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:44:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:44:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:44:25 INFO - 'MOZ_NO_REMOTE': '1', 22:44:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:44:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:44:25 INFO - 'NO_EM_RESTART': '1', 22:44:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:44:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:44:25 INFO - 'PWD': '/builds/slave/test', 22:44:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:44:25 INFO - 'SHELL': '/bin/bash', 22:44:25 INFO - 'SHLVL': '1', 22:44:25 INFO - 'TERM': 'linux', 22:44:25 INFO - 'TMOUT': '86400', 22:44:25 INFO - 'USER': 'cltbld', 22:44:25 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467870121.805140-365441519', 22:44:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:44:25 INFO - '_': '/tools/buildbot/bin/python'} 22:44:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 22:44:26 INFO - mozversion application_buildid: 20160706193023 22:44:26 INFO - mozversion application_changeset: 39ec98bf2580a236471714c28b336d8c974cc365 22:44:26 INFO - mozversion application_display_name: Nightly 22:44:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:44:26 INFO - mozversion application_name: Firefox 22:44:26 INFO - mozversion application_remotingname: firefox 22:44:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:44:26 INFO - mozversion application_vendor: Mozilla 22:44:26 INFO - mozversion application_version: 50.0a1 22:44:26 INFO - mozversion platform_buildid: 20160706193023 22:44:26 INFO - mozversion platform_changeset: 39ec98bf2580a236471714c28b336d8c974cc365 22:44:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:44:26 INFO - mozversion platform_version: 50.0a1 22:44:26 INFO - using testdate: 1467870266 22:44:26 INFO - actual date: 1467870266 22:44:26 INFO - starting webserver on 'localhost:35847' 22:44:26 INFO - SUITE-START | Running 2 tests 22:44:26 INFO - TEST-START | dromaeo_css 22:44:26 INFO - operating with platform_type : linux_ 22:44:26 INFO - Initialising browser for dromaeo_css test... 22:44:26 INFO - TEST-INFO | started process 949 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx0QMcC/profile http://localhost:35847/getInfo.html) 22:44:30 INFO - PROCESS | 949 | __metrics Screen width/height:1600/1200 22:44:30 INFO - PROCESS | 949 | colorDepth:24 22:44:30 INFO - PROCESS | 949 | Browser inner width/height: 1024/697 22:44:30 INFO - PROCESS | 949 | __metrics 22:44:31 ERROR - PROCESS | 949 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 22:44:32 INFO - TEST-INFO | 949: exit 0 22:44:32 INFO - Browser initialized. 22:44:32 INFO - Running cycle 1/1 for dromaeo_css test... 22:44:32 INFO - TEST-INFO | started process 1079 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx0QMcC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:44:43 INFO - PROCESS | 1079 | RSS: Main: 167727104 22:44:43 INFO - PROCESS | 1079 | 22:45:33 INFO - PROCESS | 1079 | 1467870333525 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] 22:47:41 INFO - PROCESS | 1079 | Cycle 1(1): loaded http://localhost:35847/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35847/tests/dromaeo/cssquery-ext.html) 22:47:42 INFO - PROCESS | 1079 | RSS: Main: 170782720 22:47:42 INFO - PROCESS | 1079 | 22:50:44 INFO - PROCESS | 1079 | Cycle 1(1): loaded http://localhost:35847/tests/dromaeo/cssquery-ext.html (next: http://localhost:35847/tests/dromaeo/cssquery-jquery.html) 22:50:45 INFO - PROCESS | 1079 | RSS: Main: 167952384 22:50:45 INFO - PROCESS | 1079 | 22:53:47 INFO - PROCESS | 1079 | Cycle 1(1): loaded http://localhost:35847/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35847/tests/dromaeo/cssquery-mootools.html) 22:53:47 INFO - PROCESS | 1079 | RSS: Main: 171585536 22:53:47 INFO - PROCESS | 1079 | 22:56:49 INFO - PROCESS | 1079 | Cycle 1(1): loaded http://localhost:35847/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35847/tests/dromaeo/cssquery-prototype.html) 22:56:50 INFO - PROCESS | 1079 | RSS: Main: 167436288 22:56:50 INFO - PROCESS | 1079 | 22:59:52 INFO - PROCESS | 1079 | Cycle 1(1): loaded http://localhost:35847/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35847/tests/dromaeo/cssquery-yui.html) 22:59:53 INFO - PROCESS | 1079 | RSS: Main: 168611840 22:59:53 INFO - PROCESS | 1079 | 23:02:56 INFO - PROCESS | 1079 | Cycle 1(1): loaded http://localhost:35847/tests/dromaeo/cssquery-yui.html (next: http://localhost:35847/tests/dromaeo/cssquery-dojo.html) 23:02:56 INFO - PROCESS | 1079 | RSS: Main: 169963520 23:02:56 INFO - PROCESS | 1079 | 23:02:56 INFO - PROCESS | 1079 | __start_tp_report 23:02:56 INFO - PROCESS | 1079 | _x_x_mozilla_page_load 23:02:56 INFO - PROCESS | 1079 | _x_x_mozilla_page_load_details 23:02:56 INFO - PROCESS | 1079 | |i|pagename|runs| 23:02:56 INFO - PROCESS | 1079 | |0;dojo.html;3072.216584770884;3103.177657920653;3142.481490554058;3162.604674415698;3164.7468202543782;5297.3908000579895;5328.760205790739;5356.598255130866;5409.486098820616;5427.538659213962;5249.973750131254;5286.629935904479;5301.814436494724;5337.492938170877;5372.435894231098;4791.616670666338;4811.08589368019;4901.803927842882;4958.429780575226;4999.275105109775;800.9262021073752;4771.165046116916;4794.712317260975;4913.680610760289;4927.236278376839;4793.161196790566;4805.687630304019;4844.055409195208;4861.465238823726;4887.902241955177;4846.515348465161;4859.708417494961;4869.4156701195725;4890.144224760653;4912.803487860481;4750.4299484061785;4765.499622539653;4774.140654682155;4819.49395313494;4861.197902346109;5273.604479664041;5309.946900530984;5315.6013299002725;5318.574514038867;5384.680753215448;5532.197831314437;5721.39925307845;5740.138979153118;5743.770249190027;5750.079987202028;5679.602427830054;5727.255456790632;5739.167820666022;5744;5772.134179873011;5385.488378604026;5390.00284947286;5400.567954563665;5415.10650742631;5415.810446634349;5786.652800831964;5790.884182316414;5814.854628634233;5840.591158618856;5847.415258474119;5608.551315894719;5682.062459694187;5689.857753556112;5701.230333904953;5723.828285151452;5768.394318596571;5769.653820770767;5770.653760774283;5771.740271687784;5774.566907481955;5533.418991005887;5716.314042314949;5725.370209276976;5762.222100016528;5766.509846662997;5776.566757493205;5787.8424315137145;5792.594518383757;5792.855178620568;5856.209411729447;4387.824487020547;4409.867703968886;4436.911261774746;4436.933445998248;4482.932756008662;3842.135519508144;3882.4176373544196;3895.2988462076532;3905.336092864163;3995.6603688686787;5371;5373.516383525502;5387.46125387466;5390.811321603804;5466.289382380265;5792.304923409218;5799.304083509922;5801.129830525455;5802.216700745345;5807.912881306784;5335.119705248668;5463.344398672105;5481.972590137024;5509.393966663663;5545.805896793673;4982.626303027215;5006.249062640633;5007.824726134568;5016.598672106223;5044.672096313728;5967.641941483438;5996;6001.63990160583;6005.579609427386;6009.36901625323;5608.327000759935;5706.657600543981;5776.480116789509;5782.537397008314;5832.62087964281;5956.523478121653;5965.403459654;5967.7016149191495;5969.462748352669;5979.402059793986;5495.203195536545;5709.714514274353;5710.428957104256;5718.22803921482;5721.256236689203;5666.858328541819;5701.771929122789;5705.515031222392;5734.455226753452;5742.138679198154;5541.3904470509015;5568.805091821767;5606.747696353756;5610.382857885547;5614.354349249888;5507.008738427122;5522.530584900168;5535.529479994246;5563.77744890216;5573.6098473106495;5479.287692599936;5555.8888822224135;5556.083246264321;5560.165975103605;5580.776768929198;5523.502884740393;5589.413111623221;5613.635113717595;5657.773689052557;5663.178839068394;5360.65155764874;5519.39286678473;5528.502434780889;5568.498835104698;5606.775728970795 23:02:56 INFO - PROCESS | 1079 | |1;ext.html;586.2173997713053;605.9394060593941;630.7445484578744;633.4457349818907;663.6980174020821;38711.41932871006;42261.57738422615;42275.365869511945;42378.152436951284;42495;41785.373219401736;42055.158896822046;42286.78856605721;42456.78771606138;42512.362314565304;8931.240844528207;9043.005269420359;9054.275657947348;9075;9096.63613455461;8857.247133993586;9003.819923601557;9021.097890210993;9024.097590240955;9061.728148155566;8994.550272486382;8995.865062024075;9052.683156089539;9071.682491112811;9079.137481939206;8957.596908139149;9000.819983600324;9017.2786177106;9055.18503334703;9073.228775554086;8896.243819275369;8942.284617230605;8949.865752013726;8963.775905602346;8995.55022248885;41255.174896502205;41424.37863432051;41632.37551436731;41669.583304166874;41695.7915210422;2941.3234955960033;3373.409653310661;3460.2560449503226;3712.313222053902;4047.372657238133;28739;29613.259668508243;31055;32026.039218823473;32183;4209;4212.262854000568;4252.149570085995;4307.547707490699;4374.803133858984;309120;309380;309745;310417;310909;34568;34686.47970280448;34703.479447808306;34709.305813884086;34715;35347.82326088353;36122.45816312757;36522.634773652455;37828;38229.04427389338;17659.11704414774;17793.19930603126;17793.288268469376;17928.103594820208;17955.910220448815;13627.454901803816;13639;13699.109557878706;13705.177689338472;13713.108647938052;19453.31913383053;19691.227789499015;19705.916174610247;19722.30971915976;19753.802461975196;7000.684969176399;7160.014182201304;7271.672774725044;7281;7395.593242371721;897.4749771383683;985.2315194148575;994.6071301835879;1017.7353887989176;1069.0218450118211;32781.83609081939;32950;33050.504242436386;33254.50118248228;33493.330133397685;1110.6667999600088;1130.4008875296106;1140.7946569617382;1165.8717541070475;1200.9579664711694;16988.235529401205;17379;17386.21762020712;17433.738493922603;17538.56153596145;626432;945474;948602;963224;987034;58961.70519147377;59027;59555.404445954984;59999.70000149971;60030.39969600248;1368.185929372022;1369.9726005479833;1371.8422381426064;1389.006860095037;1393.2754967416886;31399.17407433342;33746.15634609154;33858.49212261867;34075.829620851735;34343.82828085843;52275.47724522706;52353;52456.737716311174;52688.73655631697;52759.736201318745;536183;543200;543439;543653;543979;28345.43309133847;28523.42953140967;28715.8564207186;28734.281642959093;28750.856245718638;47098.293525596455;47891.52108478871;47920;48170.27744583764;49157.50842491529;41231.58768412277;41775.58224417717;42164.578354216064;42522.36216456694;42568.78715606402;41400.1719965593;41458.58541414547;41524.58475415328;41747;41770.791146044074;40592.79703601463;40977.59022409857;41741.79129104335;41815;41836.3724544126;28842.567361489175;31801.6819831808;32033.83983080163;34537.136571585914;34665.48001779925;28291.71708282973;28524.57213141846;28590.285242869093;28729.56905646375;28754.424911501235 23:02:56 INFO - PROCESS | 1079 | |2;jquery.html;383.10544877710544;393.56511055283903;395.59846755543145;402.27590337392695;418.54796819434995;15750.606234844134;18706.90646546767;19720.704189437132;20194.39416817496;20243.089060992235;19090.713639295423;19418;19962.30131945382;19975.101120449577;20021.498387620915;5622.718864056781;5633.943660563393;5796.536277097822;5801.984652685785;5807.651540907559;5709.71451427429;5739.799107031255;5750.1949727038245;5762.942370576283;5770.884582308351;5526.226328314039;5623.9437605623825;5642.492175704186;5758.568107391941;5775.711214439282;5468.125099984023;5644.971775141119;5658.85852853682;5659.575531835108;5663.093904975205;5031.295618613397;5123.2827404163445;5137.357830271216;5150.021495915764;5150.407703114152;22838.657420138545;23076.884615576982;23969.760302397102;24165.516689666107;24171.395715107086;2363.491849252419;2396.436837343223;2441.523902838947;2901.7098290171025;3149.401613693391;14260.714785704331;14781;15167.165805880672;15201.087934723952;15263.847361526354;1956.4815323939167;2040.1941233212797;2047.8668886522328;2064.9483762906048;2095.224766836265;77028.61485692536;78301.21698782996;78387.21612783856;78429.21570784276;78625;10832.133429325793;11059.557617695364;11074.778504429867;11275.323480591027;11380.203385763083;12262.570810021607;13067.477300908047;13084.08411411192;14373.928130359282;14399.352029158714;6282.089097080898;6511.15355003856;7358.1538123116525;7926.682932682744;8070.757877263692;8062.113167551564;8178;8304.584770761438;8328.04417901504;8431.409801313972;4151.8339266429;4161.459010328638;4165.541790403053;4177.540470548237;4198.748075115503;1863.8136186381525;1877.5869308752053;1883.218464337312;1978.7229787829715;1995.8004199580216;902.3322741171617;959.5586030426082;981.8904637759287;1013.6148263659762;1052.7894421115807;19173.520661983282;20482.487937801674;20580.79419205789;20618.79381206169;20940.79059209419;965.0397854135181;979.6228452046014;983.149575617086;1028.1260928211111;1039.3867618105355;10393.48032598367;11330.112657651422;11384.146189035855;11409.201355905006;11501.482433290523;487841;488502;502791;527847;540416;97496;97888.51055744819;99082.50458747661;99529.50235248778;99934.5003274979;984.3798407003685;986.5215370545279;995.9900400996042;1007.5667462990838;1014.4268488304084;17681.557961051076;17704.82295177083;18390;18478.260869565067;18677;39030.26788124804;40593.797031014656;41679;44087.77956110199;45737.542624573325;55344;61819.690901545204;62218.68890655518;62737;63231;8691.130886911258;8935.240504557185;9064.818703625759;9215.308851836273;9248.768780780534;10289.43408112561;13821.378037988516;13929.512467063603;14556.272186390426;14650.413983440543;12534;12772.936135319263;12829.10196286251;12861.678458038625;12945.417456214305;12519.998400127786;12733.363331833187;12809.359532023547;12879.35603219854;12973.610791676265;12543.749125017632;12905;13063.346832658519;13164.078514504276;13361.53234636783;8884.555772211233;8894.155055269739;8919.687810926587;8959.507227102571;9125.498097604695;9370.859437108586;12115;12767.106302559103;12792.296423696785;12807.103502754717 23:02:56 INFO - PROCESS | 1079 | |3;mootools.html;1464.8242210934689;1480.555833250025;1651.314704397675;1794.910254487277;1795.2908601102565;8157.91842081579;8794.252488538483;8897.466152030882;9434.481103539303;9442.81114377712;8893.777655558615;9153.267738580915;9181.449113053204;9208.263338932886;9250.444973301606;2387.355414038213;2440.121556239761;2440.9633855492184;2443.450223699671;2444.0712529238863;2394.497155597318;2404.0504000919627;2420.673209116764;2445.021991203515;2466.025919761693;2371.1700904683307;2405.458771776354;2422.0675040109595;2435.695538057743;2441.9389515262083;2325.9069637214493;2341.976580234193;2344.402177444749;2346.636271377939;2358.575456417844;2327.627579587275;2333;2337.1586228957563;2348.5420343033115;2359.5988681924114;9318.90681093194;9318.953405232998;9355.719328420158;9362.953185234099;9382.718518444457;5400;5521.4478552144865;5535.142052981794;5555.555555555546;5570.2480165177585;3379.5437615921783;3393;3457.9654203457894;3459.429194182957;3477.4783782432582;1133.6032388663984;1165.877582853805;1170.6839153428612;1178.059876432845;1185.7569198314325;13030.348482575833;13093.738125237442;13141.540046098437;13182.406791694397;13188.274644894527;4621.630269578425;4661.324108004321;4812.470628230892;4823.734694591761;4938.25926111079;10760.784784304271;10826.350418974887;10827.458627068772;10838.512266947848;10854.945725271324;5592.384837667853;5612.85967850807;5613.887722245614;5614.747336369873;5616.887662246732;4417.977910110429;4970.652054356233;5128.435872054071;5130.615203859726;5131.204663277198;4101.733387329814;4109.239790638741;4141.81361838718;4143.56492568276;4161.459010328698;1299.3048718935324;1311.1477539599146;1314.3165553912104;1338.136901698399;1341.8594194934424;893.6559424621438;1019.5870672377699;1020.9846852297221;1028.4806172882647;1034.9185101568878;6536.248331441945;6553.967230163818;6568.277489476154;6608.107905432801;6668.466522678174;481.44152782772517;482.9492903245179;483.73878105823167;493.03857477918206;499.31344401448007;4569.497355290915;4641.95358046422;4654.534546545387;4658.34783130362;4660.6970546914345;10959.342439453658;11198.328100314007;11409.942950285196;11514.078873690085;11527.193096483166;11660.30038197711;11675.532978680758;11717.941410292893;11735.41322933867;11736.413179340998;8421;8658.74023779275;8674.696385626472;8685.913140868637;8697.652093916426;6354.586951848115;6461.418472337512;6618.238902526271;6747.257801641914;6809.93190068093;10462.738431539272;10744.785104298027;10835.458227088771;10885.836712449478;10893.618723344645;10894.128469722245;10924.071453926505;10980.670579882617;11026.503807328529;11178.944105279421;7388;7609.467337286337;7787.143414224544;7860.213978602094;7952.522848629101;9051.95474022652;9072.727818165466;9111.271098312252;9151.267898568232;9195.448273103635;7883.84232315339;8025.799355016171;8149.062857771432;8261.83476330482;8410.873836892573;7906.446548741533;8001.399895008014;8085.716999904975;8260.710875119343;8265.710700125466;7348.595827229554;7419.962900185465;7455.179930207564;7505.512141710771;7515.774526764206;5611.186377975089;5625.887482250414;5644;5658.292713410824;5740.6268592541355;5517.36550296721;5546.585620666704;5576.079946808731;5604.243427137284;5639.746211420578 23:02:56 INFO - PROCESS | 1079 | |4;prototype.html;335.5202061052694;337.72644158231833;340.9113630456081;344.81207741780725;347.4857211327237;5706.144078388239;5742.511886489653;5771.192033115362;5788.160716696087;5794.362620111795;5679.517241034507;5704.429557044294;5710.514606258473;5712.685802280873;5717.885642287162;4222.9577704222875;4275.935860962088;4372.868813935587;4384.473863136428;4418.911621767563;4385.364122202279;4388.97805510972;4389.617270559779;4434.224010798098;4444.866654000385;4398.8020539075815;4400.6259467945265;4416.470023597173;4419.823207071713;4421.159979603865;4314.762688052156;4353.3469979503325;4359.302511598129;4379.605835474791;4385.978070109645;3852.8844134676006;3859.36320507116;3875.8255878485534;3875.9806200969097;3889.9611003890163;5410.864728381783;5464.863378415532;5484.149956756709;5511.559075273968;5516.641418307838;4894.2903279024695;5032;5059.569936555397;5070.416902056274;5077.365329333833;5913.3094442029205;5935.673537955411;5943.257092863392;5959.40405959405;5998.910016349758;4273.465816772903;4316.848910288156;4319.200947824663;4319.358643715399;4320.4599425071865;5954.434328738763;6097.237845269341;6135.036788227769;6157.568970172089;6186.907196392012;4308.246056940023;4314.590113939171;4320.179165958458;4322.5677432256525;4326.048269380794;4359.891002724894;4369.60673539383;4371.540988196257;4384.956150438518;4388.253996820548;4900.852974410774;5039.823606173766;5051.646384753032;5057.7724002419245;5082.593392528589;5955.880882382415;5968.850778730566;6007.549433792483;6021.789237376671;6041.124037014608;1489.1660670024821;1536.7464368379315;1550.3178601415566;1551.8593833532345;1559.1035154786043;994.1897353656747;998.1864780204111;1009.8030883977701;1035.6012935019921;1068.9732756681144;5697.487226149584;5698.3162020556965;5736;5744.994625940443;5785.71071446426;6081.422264884829;6092.878142437126;6125.9892117800955;6178.783742569079;6190.535709821781;5610.719464026783;5643.209950606918;5715.48560629537;5775.797847075332;5776.826695199151;3287.704106630367;3287.868485260563;3302.719268862126;3309.867605295761;3316.5025246212776;6006;6247.687615619201;6261.7182226799905;6282.4974002080635;6372.808815735535;6114.807612515517;6214.875702485925;6224.346443623445;6249.468795152463;6252.843678908063;5975.7609695612555;6174.166487524217;6200.751969921243;6272.717727702173;6290.905636415458;6078.696065196811;6084.574079814548;6099.817005489843;6104.20645316106;6136.7852125175405;6036.336003039574;6039.78860739872;6069.2716873975405;6089.564174330126;6109.144719739151;6123.835791661712;6265.56141070139;6415.3263907289065;6427.742890284523;6453.741850325934;4353.912921741484;4387.254166791589;4393.978030109829;4398.47218333802;4413.933790993074;6104.298005729398;6166.260048794174;6239.313675495782;6290.968545157245;6301.030350878917;6032.939670603238;6037.818865434044;6039.396060393926;6046.032634778414;6078.756849725962;6043.335233124265;6049.667268300285;6051.969740151447;6056.666883321283;6072.089186622042;5629.943700562942;5798.5651076168615;5924.081767326072;5977.850553736192;6054.243219597551;6077.453029227391;6121.296050954197;6125;6148.723307451265;6149.907751383644;5752.9137062943255;5829.37450514651;5950.940490595039;5955.821325360246;5983.820485385445 23:02:56 INFO - PROCESS | 1079 | |5;yui.html;735.8859376796598;751.5716041856144;770.7687693691893;781.4412694923133;874.5627186406797;16000.679986400279;16695.91652041738;16697.081660508666;16727.33090676373;16755.66488670226;14050.735433810954;14320.355583998718;14357;14521.346539405726;14741.262936853169;795.0538858758059;798.4650284309497;815.1278132398336;818.7912082419004;820.2125959079291;812.8821320908464;819.0130892274824;824.6536454689015;825.2201669422399;828.2173346187855;857.8884744983144;859.6217664227751;866.7486428935601;867.8437881181385;868.2489646455801;842.6208206307156;850.612971098152;853.607340623311;855.5337341149088;856.9357298202659;625.0904933322006;625.777848863656;626.3048016701504;627.7332133843098;628.5317438508295;16649.33402663892;16809.91595042029;16826.83173168265;16831.158442077845;16839.32642694291;14687.485937992118;14756.483523076748;14956.551303460914;14998.47505337319;15363.231838408146;12602.81095783564;12618.369081545887;12696.238225706395;12709.491620335175;12780.04149688777;3872.4384964180035;3911.99984129818;4027.8791636250958;4053.3919912013434;4169.91660166795;87524;88873.99999999936;89074;89198;89622;11784.528618855149;11827.822582661267;11874.228175168586;11919.046476281877;12026.218295810744;21863.12547498114;21889.781102189092;21933.780662193494;21936.561268774534;22082.33752987413;8246.793830154174;8290.502569845828;8312.293455056388;8425.4944703318;8486.151384861465;4761.857144285677;4801.4958429365115;4833.637477189225;4837.984023355065;5058.721770302669;3647.507586475845;3795.7532760370486;3811.4282857571034;3832.9425058623583;3971.3645816669195;673.1131981811982;674.6592970549841;676.1683129750336;679.3444326225216;684.6131935456451;641.416311156845;766.2108028730416;780.3912947900646;803.8311954489506;805.4080251015499;10724.74577956795;10808.621698240524;10813.405262710468;10907.509162087725;11084.612038578773;637.6715991264502;675.3210745724786;684.2302409788988;737.6606760889944;745.5899255409503;5000.299958005882;5085.211792172219;5101.362329708786;5165.070287348313;5214.713190774468;126717;131584.342078289;133668.33165834303;133901;136666;113985.4300728491;114531;116869.41565292119;118416.40791795986;118695.40652296857;96179;97054;99451.00548994562;99644.50177749064;101806.49096754468;9875.55559999816;9932.155766759906;9974.750631234278;10011.399316041061;10443.895561044596;51871.74064129655;52278.47721522736;52491.21263180979;53073.95797399241;54735;75697;81903.18096818955;82306.58846705729;82690;83948;13511.459541618226;13843.238621875491;13958.37187326593;14107.224102674452;14249.64375890611;15022.699546009237;15129.219029852546;15336.309866056277;15504.767428488356;15936.36254549805;14531.200783956561;14624.174859900888;14703.41186352534;14928.925355373589;15538.766918496005;14950.626234344229;14980.700385992437;15236.238188090772;15288.694226115638;15345;13478.258695771827;14199;14755.409783608964;14795.482158124414;14905.925470372578;12101;12167.148299619295;12196.451159698012;12620.684482887635;12968.157069790434;11958.940205298917;12117.878821211674;12285.938570307091;12355.135140540076;12697.80953285683 23:02:56 INFO - PROCESS | 1079 | __end_tp_report 23:02:56 INFO - PROCESS | 1079 | __start_cc_report 23:02:56 INFO - PROCESS | 1079 | _x_x_mozilla_cycle_collect,366 23:02:56 INFO - PROCESS | 1079 | __end_cc_report 23:02:56 INFO - PROCESS | 1079 | __startTimestamp1467871376601__endTimestamp 23:02:56 INFO - PROCESS | 1079 | 23:02:56 INFO - PROCESS | 1079 | ------- Summary: start ------- 23:02:56 INFO - PROCESS | 1079 | Number of tests: 6 23:02:56 INFO - PROCESS | 1079 | 23:02:56 INFO - PROCESS | 1079 | [#0] dojo.html Cycles:165 Average:5305.06 Median:5533.42 stddev:699.92 (12.6%) stddev-sans-first:679.79 23:02:56 INFO - PROCESS | 1079 | Values: 3072.2 3103.2 3142.5 3162.6 3164.7 5297.4 5328.8 5356.6 5409.5 5427.5 5250.0 5286.6 5301.8 5337.5 5372.4 4791.6 4811.1 4901.8 4958.4 4999.3 800.9 4771.2 4794.7 4913.7 4927.2 4793.2 4805.7 4844.1 4861.5 4887.9 4846.5 4859.7 4869.4 4890.1 4912.8 4750.4 4765.5 4774.1 4819.5 4861.2 5273.6 5309.9 5315.6 5318.6 5384.7 5532.2 5721.4 5740.1 5743.8 5750.1 5679.6 5727.3 5739.2 5744.0 5772.1 5385.5 5390.0 5400.6 5415.1 5415.8 5786.7 5790.9 5814.9 5840.6 5847.4 5608.6 5682.1 5689.9 5701.2 5723.8 5768.4 5769.7 5770.7 5771.7 5774.6 5533.4 5716.3 5725.4 5762.2 5766.5 5776.6 5787.8 5792.6 5792.9 5856.2 4387.8 4409.9 4436.9 4436.9 4482.9 3842.1 3882.4 3895.3 3905.3 3995.7 5371.0 5373.5 5387.5 5390.8 5466.3 5792.3 5799.3 5801.1 5802.2 5807.9 5335.1 5463.3 5482.0 5509.4 5545.8 4982.6 5006.2 5007.8 5016.6 5044.7 5967.6 5996.0 6001.6 6005.6 6009.4 5608.3 5706.7 5776.5 5782.5 5832.6 5956.5 5965.4 5967.7 5969.5 5979.4 5495.2 5709.7 5710.4 5718.2 5721.3 5666.9 5701.8 5705.5 5734.5 5742.1 5541.4 5568.8 5606.7 5610.4 5614.4 5507.0 5522.5 5535.5 5563.8 5573.6 5479.3 5555.9 5556.1 5560.2 5580.8 5523.5 5589.4 5613.6 5657.8 5663.2 5360.7 5519.4 5528.5 5568.5 5606.8 23:02:56 INFO - PROCESS | 1079 | 23:02:56 INFO - PROCESS | 1079 | [#1] ext.html Cycles:180 Average:70769.48 Median:41578.48 stddev:171781.80 (413.2%) stddev-sans-first:172182.87 23:02:56 INFO - PROCESS | 1079 | Values: 586.2 605.9 630.7 633.4 663.7 38711.4 42261.6 42275.4 42378.2 42495.0 41785.4 42055.2 42286.8 42456.8 42512.4 8931.2 9043.0 9054.3 9075.0 9096.6 8857.2 9003.8 9021.1 9024.1 9061.7 8994.6 8995.9 9052.7 9071.7 9079.1 8957.6 9000.8 9017.3 9055.2 9073.2 8896.2 8942.3 8949.9 8963.8 8995.6 41255.2 41424.4 41632.4 41669.6 41695.8 2941.3 3373.4 3460.3 3712.3 4047.4 28739.0 29613.3 31055.0 32026.0 32183.0 4209.0 4212.3 4252.1 4307.5 4374.8 309120.0 309380.0 309745.0 310417.0 310909.0 34568.0 34686.5 34703.5 34709.3 34715.0 35347.8 36122.5 36522.6 37828.0 38229.0 17659.1 17793.2 17793.3 17928.1 17955.9 13627.5 13639.0 13699.1 13705.2 13713.1 19453.3 19691.2 19705.9 19722.3 19753.8 7000.7 7160.0 7271.7 7281.0 7395.6 897.5 985.2 994.6 1017.7 1069.0 32781.8 32950.0 33050.5 33254.5 33493.3 1110.7 1130.4 1140.8 1165.9 1201.0 16988.2 17379.0 17386.2 17433.7 17538.6 626432.0 945474.0 948602.0 963224.0 987034.0 58961.7 59027.0 59555.4 59999.7 60030.4 1368.2 1370.0 1371.8 1389.0 1393.3 31399.2 33746.2 33858.5 34075.8 34343.8 52275.5 52353.0 52456.7 52688.7 52759.7 536183.0 543200.0 543439.0 543653.0 543979.0 28345.4 28523.4 28715.9 28734.3 28750.9 47098.3 47891.5 47920.0 48170.3 49157.5 41231.6 41775.6 42164.6 42522.4 42568.8 41400.2 41458.6 41524.6 41747.0 41770.8 40592.8 40977.6 41741.8 41815.0 41836.4 28842.6 31801.7 32033.8 34537.1 34665.5 28291.7 28524.6 28590.3 28729.6 28754.4 23:02:56 INFO - PROCESS | 1079 | 23:02:56 INFO - PROCESS | 1079 | [#2] jquery.html Cycles:180 Average:30020.61 Median:19706.69 stddev:84061.69 (426.6%) stddev-sans-first:84268.05 23:02:56 INFO - PROCESS | 1079 | Values: 383.1 393.6 395.6 402.3 418.5 15750.6 18706.9 19720.7 20194.4 20243.1 19090.7 19418.0 19962.3 19975.1 20021.5 5622.7 5633.9 5796.5 5802.0 5807.7 5709.7 5739.8 5750.2 5762.9 5770.9 5526.2 5623.9 5642.5 5758.6 5775.7 5468.1 5645.0 5658.9 5659.6 5663.1 5031.3 5123.3 5137.4 5150.0 5150.4 22838.7 23076.9 23969.8 24165.5 24171.4 2363.5 2396.4 2441.5 2901.7 3149.4 14260.7 14781.0 15167.2 15201.1 15263.8 1956.5 2040.2 2047.9 2064.9 2095.2 77028.6 78301.2 78387.2 78429.2 78625.0 10832.1 11059.6 11074.8 11275.3 11380.2 12262.6 13067.5 13084.1 14373.9 14399.4 6282.1 6511.2 7358.2 7926.7 8070.8 8062.1 8178.0 8304.6 8328.0 8431.4 4151.8 4161.5 4165.5 4177.5 4198.7 1863.8 1877.6 1883.2 1978.7 1995.8 902.3 959.6 981.9 1013.6 1052.8 19173.5 20482.5 20580.8 20618.8 20940.8 965.0 979.6 983.1 1028.1 1039.4 10393.5 11330.1 11384.1 11409.2 11501.5 487841.0 488502.0 502791.0 527847.0 540416.0 97496.0 97888.5 99082.5 99529.5 99934.5 984.4 986.5 996.0 1007.6 1014.4 17681.6 17704.8 18390.0 18478.3 18677.0 39030.3 40593.8 41679.0 44087.8 45737.5 55344.0 61819.7 62218.7 62737.0 63231.0 8691.1 8935.2 9064.8 9215.3 9248.8 10289.4 13821.4 13929.5 14556.3 14650.4 12534.0 12772.9 12829.1 12861.7 12945.4 12520.0 12733.4 12809.4 12879.4 12973.6 12543.7 12905.0 13063.3 13164.1 13361.5 8884.6 8894.2 8919.7 8959.5 9125.5 9370.9 12115.0 12767.1 12792.3 12807.1 23:02:56 INFO - PROCESS | 1079 | 23:02:56 INFO - PROCESS | 1079 | [#3] mootools.html Cycles:180 Average:6121.63 Median:4661.01 stddev:3521.02 (75.5%) stddev-sans-first:3513.51 23:02:56 INFO - PROCESS | 1079 | Values: 1464.8 1480.6 1651.3 1794.9 1795.3 8157.9 8794.3 8897.5 9434.5 9442.8 8893.8 9153.3 9181.4 9208.3 9250.4 2387.4 2440.1 2441.0 2443.5 2444.1 2394.5 2404.1 2420.7 2445.0 2466.0 2371.2 2405.5 2422.1 2435.7 2441.9 2325.9 2342.0 2344.4 2346.6 2358.6 2327.6 2333.0 2337.2 2348.5 2359.6 9318.9 9319.0 9355.7 9363.0 9382.7 5400.0 5521.4 5535.1 5555.6 5570.2 3379.5 3393.0 3458.0 3459.4 3477.5 1133.6 1165.9 1170.7 1178.1 1185.8 13030.3 13093.7 13141.5 13182.4 13188.3 4621.6 4661.3 4812.5 4823.7 4938.3 10760.8 10826.4 10827.5 10838.5 10854.9 5592.4 5612.9 5613.9 5614.7 5616.9 4418.0 4970.7 5128.4 5130.6 5131.2 4101.7 4109.2 4141.8 4143.6 4161.5 1299.3 1311.1 1314.3 1338.1 1341.9 893.7 1019.6 1021.0 1028.5 1034.9 6536.2 6554.0 6568.3 6608.1 6668.5 481.4 482.9 483.7 493.0 499.3 4569.5 4642.0 4654.5 4658.3 4660.7 10959.3 11198.3 11409.9 11514.1 11527.2 11660.3 11675.5 11717.9 11735.4 11736.4 8421.0 8658.7 8674.7 8685.9 8697.7 6354.6 6461.4 6618.2 6747.3 6809.9 10462.7 10744.8 10835.5 10885.8 10893.6 10894.1 10924.1 10980.7 11026.5 11178.9 7388.0 7609.5 7787.1 7860.2 7952.5 9052.0 9072.7 9111.3 9151.3 9195.4 7883.8 8025.8 8149.1 8261.8 8410.9 7906.4 8001.4 8085.7 8260.7 8265.7 7348.6 7420.0 7455.2 7505.5 7515.8 5611.2 5625.9 5644.0 5658.3 5740.6 5517.4 5546.6 5576.1 5604.2 5639.7 23:02:56 INFO - PROCESS | 1079 | 23:02:56 INFO - PROCESS | 1079 | [#4] prototype.html Cycles:180 Average:5026.49 Median:5739.26 stddev:1484.05 (25.9%) stddev-sans-first:1445.84 23:02:56 INFO - PROCESS | 1079 | Values: 335.5 337.7 340.9 344.8 347.5 5706.1 5742.5 5771.2 5788.2 5794.4 5679.5 5704.4 5710.5 5712.7 5717.9 4223.0 4275.9 4372.9 4384.5 4418.9 4385.4 4389.0 4389.6 4434.2 4444.9 4398.8 4400.6 4416.5 4419.8 4421.2 4314.8 4353.3 4359.3 4379.6 4386.0 3852.9 3859.4 3875.8 3876.0 3890.0 5410.9 5464.9 5484.1 5511.6 5516.6 4894.3 5032.0 5059.6 5070.4 5077.4 5913.3 5935.7 5943.3 5959.4 5998.9 4273.5 4316.8 4319.2 4319.4 4320.5 5954.4 6097.2 6135.0 6157.6 6186.9 4308.2 4314.6 4320.2 4322.6 4326.0 4359.9 4369.6 4371.5 4385.0 4388.3 4900.9 5039.8 5051.6 5057.8 5082.6 5955.9 5968.9 6007.5 6021.8 6041.1 1489.2 1536.7 1550.3 1551.9 1559.1 994.2 998.2 1009.8 1035.6 1069.0 5697.5 5698.3 5736.0 5745.0 5785.7 6081.4 6092.9 6126.0 6178.8 6190.5 5610.7 5643.2 5715.5 5775.8 5776.8 3287.7 3287.9 3302.7 3309.9 3316.5 6006.0 6247.7 6261.7 6282.5 6372.8 6114.8 6214.9 6224.3 6249.5 6252.8 5975.8 6174.2 6200.8 6272.7 6290.9 6078.7 6084.6 6099.8 6104.2 6136.8 6036.3 6039.8 6069.3 6089.6 6109.1 6123.8 6265.6 6415.3 6427.7 6453.7 4353.9 4387.3 4394.0 4398.5 4413.9 6104.3 6166.3 6239.3 6291.0 6301.0 6032.9 6037.8 6039.4 6046.0 6078.8 6043.3 6049.7 6052.0 6056.7 6072.1 5629.9 5798.6 5924.1 5977.9 6054.2 6077.5 6121.3 6125.0 6148.7 6149.9 5752.9 5829.4 5950.9 5955.8 5983.8 23:02:56 INFO - PROCESS | 1079 | 23:02:56 INFO - PROCESS | 1079 | [#5] yui.html Cycles:180 Average:23125.89 Median:3822.19 stddev:34462.52 (901.6%) stddev-sans-first:34518.19 23:02:56 INFO - PROCESS | 1079 | Values: 735.9 751.6 770.8 781.4 874.6 16000.7 16695.9 16697.1 16727.3 16755.7 14050.7 14320.4 14357.0 14521.3 14741.3 795.1 798.5 815.1 818.8 820.2 812.9 819.0 824.7 825.2 828.2 857.9 859.6 866.7 867.8 868.2 842.6 850.6 853.6 855.5 856.9 625.1 625.8 626.3 627.7 628.5 16649.3 16809.9 16826.8 16831.2 16839.3 14687.5 14756.5 14956.6 14998.5 15363.2 12602.8 12618.4 12696.2 12709.5 12780.0 3872.4 3912.0 4027.9 4053.4 4169.9 87524.0 88874.0 89074.0 89198.0 89622.0 11784.5 11827.8 11874.2 11919.0 12026.2 21863.1 21889.8 21933.8 21936.6 22082.3 8246.8 8290.5 8312.3 8425.5 8486.2 4761.9 4801.5 4833.6 4838.0 5058.7 3647.5 3795.8 3811.4 3832.9 3971.4 673.1 674.7 676.2 679.3 684.6 641.4 766.2 780.4 803.8 805.4 10724.7 10808.6 10813.4 10907.5 11084.6 637.7 675.3 684.2 737.7 745.6 5000.3 5085.2 5101.4 5165.1 5214.7 126717.0 131584.3 133668.3 133901.0 136666.0 113985.4 114531.0 116869.4 118416.4 118695.4 96179.0 97054.0 99451.0 99644.5 101806.5 9875.6 9932.2 9974.8 10011.4 10443.9 51871.7 52278.5 52491.2 53074.0 54735.0 75697.0 81903.2 82306.6 82690.0 83948.0 13511.5 13843.2 13958.4 14107.2 14249.6 15022.7 15129.2 15336.3 15504.8 15936.4 14531.2 14624.2 14703.4 14928.9 15538.8 14950.6 14980.7 15236.2 15288.7 15345.0 13478.3 14199.0 14755.4 14795.5 14905.9 12101.0 12167.1 12196.5 12620.7 12968.2 11958.9 12117.9 12285.9 12355.1 12697.8 23:02:56 INFO - PROCESS | 1079 | -------- Summary: end -------- 23:02:56 INFO - PROCESS | 1079 | 23:02:57 INFO - TEST-INFO | 1079: exit 0 23:02:57 INFO - TEST-OK | dromaeo_css | took 1111134ms 23:02:57 INFO - TEST-START | kraken 23:02:57 INFO - operating with platform_type : linux_ 23:02:57 INFO - Initialising browser for kraken test... 23:02:57 INFO - TEST-INFO | started process 1403 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIUM1wO/profile http://localhost:35847/getInfo.html) 23:03:01 INFO - PROCESS | 1403 | __metrics Screen width/height:1600/1200 23:03:01 INFO - PROCESS | 1403 | colorDepth:24 23:03:01 INFO - PROCESS | 1403 | Browser inner width/height: 1024/697 23:03:01 INFO - PROCESS | 1403 | __metrics 23:03:02 ERROR - PROCESS | 1403 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 23:03:03 INFO - TEST-INFO | 1403: exit 0 23:03:03 INFO - Browser initialized. 23:03:03 INFO - Running cycle 1/1 for kraken test... 23:03:03 INFO - TEST-INFO | started process 1524 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIUM1wO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:03:15 INFO - PROCESS | 1524 | RSS: Main: 167579648 23:03:15 INFO - PROCESS | 1524 | 23:03:17 INFO - PROCESS | 1524 | Cycle 1(1): loaded http://localhost:35847/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35847/tests/kraken/driver.html?testName=audio-beat-detection) 23:03:18 INFO - PROCESS | 1524 | RSS: Main: 173273088 23:03:18 INFO - PROCESS | 1524 | 23:03:21 INFO - PROCESS | 1524 | Cycle 1(1): loaded http://localhost:35847/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35847/tests/kraken/driver.html?testName=audio-dft) 23:03:21 INFO - PROCESS | 1524 | RSS: Main: 172335104 23:03:21 INFO - PROCESS | 1524 | 23:03:24 INFO - PROCESS | 1524 | Cycle 1(1): loaded http://localhost:35847/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35847/tests/kraken/driver.html?testName=audio-fft) 23:03:25 INFO - PROCESS | 1524 | RSS: Main: 166879232 23:03:25 INFO - PROCESS | 1524 | 23:03:27 INFO - PROCESS | 1524 | Cycle 1(1): loaded http://localhost:35847/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35847/tests/kraken/driver.html?testName=audio-oscillator) 23:03:27 INFO - PROCESS | 1524 | RSS: Main: 168173568 23:03:27 INFO - PROCESS | 1524 | 23:03:30 INFO - PROCESS | 1524 | Cycle 1(1): loaded http://localhost:35847/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35847/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:03:30 INFO - PROCESS | 1524 | RSS: Main: 168321024 23:03:30 INFO - PROCESS | 1524 | 23:03:33 INFO - PROCESS | 1524 | Cycle 1(1): loaded http://localhost:35847/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35847/tests/kraken/driver.html?testName=imaging-darkroom) 23:03:34 INFO - PROCESS | 1524 | RSS: Main: 168615936 23:03:34 INFO - PROCESS | 1524 | 23:03:37 INFO - PROCESS | 1524 | Cycle 1(1): loaded http://localhost:35847/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35847/tests/kraken/driver.html?testName=imaging-desaturate) 23:03:38 INFO - PROCESS | 1524 | RSS: Main: 169082880 23:03:38 INFO - PROCESS | 1524 | 23:03:41 INFO - PROCESS | 1524 | Cycle 1(1): loaded http://localhost:35847/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35847/tests/kraken/driver.html?testName=json-parse-financial) 23:03:41 INFO - PROCESS | 1524 | RSS: Main: 169074688 23:03:41 INFO - PROCESS | 1524 | 23:03:43 INFO - PROCESS | 1524 | Cycle 1(1): loaded http://localhost:35847/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35847/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:03:44 INFO - PROCESS | 1524 | RSS: Main: 169054208 23:03:44 INFO - PROCESS | 1524 | 23:03:45 INFO - PROCESS | 1524 | Cycle 1(1): loaded http://localhost:35847/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35847/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:03:46 INFO - PROCESS | 1524 | RSS: Main: 169021440 23:03:46 INFO - PROCESS | 1524 | 23:03:48 INFO - PROCESS | 1524 | Cycle 1(1): loaded http://localhost:35847/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35847/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:03:49 INFO - PROCESS | 1524 | RSS: Main: 169283584 23:03:49 INFO - PROCESS | 1524 | 23:03:51 INFO - PROCESS | 1524 | Cycle 1(1): loaded http://localhost:35847/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35847/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:03:52 INFO - PROCESS | 1524 | RSS: Main: 169271296 23:03:52 INFO - PROCESS | 1524 | 23:03:55 INFO - PROCESS | 1524 | Cycle 1(1): loaded http://localhost:35847/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35847/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:03:55 INFO - PROCESS | 1524 | RSS: Main: 168841216 23:03:55 INFO - PROCESS | 1524 | 23:03:57 INFO - PROCESS | 1524 | Cycle 1(1): loaded http://localhost:35847/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35847/tests/kraken/driver.html?testName=ai-astar) 23:03:57 INFO - PROCESS | 1524 | RSS: Main: 169209856 23:03:57 INFO - PROCESS | 1524 | 23:03:57 INFO - PROCESS | 1524 | __start_tp_report 23:03:57 INFO - PROCESS | 1524 | _x_x_mozilla_page_load 23:03:57 INFO - PROCESS | 1524 | _x_x_mozilla_page_load_details 23:03:57 INFO - PROCESS | 1524 | |i|pagename|runs| 23:03:57 INFO - PROCESS | 1524 | |0;ai-astar;102;111;104;111;111;111;115;113;111;110 23:03:57 INFO - PROCESS | 1524 | |1;audio-beat-detection;147;118;145;168;118;148;144;125;167;116 23:03:57 INFO - PROCESS | 1524 | |2;audio-dft;161;163;162;162;163;164;167;169;163;164 23:03:57 INFO - PROCESS | 1524 | |3;audio-fft;73;75;74;160;77;75;75;76;179;74 23:03:57 INFO - PROCESS | 1524 | |4;audio-oscillator;83;85;145;85;85;85;150;85;85;151 23:03:57 INFO - PROCESS | 1524 | |5;imaging-gaussian-blur;117;117;118;118;120;120;117;117;118;118 23:03:57 INFO - PROCESS | 1524 | |6;imaging-darkroom;147;146;147;147;147;146;148;147;147;147 23:03:57 INFO - PROCESS | 1524 | |7;imaging-desaturate;95;95;96;95;95;96;96;96;96;95 23:03:57 INFO - PROCESS | 1524 | |8;json-parse-financial;53;59;62;56;62;54;58;54;54;55 23:03:57 INFO - PROCESS | 1524 | |9;json-stringify-tinderbox;63;62;61;63;63;65;62;62;62;63 23:03:57 INFO - PROCESS | 1524 | |10;stanford-crypto-aes;76;76;75;76;80;78;81;76;85;78 23:03:57 INFO - PROCESS | 1524 | |11;stanford-crypto-ccm;138;129;130;135;125;121;123;127;170;123 23:03:57 INFO - PROCESS | 1524 | |12;stanford-crypto-pbkdf2;161;158;156;159;157;158;163;158;172;154 23:03:57 INFO - PROCESS | 1524 | |13;stanford-crypto-sha256-iterative;64;63;65;62;63;63;63;63;64;62 23:03:57 INFO - PROCESS | 1524 | __end_tp_report 23:03:57 INFO - PROCESS | 1524 | __start_cc_report 23:03:57 INFO - PROCESS | 1524 | _x_x_mozilla_cycle_collect,946 23:03:57 INFO - PROCESS | 1524 | __end_cc_report 23:03:57 INFO - PROCESS | 1524 | __startTimestamp1467871437765__endTimestamp 23:03:57 INFO - PROCESS | 1524 | 23:03:57 INFO - PROCESS | 1524 | ------- Summary: start ------- 23:03:57 INFO - PROCESS | 1524 | Number of tests: 14 23:03:57 INFO - PROCESS | 1524 | 23:03:57 INFO - PROCESS | 1524 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.93 (3.5%) stddev-sans-first:2.95 23:03:57 INFO - PROCESS | 1524 | Values: 102.0 111.0 104.0 111.0 111.0 111.0 115.0 113.0 111.0 110.0 23:03:57 INFO - PROCESS | 1524 | 23:03:57 INFO - PROCESS | 1524 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:146.00 stddev:19.53 (13.4%) stddev-sans-first:20.54 23:03:57 INFO - PROCESS | 1524 | Values: 147.0 118.0 145.0 168.0 118.0 148.0 144.0 125.0 167.0 116.0 23:03:57 INFO - PROCESS | 1524 | 23:03:57 INFO - PROCESS | 1524 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:2.44 (1.5%) stddev-sans-first:2.37 23:03:57 INFO - PROCESS | 1524 | Values: 161.0 163.0 162.0 162.0 163.0 164.0 167.0 169.0 163.0 164.0 23:03:57 INFO - PROCESS | 1524 | 23:03:57 INFO - PROCESS | 1524 | [#3] audio-fft Cycles:10 Average:93.80 Median:75.00 stddev:40.16 (53.6%) stddev-sans-first:41.89 23:03:57 INFO - PROCESS | 1524 | Values: 73.0 75.0 74.0 160.0 77.0 75.0 75.0 76.0 179.0 74.0 23:03:57 INFO - PROCESS | 1524 | 23:03:57 INFO - PROCESS | 1524 | [#4] audio-oscillator Cycles:10 Average:103.90 Median:85.00 stddev:30.94 (36.4%) stddev-sans-first:31.87 23:03:57 INFO - PROCESS | 1524 | Values: 83.0 85.0 145.0 85.0 85.0 85.0 150.0 85.0 85.0 151.0 23:03:57 INFO - PROCESS | 1524 | 23:03:57 INFO - PROCESS | 1524 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.15 (1.0%) stddev-sans-first:1.17 23:03:57 INFO - PROCESS | 1524 | Values: 117.0 117.0 118.0 118.0 120.0 120.0 117.0 117.0 118.0 118.0 23:03:57 INFO - PROCESS | 1524 | 23:03:57 INFO - PROCESS | 1524 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 23:03:57 INFO - PROCESS | 1524 | Values: 147.0 146.0 147.0 147.0 147.0 146.0 148.0 147.0 147.0 147.0 23:03:57 INFO - PROCESS | 1524 | 23:03:57 INFO - PROCESS | 1524 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 23:03:57 INFO - PROCESS | 1524 | Values: 95.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 23:03:57 INFO - PROCESS | 1524 | 23:03:57 INFO - PROCESS | 1524 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:3.37 (5.9%) stddev-sans-first:3.30 23:03:57 INFO - PROCESS | 1524 | Values: 53.0 59.0 62.0 56.0 62.0 54.0 58.0 54.0 54.0 55.0 23:03:57 INFO - PROCESS | 1524 | 23:03:57 INFO - PROCESS | 1524 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:63.00 stddev:1.07 (1.7%) stddev-sans-first:1.13 23:03:57 INFO - PROCESS | 1524 | Values: 63.0 62.0 61.0 63.0 63.0 65.0 62.0 62.0 62.0 63.0 23:03:57 INFO - PROCESS | 1524 | 23:03:57 INFO - PROCESS | 1524 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:78.00 stddev:3.11 (4.0%) stddev-sans-first:3.20 23:03:57 INFO - PROCESS | 1524 | Values: 76.0 76.0 75.0 76.0 80.0 78.0 81.0 76.0 85.0 78.0 23:03:57 INFO - PROCESS | 1524 | 23:03:57 INFO - PROCESS | 1524 | [#11] stanford-crypto-ccm Cycles:10 Average:132.10 Median:129.50 stddev:14.37 (11.1%) stddev-sans-first:15.08 23:03:57 INFO - PROCESS | 1524 | Values: 138.0 129.0 130.0 135.0 125.0 121.0 123.0 127.0 170.0 123.0 23:03:57 INFO - PROCESS | 1524 | 23:03:57 INFO - PROCESS | 1524 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.60 Median:158.50 stddev:5.02 (3.2%) stddev-sans-first:5.29 23:03:57 INFO - PROCESS | 1524 | Values: 161.0 158.0 156.0 159.0 157.0 158.0 163.0 158.0 172.0 154.0 23:03:57 INFO - PROCESS | 1524 | 23:03:57 INFO - PROCESS | 1524 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:0.92 (1.5%) stddev-sans-first:0.93 23:03:57 INFO - PROCESS | 1524 | Values: 64.0 63.0 65.0 62.0 63.0 63.0 63.0 63.0 64.0 62.0 23:03:57 INFO - PROCESS | 1524 | -------- Summary: end -------- 23:03:57 INFO - PROCESS | 1524 | 23:03:58 INFO - TEST-INFO | 1524: exit 0 23:03:58 INFO - TEST-OK | kraken | took 61450ms 23:03:58 INFO - SUITE-END | took 1172s 23:03:58 INFO - Completed test suite (00:19:32) 23:03:58 INFO - javascript benchmark 23:03:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7473.129931897819, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3072.216584770884, 3103.177657920653, 3142.481490554058, 3162.604674415698, 3164.7468202543782, 5297.3908000579895, 5328.760205790739, 5356.598255130866, 5409.486098820616, 5427.538659213962, 5249.973750131254, 5286.629935904479, 5301.814436494724, 5337.492938170877, 5372.435894231098, 4791.616670666338, 4811.08589368019, 4901.803927842882, 4958.429780575226, 4999.275105109775, 800.9262021073752, 4771.165046116916, 4794.712317260975, 4913.680610760289, 4927.236278376839, 4793.161196790566, 4805.687630304019, 4844.055409195208, 4861.465238823726, 4887.902241955177, 4846.515348465161, 4859.708417494961, 4869.4156701195725, 4890.144224760653, 4912.803487860481, 4750.4299484061785, 4765.499622539653, 4774.140654682155, 4819.49395313494, 4861.197902346109, 5273.604479664041, 5309.946900530984, 5315.6013299002725, 5318.574514038867, 5384.680753215448, 5532.197831314437, 5721.39925307845, 5740.138979153118, 5743.770249190027, 5750.079987202028, 5679.602427830054, 5727.255456790632, 5739.167820666022, 5744.0, 5772.134179873011, 5385.488378604026, 5390.00284947286, 5400.567954563665, 5415.10650742631, 5415.810446634349, 5786.652800831964, 5790.884182316414, 5814.854628634233, 5840.591158618856, 5847.415258474119, 5608.551315894719, 5682.062459694187, 5689.857753556112, 5701.230333904953, 5723.828285151452, 5768.394318596571, 5769.653820770767, 5770.653760774283, 5771.740271687784, 5774.566907481955, 5533.418991005887, 5716.314042314949, 5725.370209276976, 5762.222100016528, 5766.509846662997, 5776.566757493205, 5787.8424315137145, 5792.594518383757, 5792.855178620568, 5856.209411729447, 4387.824487020547, 4409.867703968886, 4436.911261774746, 4436.933445998248, 4482.932756008662, 3842.135519508144, 3882.4176373544196, 3895.2988462076532, 3905.336092864163, 3995.6603688686787, 5371.0, 5373.516383525502, 5387.46125387466, 5390.811321603804, 5466.289382380265, 5792.304923409218, 5799.304083509922, 5801.129830525455, 5802.216700745345, 5807.912881306784, 5335.119705248668, 5463.344398672105, 5481.972590137024, 5509.393966663663, 5545.805896793673, 4982.626303027215, 5006.249062640633, 5007.824726134568, 5016.598672106223, 5044.672096313728, 5967.641941483438, 5996.0, 6001.63990160583, 6005.579609427386, 6009.36901625323, 5608.327000759935, 5706.657600543981, 5776.480116789509, 5782.537397008314, 5832.62087964281, 5956.523478121653, 5965.403459654, 5967.7016149191495, 5969.462748352669, 5979.402059793986, 5495.203195536545, 5709.714514274353, 5710.428957104256, 5718.22803921482, 5721.256236689203, 5666.858328541819, 5701.771929122789, 5705.515031222392, 5734.455226753452, 5742.138679198154, 5541.3904470509015, 5568.805091821767, 5606.747696353756, 5610.382857885547, 5614.354349249888, 5507.008738427122, 5522.530584900168, 5535.529479994246, 5563.77744890216, 5573.6098473106495, 5479.287692599936, 5555.8888822224135, 5556.083246264321, 5560.165975103605, 5580.776768929198, 5523.502884740393, 5589.413111623221, 5613.635113717595, 5657.773689052557, 5663.178839068394, 5360.65155764874, 5519.39286678473, 5528.502434780889, 5568.498835104698, 5606.775728970795], "value": 5259.679889058812, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.2173997713053, 605.9394060593941, 630.7445484578744, 633.4457349818907, 663.6980174020821, 38711.41932871006, 42261.57738422615, 42275.365869511945, 42378.152436951284, 42495.0, 41785.373219401736, 42055.158896822046, 42286.78856605721, 42456.78771606138, 42512.362314565304, 8931.240844528207, 9043.005269420359, 9054.275657947348, 9075.0, 9096.63613455461, 8857.247133993586, 9003.819923601557, 9021.097890210993, 9024.097590240955, 9061.728148155566, 8994.550272486382, 8995.865062024075, 9052.683156089539, 9071.682491112811, 9079.137481939206, 8957.596908139149, 9000.819983600324, 9017.2786177106, 9055.18503334703, 9073.228775554086, 8896.243819275369, 8942.284617230605, 8949.865752013726, 8963.775905602346, 8995.55022248885, 41255.174896502205, 41424.37863432051, 41632.37551436731, 41669.583304166874, 41695.7915210422, 2941.3234955960033, 3373.409653310661, 3460.2560449503226, 3712.313222053902, 4047.372657238133, 28739.0, 29613.259668508243, 31055.0, 32026.039218823473, 32183.0, 4209.0, 4212.262854000568, 4252.149570085995, 4307.547707490699, 4374.803133858984, 309120.0, 309380.0, 309745.0, 310417.0, 310909.0, 34568.0, 34686.47970280448, 34703.479447808306, 34709.305813884086, 34715.0, 35347.82326088353, 36122.45816312757, 36522.634773652455, 37828.0, 38229.04427389338, 17659.11704414774, 17793.19930603126, 17793.288268469376, 17928.103594820208, 17955.910220448815, 13627.454901803816, 13639.0, 13699.109557878706, 13705.177689338472, 13713.108647938052, 19453.31913383053, 19691.227789499015, 19705.916174610247, 19722.30971915976, 19753.802461975196, 7000.684969176399, 7160.014182201304, 7271.672774725044, 7281.0, 7395.593242371721, 897.4749771383683, 985.2315194148575, 994.6071301835879, 1017.7353887989176, 1069.0218450118211, 32781.83609081939, 32950.0, 33050.504242436386, 33254.50118248228, 33493.330133397685, 1110.6667999600088, 1130.4008875296106, 1140.7946569617382, 1165.8717541070475, 1200.9579664711694, 16988.235529401205, 17379.0, 17386.21762020712, 17433.738493922603, 17538.56153596145, 626432.0, 945474.0, 948602.0, 963224.0, 987034.0, 58961.70519147377, 59027.0, 59555.404445954984, 59999.70000149971, 60030.39969600248, 1368.185929372022, 1369.9726005479833, 1371.8422381426064, 1389.006860095037, 1393.2754967416886, 31399.17407433342, 33746.15634609154, 33858.49212261867, 34075.829620851735, 34343.82828085843, 52275.47724522706, 52353.0, 52456.737716311174, 52688.73655631697, 52759.736201318745, 536183.0, 543200.0, 543439.0, 543653.0, 543979.0, 28345.43309133847, 28523.42953140967, 28715.8564207186, 28734.281642959093, 28750.856245718638, 47098.293525596455, 47891.52108478871, 47920.0, 48170.27744583764, 49157.50842491529, 41231.58768412277, 41775.58224417717, 42164.578354216064, 42522.36216456694, 42568.78715606402, 41400.1719965593, 41458.58541414547, 41524.58475415328, 41747.0, 41770.791146044074, 40592.79703601463, 40977.59022409857, 41741.79129104335, 41815.0, 41836.3724544126, 28842.567361489175, 31801.6819831808, 32033.83983080163, 34537.136571585914, 34665.48001779925, 28291.71708282973, 28524.57213141846, 28590.285242869093, 28729.56905646375, 28754.424911501235], "value": 20027.28059819483, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.10544877710544, 393.56511055283903, 395.59846755543145, 402.27590337392695, 418.54796819434995, 15750.606234844134, 18706.90646546767, 19720.704189437132, 20194.39416817496, 20243.089060992235, 19090.713639295423, 19418.0, 19962.30131945382, 19975.101120449577, 20021.498387620915, 5622.718864056781, 5633.943660563393, 5796.536277097822, 5801.984652685785, 5807.651540907559, 5709.71451427429, 5739.799107031255, 5750.1949727038245, 5762.942370576283, 5770.884582308351, 5526.226328314039, 5623.9437605623825, 5642.492175704186, 5758.568107391941, 5775.711214439282, 5468.125099984023, 5644.971775141119, 5658.85852853682, 5659.575531835108, 5663.093904975205, 5031.295618613397, 5123.2827404163445, 5137.357830271216, 5150.021495915764, 5150.407703114152, 22838.657420138545, 23076.884615576982, 23969.760302397102, 24165.516689666107, 24171.395715107086, 2363.491849252419, 2396.436837343223, 2441.523902838947, 2901.7098290171025, 3149.401613693391, 14260.714785704331, 14781.0, 15167.165805880672, 15201.087934723952, 15263.847361526354, 1956.4815323939167, 2040.1941233212797, 2047.8668886522328, 2064.9483762906048, 2095.224766836265, 77028.61485692536, 78301.21698782996, 78387.21612783856, 78429.21570784276, 78625.0, 10832.133429325793, 11059.557617695364, 11074.778504429867, 11275.323480591027, 11380.203385763083, 12262.570810021607, 13067.477300908047, 13084.08411411192, 14373.928130359282, 14399.352029158714, 6282.089097080898, 6511.15355003856, 7358.1538123116525, 7926.682932682744, 8070.757877263692, 8062.113167551564, 8178.0, 8304.584770761438, 8328.04417901504, 8431.409801313972, 4151.8339266429, 4161.459010328638, 4165.541790403053, 4177.540470548237, 4198.748075115503, 1863.8136186381525, 1877.5869308752053, 1883.218464337312, 1978.7229787829715, 1995.8004199580216, 902.3322741171617, 959.5586030426082, 981.8904637759287, 1013.6148263659762, 1052.7894421115807, 19173.520661983282, 20482.487937801674, 20580.79419205789, 20618.79381206169, 20940.79059209419, 965.0397854135181, 979.6228452046014, 983.149575617086, 1028.1260928211111, 1039.3867618105355, 10393.48032598367, 11330.112657651422, 11384.146189035855, 11409.201355905006, 11501.482433290523, 487841.0, 488502.0, 502791.0, 527847.0, 540416.0, 97496.0, 97888.51055744819, 99082.50458747661, 99529.50235248778, 99934.5003274979, 984.3798407003685, 986.5215370545279, 995.9900400996042, 1007.5667462990838, 1014.4268488304084, 17681.557961051076, 17704.82295177083, 18390.0, 18478.260869565067, 18677.0, 39030.26788124804, 40593.797031014656, 41679.0, 44087.77956110199, 45737.542624573325, 55344.0, 61819.690901545204, 62218.68890655518, 62737.0, 63231.0, 8691.130886911258, 8935.240504557185, 9064.818703625759, 9215.308851836273, 9248.768780780534, 10289.43408112561, 13821.378037988516, 13929.512467063603, 14556.272186390426, 14650.413983440543, 12534.0, 12772.936135319263, 12829.10196286251, 12861.678458038625, 12945.417456214305, 12519.998400127786, 12733.363331833187, 12809.359532023547, 12879.35603219854, 12973.610791676265, 12543.749125017632, 12905.0, 13063.346832658519, 13164.078514504276, 13361.53234636783, 8884.555772211233, 8894.155055269739, 8919.687810926587, 8959.507227102571, 9125.498097604695, 9370.859437108586, 12115.0, 12767.106302559103, 12792.296423696785, 12807.103502754717], "value": 9438.590605575519, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1464.8242210934689, 1480.555833250025, 1651.314704397675, 1794.910254487277, 1795.2908601102565, 8157.91842081579, 8794.252488538483, 8897.466152030882, 9434.481103539303, 9442.81114377712, 8893.777655558615, 9153.267738580915, 9181.449113053204, 9208.263338932886, 9250.444973301606, 2387.355414038213, 2440.121556239761, 2440.9633855492184, 2443.450223699671, 2444.0712529238863, 2394.497155597318, 2404.0504000919627, 2420.673209116764, 2445.021991203515, 2466.025919761693, 2371.1700904683307, 2405.458771776354, 2422.0675040109595, 2435.695538057743, 2441.9389515262083, 2325.9069637214493, 2341.976580234193, 2344.402177444749, 2346.636271377939, 2358.575456417844, 2327.627579587275, 2333.0, 2337.1586228957563, 2348.5420343033115, 2359.5988681924114, 9318.90681093194, 9318.953405232998, 9355.719328420158, 9362.953185234099, 9382.718518444457, 5400.0, 5521.4478552144865, 5535.142052981794, 5555.555555555546, 5570.2480165177585, 3379.5437615921783, 3393.0, 3457.9654203457894, 3459.429194182957, 3477.4783782432582, 1133.6032388663984, 1165.877582853805, 1170.6839153428612, 1178.059876432845, 1185.7569198314325, 13030.348482575833, 13093.738125237442, 13141.540046098437, 13182.406791694397, 13188.274644894527, 4621.630269578425, 4661.324108004321, 4812.470628230892, 4823.734694591761, 4938.25926111079, 10760.784784304271, 10826.350418974887, 10827.458627068772, 10838.512266947848, 10854.945725271324, 5592.384837667853, 5612.85967850807, 5613.887722245614, 5614.747336369873, 5616.887662246732, 4417.977910110429, 4970.652054356233, 5128.435872054071, 5130.615203859726, 5131.204663277198, 4101.733387329814, 4109.239790638741, 4141.81361838718, 4143.56492568276, 4161.459010328698, 1299.3048718935324, 1311.1477539599146, 1314.3165553912104, 1338.136901698399, 1341.8594194934424, 893.6559424621438, 1019.5870672377699, 1020.9846852297221, 1028.4806172882647, 1034.9185101568878, 6536.248331441945, 6553.967230163818, 6568.277489476154, 6608.107905432801, 6668.466522678174, 481.44152782772517, 482.9492903245179, 483.73878105823167, 493.03857477918206, 499.31344401448007, 4569.497355290915, 4641.95358046422, 4654.534546545387, 4658.34783130362, 4660.6970546914345, 10959.342439453658, 11198.328100314007, 11409.942950285196, 11514.078873690085, 11527.193096483166, 11660.30038197711, 11675.532978680758, 11717.941410292893, 11735.41322933867, 11736.413179340998, 8421.0, 8658.74023779275, 8674.696385626472, 8685.913140868637, 8697.652093916426, 6354.586951848115, 6461.418472337512, 6618.238902526271, 6747.257801641914, 6809.93190068093, 10462.738431539272, 10744.785104298027, 10835.458227088771, 10885.836712449478, 10893.618723344645, 10894.128469722245, 10924.071453926505, 10980.670579882617, 11026.503807328529, 11178.944105279421, 7388.0, 7609.467337286337, 7787.143414224544, 7860.213978602094, 7952.522848629101, 9051.95474022652, 9072.727818165466, 9111.271098312252, 9151.267898568232, 9195.448273103635, 7883.84232315339, 8025.799355016171, 8149.062857771432, 8261.83476330482, 8410.873836892573, 7906.446548741533, 8001.399895008014, 8085.716999904975, 8260.710875119343, 8265.710700125466, 7348.595827229554, 7419.962900185465, 7455.179930207564, 7505.512141710771, 7515.774526764206, 5611.186377975089, 5625.887482250414, 5644.0, 5658.292713410824, 5740.6268592541355, 5517.36550296721, 5546.585620666704, 5576.079946808731, 5604.243427137284, 5639.746211420578], "value": 4795.730019271263, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.5202061052694, 337.72644158231833, 340.9113630456081, 344.81207741780725, 347.4857211327237, 5706.144078388239, 5742.511886489653, 5771.192033115362, 5788.160716696087, 5794.362620111795, 5679.517241034507, 5704.429557044294, 5710.514606258473, 5712.685802280873, 5717.885642287162, 4222.9577704222875, 4275.935860962088, 4372.868813935587, 4384.473863136428, 4418.911621767563, 4385.364122202279, 4388.97805510972, 4389.617270559779, 4434.224010798098, 4444.866654000385, 4398.8020539075815, 4400.6259467945265, 4416.470023597173, 4419.823207071713, 4421.159979603865, 4314.762688052156, 4353.3469979503325, 4359.302511598129, 4379.605835474791, 4385.978070109645, 3852.8844134676006, 3859.36320507116, 3875.8255878485534, 3875.9806200969097, 3889.9611003890163, 5410.864728381783, 5464.863378415532, 5484.149956756709, 5511.559075273968, 5516.641418307838, 4894.2903279024695, 5032.0, 5059.569936555397, 5070.416902056274, 5077.365329333833, 5913.3094442029205, 5935.673537955411, 5943.257092863392, 5959.40405959405, 5998.910016349758, 4273.465816772903, 4316.848910288156, 4319.200947824663, 4319.358643715399, 4320.4599425071865, 5954.434328738763, 6097.237845269341, 6135.036788227769, 6157.568970172089, 6186.907196392012, 4308.246056940023, 4314.590113939171, 4320.179165958458, 4322.5677432256525, 4326.048269380794, 4359.891002724894, 4369.60673539383, 4371.540988196257, 4384.956150438518, 4388.253996820548, 4900.852974410774, 5039.823606173766, 5051.646384753032, 5057.7724002419245, 5082.593392528589, 5955.880882382415, 5968.850778730566, 6007.549433792483, 6021.789237376671, 6041.124037014608, 1489.1660670024821, 1536.7464368379315, 1550.3178601415566, 1551.8593833532345, 1559.1035154786043, 994.1897353656747, 998.1864780204111, 1009.8030883977701, 1035.6012935019921, 1068.9732756681144, 5697.487226149584, 5698.3162020556965, 5736.0, 5744.994625940443, 5785.71071446426, 6081.422264884829, 6092.878142437126, 6125.9892117800955, 6178.783742569079, 6190.535709821781, 5610.719464026783, 5643.209950606918, 5715.48560629537, 5775.797847075332, 5776.826695199151, 3287.704106630367, 3287.868485260563, 3302.719268862126, 3309.867605295761, 3316.5025246212776, 6006.0, 6247.687615619201, 6261.7182226799905, 6282.4974002080635, 6372.808815735535, 6114.807612515517, 6214.875702485925, 6224.346443623445, 6249.468795152463, 6252.843678908063, 5975.7609695612555, 6174.166487524217, 6200.751969921243, 6272.717727702173, 6290.905636415458, 6078.696065196811, 6084.574079814548, 6099.817005489843, 6104.20645316106, 6136.7852125175405, 6036.336003039574, 6039.78860739872, 6069.2716873975405, 6089.564174330126, 6109.144719739151, 6123.835791661712, 6265.56141070139, 6415.3263907289065, 6427.742890284523, 6453.741850325934, 4353.912921741484, 4387.254166791589, 4393.978030109829, 4398.47218333802, 4413.933790993074, 6104.298005729398, 6166.260048794174, 6239.313675495782, 6290.968545157245, 6301.030350878917, 6032.939670603238, 6037.818865434044, 6039.396060393926, 6046.032634778414, 6078.756849725962, 6043.335233124265, 6049.667268300285, 6051.969740151447, 6056.666883321283, 6072.089186622042, 5629.943700562942, 5798.5651076168615, 5924.081767326072, 5977.850553736192, 6054.243219597551, 6077.453029227391, 6121.296050954197, 6125.0, 6148.723307451265, 6149.907751383644, 5752.9137062943255, 5829.37450514651, 5950.940490595039, 5955.821325360246, 5983.820485385445], "value": 4549.701059137184, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.8859376796598, 751.5716041856144, 770.7687693691893, 781.4412694923133, 874.5627186406797, 16000.679986400279, 16695.91652041738, 16697.081660508666, 16727.33090676373, 16755.66488670226, 14050.735433810954, 14320.355583998718, 14357.0, 14521.346539405726, 14741.262936853169, 795.0538858758059, 798.4650284309497, 815.1278132398336, 818.7912082419004, 820.2125959079291, 812.8821320908464, 819.0130892274824, 824.6536454689015, 825.2201669422399, 828.2173346187855, 857.8884744983144, 859.6217664227751, 866.7486428935601, 867.8437881181385, 868.2489646455801, 842.6208206307156, 850.612971098152, 853.607340623311, 855.5337341149088, 856.9357298202659, 625.0904933322006, 625.777848863656, 626.3048016701504, 627.7332133843098, 628.5317438508295, 16649.33402663892, 16809.91595042029, 16826.83173168265, 16831.158442077845, 16839.32642694291, 14687.485937992118, 14756.483523076748, 14956.551303460914, 14998.47505337319, 15363.231838408146, 12602.81095783564, 12618.369081545887, 12696.238225706395, 12709.491620335175, 12780.04149688777, 3872.4384964180035, 3911.99984129818, 4027.8791636250958, 4053.3919912013434, 4169.91660166795, 87524.0, 88873.99999999936, 89074.0, 89198.0, 89622.0, 11784.528618855149, 11827.822582661267, 11874.228175168586, 11919.046476281877, 12026.218295810744, 21863.12547498114, 21889.781102189092, 21933.780662193494, 21936.561268774534, 22082.33752987413, 8246.793830154174, 8290.502569845828, 8312.293455056388, 8425.4944703318, 8486.151384861465, 4761.857144285677, 4801.4958429365115, 4833.637477189225, 4837.984023355065, 5058.721770302669, 3647.507586475845, 3795.7532760370486, 3811.4282857571034, 3832.9425058623583, 3971.3645816669195, 673.1131981811982, 674.6592970549841, 676.1683129750336, 679.3444326225216, 684.6131935456451, 641.416311156845, 766.2108028730416, 780.3912947900646, 803.8311954489506, 805.4080251015499, 10724.74577956795, 10808.621698240524, 10813.405262710468, 10907.509162087725, 11084.612038578773, 637.6715991264502, 675.3210745724786, 684.2302409788988, 737.6606760889944, 745.5899255409503, 5000.299958005882, 5085.211792172219, 5101.362329708786, 5165.070287348313, 5214.713190774468, 126717.0, 131584.342078289, 133668.33165834303, 133901.0, 136666.0, 113985.4300728491, 114531.0, 116869.41565292119, 118416.40791795986, 118695.40652296857, 96179.0, 97054.0, 99451.00548994562, 99644.50177749064, 101806.49096754468, 9875.55559999816, 9932.155766759906, 9974.750631234278, 10011.399316041061, 10443.895561044596, 51871.74064129655, 52278.47721522736, 52491.21263180979, 53073.95797399241, 54735.0, 75697.0, 81903.18096818955, 82306.58846705729, 82690.0, 83948.0, 13511.459541618226, 13843.238621875491, 13958.37187326593, 14107.224102674452, 14249.64375890611, 15022.699546009237, 15129.219029852546, 15336.309866056277, 15504.767428488356, 15936.36254549805, 14531.200783956561, 14624.174859900888, 14703.41186352534, 14928.925355373589, 15538.766918496005, 14950.626234344229, 14980.700385992437, 15236.238188090772, 15288.694226115638, 15345.0, 13478.258695771827, 14199.0, 14755.409783608964, 14795.482158124414, 14905.925470372578, 12101.0, 12167.148299619295, 12196.451159698012, 12620.684482887635, 12968.157069790434, 11958.940205298917, 12117.878821211674, 12285.938570307091, 12355.135140540076, 12697.80953285683], "value": 8028.741712218844, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.6999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 104.0, 111.0, 111.0, 111.0, 115.0, 113.0, 111.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 118.0, 145.0, 168.0, 118.0, 148.0, 144.0, 125.0, 167.0, 116.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 162.0, 163.0, 164.0, 167.0, 169.0, 163.0, 164.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 74.0, 160.0, 77.0, 75.0, 75.0, 76.0, 179.0, 74.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 145.0, 85.0, 85.0, 85.0, 150.0, 85.0, 85.0, 151.0], "value": 103.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 120.0, 120.0, 117.0, 117.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 148.0, 147.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 59.0, 62.0, 56.0, 62.0, 54.0, 58.0, 54.0, 54.0, 55.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 63.0, 63.0, 65.0, 62.0, 62.0, 62.0, 63.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 76.0, 80.0, 78.0, 81.0, 76.0, 85.0, 78.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 129.0, 130.0, 135.0, 125.0, 121.0, 123.0, 127.0, 170.0, 123.0], "value": 132.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 158.0, 156.0, 159.0, 157.0, 158.0, 163.0, 158.0, 172.0, 154.0], "value": 159.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 62.0, 63.0, 63.0, 63.0, 63.0, 64.0, 62.0], "value": 63.2, "unit": "score"}]}]} 23:03:58 INFO - Return code: 0 23:03:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:03:59 ERROR - # TBPL SUCCESS # 23:03:59 INFO - Running post-action listener: _resource_record_post_action 23:03:59 INFO - ##### 23:03:59 INFO - ##### Finished run-tests step (success) 23:03:59 INFO - ##### 23:03:59 INFO - Running post-run listener: _resource_record_post_run 23:03:59 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 569409536; Read time: 12; Write time: 453920 23:03:59 INFO - TinderboxPrint: CPU usage
13.3% 23:03:59 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 23:03:59 INFO - TinderboxPrint: I/O write bytes / time
569,409,536 / 453,920 23:03:59 INFO - TinderboxPrint: CPU idle
8,230.6 (86.7%) 23:03:59 INFO - TinderboxPrint: CPU user
1,211.2 (12.8%) 23:03:59 INFO - TinderboxPrint: Swap in / out
0 / 0 23:03:59 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 272351232; Read time: 0; Write time: 259080 23:03:59 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 297058304; Read time: 0; Write time: 194840 23:03:59 INFO - Running post-run listener: _upload_blobber_files 23:03:59 INFO - Blob upload gear active. 23:03:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:03:59 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 23:03:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:04:00 INFO - (blobuploader) - INFO - Open directory for files ... 23:04:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:04:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:04:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:04:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:04:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:04:03 INFO - (blobuploader) - INFO - Done attempting. 23:04:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:04:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:04:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:04:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:04:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:04:04 INFO - (blobuploader) - INFO - Done attempting. 23:04:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:04:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:04:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:04:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:04:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:04:05 INFO - (blobuploader) - INFO - Done attempting. 23:04:05 INFO - (blobuploader) - INFO - Iteration through files over. 23:04:05 INFO - Return code: 0 23:04:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:04:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:04:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f21c405d528a46ede029ee68fe203e97e8290c5dea99c241c4b4e061f6ec4d494a7bd300693edd6f545c53bc3aac519456fc65d9361d17857715fc842dea108a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c237af1c5d1afa76116551ac99a3e0a7af6fca48b374001990a7705c3a9025973a327b109f80f9f96be1f30789ec6d92897d011879e19b37106c3c3b2c363c28", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa54e5c74e6ad4af3c9096a852e9d0a07203897b1d2dd668e266438d72a34b82de757344932c12d79378350240ca90e5175b2df8b8f805efda8e09ae75155857"} 23:04:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:04:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:04:05 INFO - Contents: 23:04:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f21c405d528a46ede029ee68fe203e97e8290c5dea99c241c4b4e061f6ec4d494a7bd300693edd6f545c53bc3aac519456fc65d9361d17857715fc842dea108a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c237af1c5d1afa76116551ac99a3e0a7af6fca48b374001990a7705c3a9025973a327b109f80f9f96be1f30789ec6d92897d011879e19b37106c3c3b2c363c28", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa54e5c74e6ad4af3c9096a852e9d0a07203897b1d2dd668e266438d72a34b82de757344932c12d79378350240ca90e5175b2df8b8f805efda8e09ae75155857"} 23:04:05 INFO - Running post-run listener: copy_logs_to_upload_dir 23:04:05 INFO - Copying logs to upload dir... 23:04:05 INFO - mkdir: /builds/slave/test/build/upload/logs 23:04:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.974457 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-06 23:04:05.400191) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 23:04:05.403427) ========= 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=1f5564757af27664ca02d71f000001b0-1467870121.805140-365441519 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/sha512/f21c405d528a46ede029ee68fe203e97e8290c5dea99c241c4b4e061f6ec4d494a7bd300693edd6f545c53bc3aac519456fc65d9361d17857715fc842dea108a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c237af1c5d1afa76116551ac99a3e0a7af6fca48b374001990a7705c3a9025973a327b109f80f9f96be1f30789ec6d92897d011879e19b37106c3c3b2c363c28", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa54e5c74e6ad4af3c9096a852e9d0a07203897b1d2dd668e266438d72a34b82de757344932c12d79378350240ca90e5175b2df8b8f805efda8e09ae75155857"} build_url:https://queue.taskcluster.net/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011437 build_url: 'https://queue.taskcluster.net/v1/task/UYqJXCT7SV6SNuNIZWl8JQ/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/sha512/f21c405d528a46ede029ee68fe203e97e8290c5dea99c241c4b4e061f6ec4d494a7bd300693edd6f545c53bc3aac519456fc65d9361d17857715fc842dea108a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c237af1c5d1afa76116551ac99a3e0a7af6fca48b374001990a7705c3a9025973a327b109f80f9f96be1f30789ec6d92897d011879e19b37106c3c3b2c363c28", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa54e5c74e6ad4af3c9096a852e9d0a07203897b1d2dd668e266438d72a34b82de757344932c12d79378350240ca90e5175b2df8b8f805efda8e09ae75155857"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 23:04:05.428780) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:04:05.429099) ========= 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=1f5564757af27664ca02d71f000001b0-1467870121.805140-365441519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004435 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:04:05.480276) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 23:04:05.480546) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 23:04:05.480794) ========= ========= Total master_lag: 0.13 =========