builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-060 starttime: 1468327529.68 results: success (0) buildid: 20160712030234 builduid: 712932614c3d4777a852252f0fb4b1bf revision: aac8ff1024c553d9c92b85b8b6ba90f65de2ed08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 05:45:29.676738) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 05:45:29.677273) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 05:45:29.677597) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 05:45:29.693472) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 05:45:29.694212) ========= 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=337fe3f4b1febe37b85fccc40000019e-1468327528.630281-599773880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 05:45:30-- 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% 32.6M=0s 2016-07-12 05:45:30 (32.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.073888 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 05:45:29.784195) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 05:45:29.784582) ========= 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=337fe3f4b1febe37b85fccc40000019e-1468327528.630281-599773880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017358 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 05:45:29.836799) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 05:45:29.837574) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev aac8ff1024c553d9c92b85b8b6ba90f65de2ed08 --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 aac8ff1024c553d9c92b85b8b6ba90f65de2ed08 --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=337fe3f4b1febe37b85fccc40000019e-1468327528.630281-599773880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 05:45:30,422 truncating revision to first 12 chars 2016-07-12 05:45:30,422 Setting DEBUG logging. 2016-07-12 05:45:30,422 attempt 1/10 2016-07-12 05:45:30,422 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/aac8ff1024c5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 05:45:30,751 unpacking tar archive at: mozilla-central-aac8ff1024c5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.681393 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 05:45:30.534028) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 05:45:30.534402) ========= script_repo_revision: aac8ff1024c553d9c92b85b8b6ba90f65de2ed08 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 05:45:30.534877) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 05:45:30.535192) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 05:45:30.545946) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-12 05:45:30.546290) ========= /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=337fe3f4b1febe37b85fccc40000019e-1468327528.630281-599773880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:45:31 INFO - MultiFileLogger online at 20160712 05:45:31 in /builds/slave/test 05:45:31 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 05:45:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:45:31 INFO - {'append_to_log': False, 05:45:31 INFO - 'base_work_dir': '/builds/slave/test', 05:45:31 INFO - 'blob_upload_branch': 'Firefox', 05:45:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:45:31 INFO - 'branch': 'Firefox', 05:45:31 INFO - 'buildbot_json_path': 'buildprops.json', 05:45:31 INFO - 'config_files': ('talos/linux_config.py',), 05:45:31 INFO - 'default_actions': ('clobber', 05:45:31 INFO - 'read-buildbot-config', 05:45:31 INFO - 'download-and-extract', 05:45:31 INFO - 'populate-webroot', 05:45:31 INFO - 'create-virtualenv', 05:45:31 INFO - 'install', 05:45:31 INFO - 'run-tests'), 05:45:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:45:31 INFO - 'download_minidump_stackwalk': True, 05:45:31 INFO - 'download_symbols': 'ondemand', 05:45:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:45:31 INFO - 'tooltool.py': '/tools/tooltool.py', 05:45:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:45:31 INFO - '/tools/misc-python/virtualenv.py')}, 05:45:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:45:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:45:31 INFO - 'installer_path': 'installer.exe', 05:45:31 INFO - 'log_level': 'info', 05:45:31 INFO - 'log_name': 'talos', 05:45:31 INFO - 'log_to_console': True, 05:45:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:45:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:45:31 INFO - 'opt_config_files': (), 05:45:31 INFO - 'pip_index': False, 05:45:31 INFO - 'sps_profile': False, 05:45:31 INFO - 'sps_profile_interval': 0, 05:45:31 INFO - 'suite': 'dromaeojs-e10s', 05:45:31 INFO - 'system_bits': '32', 05:45:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:45:31 INFO - 'title': 'talos-linux64-ix-060', 05:45:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:45:31 INFO - 'use_talos_json': True, 05:45:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:45:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:45:31 INFO - 'work_dir': 'build'} 05:45:31 INFO - ##### 05:45:31 INFO - ##### Running clobber step. 05:45:31 INFO - ##### 05:45:31 INFO - Running pre-action listener: _resource_record_pre_action 05:45:31 INFO - Running main action method: clobber 05:45:31 INFO - rmtree: /builds/slave/test/build 05:45:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:45:31 INFO - Running post-action listener: _resource_record_post_action 05:45:31 INFO - ##### 05:45:31 INFO - ##### Finished clobber step (success) 05:45:31 INFO - ##### 05:45:31 INFO - ##### 05:45:31 INFO - ##### Running read-buildbot-config step. 05:45:31 INFO - ##### 05:45:31 INFO - Running pre-action listener: _resource_record_pre_action 05:45:31 INFO - Running main action method: read_buildbot_config 05:45:31 INFO - Using buildbot properties: 05:45:31 INFO - { 05:45:31 INFO - "project": "", 05:45:31 INFO - "product": "firefox", 05:45:31 INFO - "script_repo_revision": "production", 05:45:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:45:31 INFO - "repository": "", 05:45:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:45:31 INFO - "buildid": "20160712030234", 05:45:31 INFO - "stage_platform": "linux64-pgo", 05:45:31 INFO - "basedir": "/builds/slave/test", 05:45:31 INFO - "nightly_build": "True", 05:45:31 INFO - "buildnumber": 86, 05:45:31 INFO - "slavename": "talos-linux64-ix-060", 05:45:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:45:31 INFO - "platform": "ubuntu64_hw", 05:45:31 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:45:31 INFO - "branch": "mozilla-central", 05:45:31 INFO - "repo_path": "mozilla-central", 05:45:31 INFO - "revision": "aac8ff1024c553d9c92b85b8b6ba90f65de2ed08", 05:45:31 INFO - "pgo_build": "True", 05:45:31 INFO - "builduid": "712932614c3d4777a852252f0fb4b1bf", 05:45:31 INFO - "slavebuilddir": "test" 05:45:31 INFO - } 05:45:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:45:31 INFO - Running post-action listener: _resource_record_post_action 05:45:31 INFO - ##### 05:45:31 INFO - ##### Finished read-buildbot-config step (success) 05:45:31 INFO - ##### 05:45:31 INFO - ##### 05:45:31 INFO - ##### Running download-and-extract step. 05:45:31 INFO - ##### 05:45:31 INFO - Running pre-action listener: _resource_record_pre_action 05:45:31 INFO - Running main action method: download_and_extract 05:45:31 INFO - mkdir: /builds/slave/test/build/tests 05:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:31 INFO - https://queue.taskcluster.net/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:45:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:45:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:45:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:45:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:45:32 INFO - Downloaded 1361 bytes. 05:45:32 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:45:32 INFO - Using the following test package requirements: 05:45:32 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:45:32 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:45:32 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:45:32 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:32 INFO - u'jsshell-linux-x86_64.zip'], 05:45:32 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:45:32 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:45:32 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:45:32 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:45:32 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:45:32 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:45:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:32 INFO - https://queue.taskcluster.net/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:45:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:45:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:45:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:45:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:45:33 INFO - Downloaded 24270856 bytes. 05:45:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:45:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:45:34 INFO - Return code: 0 05:45:34 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:34 INFO - https://queue.taskcluster.net/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:45:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:45:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:45:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:45:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:45:36 INFO - Downloaded 24270856 bytes. 05:45:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:45:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:45:38 INFO - Return code: 0 05:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:38 INFO - https://queue.taskcluster.net/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:45:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:45:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:45:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:45:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:45:40 INFO - Downloaded 14403317 bytes. 05:45:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:45:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:45:40 INFO - Return code: 0 05:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:40 INFO - https://queue.taskcluster.net/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:45:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:45:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:45:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:45:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:45:41 INFO - Downloaded 60498656 bytes. 05:45:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:45:41 INFO - mkdir: /builds/slave/test/properties 05:45:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:45:41 INFO - Writing to file /builds/slave/test/properties/build_url 05:45:41 INFO - Contents: 05:45:41 INFO - build_url:https://queue.taskcluster.net/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:45:42 INFO - Running post-action listener: _resource_record_post_action 05:45:42 INFO - Running post-action listener: set_extra_try_arguments 05:45:42 INFO - ##### 05:45:42 INFO - ##### Finished download-and-extract step (success) 05:45:42 INFO - ##### 05:45:42 INFO - ##### 05:45:42 INFO - ##### Running populate-webroot step. 05:45:42 INFO - ##### 05:45:42 INFO - Running pre-action listener: _resource_record_pre_action 05:45:42 INFO - Running main action method: populate_webroot 05:45:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:45:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:45:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:45:42 INFO - '--tppagecycles', 05:45:42 INFO - '7'], 05:45:42 INFO - 'tests': ['tsvgm']}}, 05:45:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:45:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:45:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:45:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:45:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:45:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:45:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:42 INFO - 'talos_options': ['--disable-e10s'], 05:45:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:42 INFO - 'talos_options': ['--disable-e10s'], 05:45:42 INFO - 'tests': ['damp', 'tps']}, 05:45:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:42 INFO - 'tests': ['damp', 'tps']}, 05:45:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:45:42 INFO - 'tests': ['dromaeo_dom']}, 05:45:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:45:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:45:42 INFO - 'tests': ['basic_compositor_video']}, 05:45:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:45:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:45:42 INFO - 'tests': ['a11yr', 05:45:42 INFO - 'ts_paint', 05:45:42 INFO - 'tpaint', 05:45:42 INFO - 'sessionrestore', 05:45:42 INFO - 'sessionrestore_no_auto_restore', 05:45:42 INFO - 'tabpaint']}, 05:45:42 INFO - 'other-e10s': {'tests': ['a11yr', 05:45:42 INFO - 'ts_paint', 05:45:42 INFO - 'tpaint', 05:45:42 INFO - 'sessionrestore', 05:45:42 INFO - 'sessionrestore_no_auto_restore', 05:45:42 INFO - 'tabpaint']}, 05:45:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:45:42 INFO - 'ts_paint', 05:45:42 INFO - 'tpaint', 05:45:42 INFO - 'sessionrestore', 05:45:42 INFO - 'sessionrestore_no_auto_restore', 05:45:42 INFO - 'tabpaint']}, 05:45:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:45:42 INFO - 'ts_paint', 05:45:42 INFO - 'tpaint', 05:45:42 INFO - 'sessionrestore', 05:45:42 INFO - 'sessionrestore_no_auto_restore', 05:45:42 INFO - 'tabpaint']}, 05:45:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:45:42 INFO - 'tests': ['a11yr', 05:45:42 INFO - 'ts_paint', 05:45:42 INFO - 'tpaint', 05:45:42 INFO - 'sessionrestore', 05:45:42 INFO - 'sessionrestore_no_auto_restore', 05:45:42 INFO - 'tabpaint']}, 05:45:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:45:42 INFO - 'tests': ['a11yr', 05:45:42 INFO - 'ts_paint', 05:45:42 INFO - 'tpaint', 05:45:42 INFO - 'sessionrestore', 05:45:42 INFO - 'sessionrestore_no_auto_restore', 05:45:42 INFO - 'tabpaint']}, 05:45:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:45:42 INFO - 'tests': ['tsvgx', 05:45:42 INFO - 'tsvgr_opacity', 05:45:42 INFO - 'tart', 05:45:42 INFO - 'tscrollx', 05:45:42 INFO - 'cart']}, 05:45:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:45:42 INFO - 'tsvgr_opacity', 05:45:42 INFO - 'tart', 05:45:42 INFO - 'tscrollx', 05:45:42 INFO - 'cart']}, 05:45:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:42 INFO - 'talos_options': ['--disable-e10s'], 05:45:42 INFO - 'tests': ['tp5o']}, 05:45:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:42 INFO - 'tests': ['tp5o']}, 05:45:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:42 INFO - 'talos_options': ['--disable-e10s', 05:45:42 INFO - '--xperf_path', 05:45:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:42 INFO - 'tests': ['tp5n']}, 05:45:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:42 INFO - 'talos_options': ['--xperf_path', 05:45:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:42 INFO - 'tests': ['tp5n']}}, 05:45:42 INFO - 'talos.zip': {'path': '', 05:45:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:45:42 INFO - Running post-action listener: _resource_record_post_action 05:45:42 INFO - ##### 05:45:42 INFO - ##### Finished populate-webroot step (success) 05:45:42 INFO - ##### 05:45:42 INFO - ##### 05:45:42 INFO - ##### Running create-virtualenv step. 05:45:42 INFO - ##### 05:45:42 INFO - Running pre-action listener: _resource_record_pre_action 05:45:42 INFO - Running main action method: create_virtualenv 05:45:42 INFO - Creating virtualenv /builds/slave/test/build/venv 05:45:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:45:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:45:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:45:42 INFO - Using real prefix '/usr' 05:45:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:45:43 INFO - Installing distribute.............................................................................................................................................................................................done. 05:45:45 INFO - Installing pip.................done. 05:45:45 INFO - Return code: 0 05:45:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:45:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17883b0>, '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 0x17892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1789740>, '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': '337fe3f4b1febe37b85fccc40000019e-1468327528.630281-599773880', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:45:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:45:45 INFO - Using env: {'DISPLAY': ':0', 05:45:45 INFO - 'HOME': '/home/cltbld', 05:45:45 INFO - 'LANG': 'en_US.UTF-8', 05:45:45 INFO - 'LANGUAGE': 'en_US:en', 05:45:45 INFO - 'LOGNAME': 'cltbld', 05:45:45 INFO - 'MAIL': '/var/mail/cltbld', 05:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:45 INFO - 'MOZ_NO_REMOTE': '1', 05:45:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:45 INFO - 'NO_EM_RESTART': '1', 05:45:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:45 INFO - 'PWD': '/builds/slave/test', 05:45:45 INFO - 'SHELL': '/bin/bash', 05:45:45 INFO - 'SHLVL': '1', 05:45:45 INFO - 'TERM': 'linux', 05:45:45 INFO - 'TMOUT': '86400', 05:45:45 INFO - 'USER': 'cltbld', 05:45:45 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1468327528.630281-599773880', 05:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:45 INFO - '_': '/tools/buildbot/bin/python'} 05:45:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:45:45 INFO - Cleaning up... 05:45:45 INFO - Return code: 0 05:45:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:45:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x14c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17883b0>, '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 0x17892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1789740>, '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': '337fe3f4b1febe37b85fccc40000019e-1468327528.630281-599773880', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:45:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:45:45 INFO - Using env: {'DISPLAY': ':0', 05:45:45 INFO - 'HOME': '/home/cltbld', 05:45:45 INFO - 'LANG': 'en_US.UTF-8', 05:45:45 INFO - 'LANGUAGE': 'en_US:en', 05:45:45 INFO - 'LOGNAME': 'cltbld', 05:45:45 INFO - 'MAIL': '/var/mail/cltbld', 05:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:45 INFO - 'MOZ_NO_REMOTE': '1', 05:45:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:45 INFO - 'NO_EM_RESTART': '1', 05:45:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:45 INFO - 'PWD': '/builds/slave/test', 05:45:45 INFO - 'SHELL': '/bin/bash', 05:45:45 INFO - 'SHLVL': '1', 05:45:45 INFO - 'TERM': 'linux', 05:45:45 INFO - 'TMOUT': '86400', 05:45:45 INFO - 'USER': 'cltbld', 05:45:45 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1468327528.630281-599773880', 05:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:45 INFO - '_': '/tools/buildbot/bin/python'} 05:45:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:45 INFO - Downloading/unpacking psutil>=3.1.1 05:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:45:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:47 INFO - Installing collected packages: psutil 05:45:47 INFO - Running setup.py install for psutil 05:45:47 INFO - building 'psutil._psutil_linux' extension 05:45:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:45:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:45:47 INFO - building 'psutil._psutil_posix' extension 05:45:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:45:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:45:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:47 INFO - Successfully installed psutil 05:45:47 INFO - Cleaning up... 05:45:48 INFO - Return code: 0 05:45:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:45:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17883b0>, '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 0x17892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1789740>, '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': '337fe3f4b1febe37b85fccc40000019e-1468327528.630281-599773880', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:45:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:45:48 INFO - Using env: {'DISPLAY': ':0', 05:45:48 INFO - 'HOME': '/home/cltbld', 05:45:48 INFO - 'LANG': 'en_US.UTF-8', 05:45:48 INFO - 'LANGUAGE': 'en_US:en', 05:45:48 INFO - 'LOGNAME': 'cltbld', 05:45:48 INFO - 'MAIL': '/var/mail/cltbld', 05:45:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:48 INFO - 'MOZ_NO_REMOTE': '1', 05:45:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:48 INFO - 'NO_EM_RESTART': '1', 05:45:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:48 INFO - 'PWD': '/builds/slave/test', 05:45:48 INFO - 'SHELL': '/bin/bash', 05:45:48 INFO - 'SHLVL': '1', 05:45:48 INFO - 'TERM': 'linux', 05:45:48 INFO - 'TMOUT': '86400', 05:45:48 INFO - 'USER': 'cltbld', 05:45:48 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1468327528.630281-599773880', 05:45:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:48 INFO - '_': '/tools/buildbot/bin/python'} 05:45:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:45:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:45:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:45:50 INFO - Installing collected packages: mozsystemmonitor 05:45:50 INFO - Running setup.py install for mozsystemmonitor 05:45:50 INFO - Successfully installed mozsystemmonitor 05:45:50 INFO - Cleaning up... 05:45:50 INFO - Return code: 0 05:45:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:45:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x14c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17883b0>, '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 0x17892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1789740>, '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': '337fe3f4b1febe37b85fccc40000019e-1468327528.630281-599773880', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:45:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:45:50 INFO - Using env: {'DISPLAY': ':0', 05:45:50 INFO - 'HOME': '/home/cltbld', 05:45:50 INFO - 'LANG': 'en_US.UTF-8', 05:45:50 INFO - 'LANGUAGE': 'en_US:en', 05:45:50 INFO - 'LOGNAME': 'cltbld', 05:45:50 INFO - 'MAIL': '/var/mail/cltbld', 05:45:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:50 INFO - 'MOZ_NO_REMOTE': '1', 05:45:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:50 INFO - 'NO_EM_RESTART': '1', 05:45:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:50 INFO - 'PWD': '/builds/slave/test', 05:45:50 INFO - 'SHELL': '/bin/bash', 05:45:50 INFO - 'SHLVL': '1', 05:45:50 INFO - 'TERM': 'linux', 05:45:50 INFO - 'TMOUT': '86400', 05:45:50 INFO - 'USER': 'cltbld', 05:45:50 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1468327528.630281-599773880', 05:45:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:50 INFO - '_': '/tools/buildbot/bin/python'} 05:45:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:50 INFO - Downloading/unpacking jsonschema==2.5.1 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:45:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:54 INFO - Downloading functools32-3.2.3-2.tar.gz 05:45:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:45:54 INFO - warning: no files found matching '*.txt' 05:45:54 INFO - no previously-included directories found matching 'build' 05:45:54 INFO - no previously-included directories found matching 'dist' 05:45:54 INFO - no previously-included directories found matching '.git*' 05:45:54 INFO - Installing collected packages: jsonschema, functools32 05:45:54 INFO - Running setup.py install for functools32 05:45:54 INFO - warning: no files found matching '*.txt' 05:45:54 INFO - no previously-included directories found matching 'build' 05:45:54 INFO - no previously-included directories found matching 'dist' 05:45:54 INFO - no previously-included directories found matching '.git*' 05:45:54 INFO - Successfully installed jsonschema functools32 05:45:54 INFO - Cleaning up... 05:45:54 INFO - Return code: 0 05:45:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:54 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 0x14c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17883b0>, '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 0x17892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1789740>, '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': '337fe3f4b1febe37b85fccc40000019e-1468327528.630281-599773880', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:45:54 INFO - Using env: {'DISPLAY': ':0', 05:45:54 INFO - 'HOME': '/home/cltbld', 05:45:54 INFO - 'LANG': 'en_US.UTF-8', 05:45:54 INFO - 'LANGUAGE': 'en_US:en', 05:45:54 INFO - 'LOGNAME': 'cltbld', 05:45:54 INFO - 'MAIL': '/var/mail/cltbld', 05:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:54 INFO - 'MOZ_NO_REMOTE': '1', 05:45:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:54 INFO - 'NO_EM_RESTART': '1', 05:45:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:54 INFO - 'PWD': '/builds/slave/test', 05:45:54 INFO - 'SHELL': '/bin/bash', 05:45:54 INFO - 'SHLVL': '1', 05:45:54 INFO - 'TERM': 'linux', 05:45:54 INFO - 'TMOUT': '86400', 05:45:54 INFO - 'USER': 'cltbld', 05:45:54 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1468327528.630281-599773880', 05:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:54 INFO - '_': '/tools/buildbot/bin/python'} 05:45:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:54 INFO - Downloading/unpacking blobuploader==1.2.4 05:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:56 INFO - Downloading blobuploader-1.2.4.tar.gz 05:45:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:45:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:45:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:57 INFO - Downloading docopt-0.6.1.tar.gz 05:45:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:45:57 INFO - Installing collected packages: blobuploader, requests, docopt 05:45:57 INFO - Running setup.py install for blobuploader 05:45:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:45:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:45:57 INFO - Running setup.py install for requests 05:45:57 INFO - Running setup.py install for docopt 05:45:57 INFO - Successfully installed blobuploader requests docopt 05:45:57 INFO - Cleaning up... 05:45:57 INFO - Return code: 0 05:45:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:45: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')]} 05:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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')]} 05:45:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:57 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 0x14c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17883b0>, '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 0x17892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1789740>, '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': '337fe3f4b1febe37b85fccc40000019e-1468327528.630281-599773880', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:45:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:45:57 INFO - Using env: {'DISPLAY': ':0', 05:45:57 INFO - 'HOME': '/home/cltbld', 05:45:57 INFO - 'LANG': 'en_US.UTF-8', 05:45:57 INFO - 'LANGUAGE': 'en_US:en', 05:45:57 INFO - 'LOGNAME': 'cltbld', 05:45:57 INFO - 'MAIL': '/var/mail/cltbld', 05:45:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:57 INFO - 'MOZ_NO_REMOTE': '1', 05:45:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:57 INFO - 'NO_EM_RESTART': '1', 05:45:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:57 INFO - 'PWD': '/builds/slave/test', 05:45:57 INFO - 'SHELL': '/bin/bash', 05:45:57 INFO - 'SHLVL': '1', 05:45:57 INFO - 'TERM': 'linux', 05:45:57 INFO - 'TMOUT': '86400', 05:45:57 INFO - 'USER': 'cltbld', 05:45:57 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1468327528.630281-599773880', 05:45:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:57 INFO - '_': '/tools/buildbot/bin/python'} 05:45:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:45:58 INFO - Running setup.py (path:/tmp/pip-KsaNw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:45:58 INFO - Running setup.py (path:/tmp/pip-cqux5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:45:58 INFO - Running setup.py (path:/tmp/pip-gbsUkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:45:58 INFO - Running setup.py (path:/tmp/pip-u3e6pI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:45:58 INFO - Running setup.py (path:/tmp/pip-cNRpLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:45:58 INFO - Running setup.py (path:/tmp/pip-BIl1DE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:45:58 INFO - Running setup.py (path:/tmp/pip-Ge2Tt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:45:58 INFO - Running setup.py (path:/tmp/pip-Rzdr_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:45:58 INFO - Running setup.py (path:/tmp/pip-eKqde9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:45:58 INFO - Running setup.py (path:/tmp/pip-ISfjfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:45:58 INFO - Running setup.py (path:/tmp/pip-xy1zje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:45:58 INFO - Running setup.py (path:/tmp/pip-AldyMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:45:58 INFO - Running setup.py (path:/tmp/pip-HFFts4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:45:58 INFO - Running setup.py (path:/tmp/pip-eJmRex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:59 INFO - Running setup.py (path:/tmp/pip-hW2LKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:45:59 INFO - Running setup.py (path:/tmp/pip-B150u4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:45:59 INFO - Running setup.py (path:/tmp/pip-s0j97o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:45:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:45:59 INFO - Running setup.py install for manifestparser 05:45:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:45:59 INFO - Running setup.py install for mozcrash 05:45:59 INFO - Running setup.py install for mozdebug 05:45:59 INFO - Running setup.py install for mozdevice 05:45:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:45:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:45:59 INFO - Running setup.py install for mozfile 05:45:59 INFO - Running setup.py install for mozhttpd 05:45:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:45:59 INFO - Running setup.py install for mozinfo 05:45:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:45:59 INFO - Running setup.py install for mozInstall 05:46:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:46:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:46:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:46:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:46:00 INFO - Running setup.py install for mozleak 05:46:00 INFO - Running setup.py install for mozlog 05:46:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:46:00 INFO - Running setup.py install for moznetwork 05:46:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:46:00 INFO - Running setup.py install for mozprocess 05:46:00 INFO - Running setup.py install for mozprofile 05:46:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:46:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:46:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:46:00 INFO - Running setup.py install for mozrunner 05:46:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:46:00 INFO - Running setup.py install for mozscreenshot 05:46:00 INFO - Running setup.py install for moztest 05:46:00 INFO - Running setup.py install for mozversion 05:46:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:46:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:46:01 INFO - Cleaning up... 05:46:01 INFO - Return code: 0 05:46:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:01 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 0x14c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17883b0>, '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 0x17892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1789740>, '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': '337fe3f4b1febe37b85fccc40000019e-1468327528.630281-599773880', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:46:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:46:01 INFO - Using env: {'DISPLAY': ':0', 05:46:01 INFO - 'HOME': '/home/cltbld', 05:46:01 INFO - 'LANG': 'en_US.UTF-8', 05:46:01 INFO - 'LANGUAGE': 'en_US:en', 05:46:01 INFO - 'LOGNAME': 'cltbld', 05:46:01 INFO - 'MAIL': '/var/mail/cltbld', 05:46:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:01 INFO - 'MOZ_NO_REMOTE': '1', 05:46:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:01 INFO - 'NO_EM_RESTART': '1', 05:46:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:01 INFO - 'PWD': '/builds/slave/test', 05:46:01 INFO - 'SHELL': '/bin/bash', 05:46:01 INFO - 'SHLVL': '1', 05:46:01 INFO - 'TERM': 'linux', 05:46:01 INFO - 'TMOUT': '86400', 05:46:01 INFO - 'USER': 'cltbld', 05:46:01 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1468327528.630281-599773880', 05:46:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:01 INFO - '_': '/tools/buildbot/bin/python'} 05:46:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:46:01 INFO - Running setup.py (path:/tmp/pip-_6vgAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:46:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:46:01 INFO - Running setup.py (path:/tmp/pip-1MUmPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:46:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:46:01 INFO - Running setup.py (path:/tmp/pip-4xQZxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:46:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:46:01 INFO - Running setup.py (path:/tmp/pip-dH5yWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:46:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:46:01 INFO - Running setup.py (path:/tmp/pip-Ve0QLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:46:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:46:01 INFO - Running setup.py (path:/tmp/pip-NcSK2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:46:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:46:01 INFO - Running setup.py (path:/tmp/pip-CY_pKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:46:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:46:01 INFO - Running setup.py (path:/tmp/pip-7133fC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:46:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:46:01 INFO - Running setup.py (path:/tmp/pip-Gz8bOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:46:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:46:01 INFO - Running setup.py (path:/tmp/pip-cXdn1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:46:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:46:01 INFO - Running setup.py (path:/tmp/pip-XA_TrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:46:02 INFO - Running setup.py (path:/tmp/pip-MBucUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:46:02 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)) 05:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:46:02 INFO - Running setup.py (path:/tmp/pip-1sXMDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:46:02 INFO - Running setup.py (path:/tmp/pip-u3yH4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:46:02 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)) 05:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:02 INFO - Running setup.py (path:/tmp/pip-GGWEv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:46:02 INFO - Running setup.py (path:/tmp/pip-3DYGRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:46:02 INFO - Running setup.py (path:/tmp/pip-YXRLx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:46:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:04 INFO - Downloading blessings-1.6.tar.gz 05:46:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:46:04 INFO - Installing collected packages: blessings 05:46:04 INFO - Running setup.py install for blessings 05:46:04 INFO - Successfully installed blessings 05:46:04 INFO - Cleaning up... 05:46:04 INFO - Return code: 0 05:46:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:46:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:04 INFO - Reading from file tmpfile_stdout 05:46:04 INFO - Current package versions: 05:46:04 INFO - argparse == 1.2.1 05:46:04 INFO - blessings == 1.6 05:46:04 INFO - blobuploader == 1.2.4 05:46:04 INFO - docopt == 0.6.1 05:46:04 INFO - functools32 == 3.2.3-2 05:46:04 INFO - jsonschema == 2.5.1 05:46:04 INFO - manifestparser == 1.1 05:46:04 INFO - mozInstall == 1.12 05:46:04 INFO - mozcrash == 0.17 05:46:04 INFO - mozdebug == 0.1 05:46:04 INFO - mozdevice == 0.48 05:46:04 INFO - mozfile == 1.2 05:46:04 INFO - mozhttpd == 0.7 05:46:04 INFO - mozinfo == 0.9 05:46:04 INFO - mozleak == 0.1 05:46:04 INFO - mozlog == 3.2 05:46:04 INFO - moznetwork == 0.27 05:46:04 INFO - mozprocess == 0.23 05:46:04 INFO - mozprofile == 0.28 05:46:04 INFO - mozrunner == 6.12 05:46:04 INFO - mozscreenshot == 0.1 05:46:04 INFO - mozsystemmonitor == 0.3 05:46:04 INFO - moztest == 0.7 05:46:04 INFO - mozversion == 1.4 05:46:04 INFO - psutil == 3.1.1 05:46:04 INFO - requests == 1.2.3 05:46:04 INFO - wsgiref == 0.1.2 05:46:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46: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')]} 05:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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')]} 05:46:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:04 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 0x14c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17883b0>, '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 0x17892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1789740>, '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': '337fe3f4b1febe37b85fccc40000019e-1468327528.630281-599773880', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:46:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:46:04 INFO - Using env: {'DISPLAY': ':0', 05:46:04 INFO - 'HOME': '/home/cltbld', 05:46:04 INFO - 'LANG': 'en_US.UTF-8', 05:46:04 INFO - 'LANGUAGE': 'en_US:en', 05:46:04 INFO - 'LOGNAME': 'cltbld', 05:46:04 INFO - 'MAIL': '/var/mail/cltbld', 05:46:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:04 INFO - 'MOZ_NO_REMOTE': '1', 05:46:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:04 INFO - 'NO_EM_RESTART': '1', 05:46:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:04 INFO - 'PWD': '/builds/slave/test', 05:46:04 INFO - 'SHELL': '/bin/bash', 05:46:04 INFO - 'SHLVL': '1', 05:46:04 INFO - 'TERM': 'linux', 05:46:04 INFO - 'TMOUT': '86400', 05:46:04 INFO - 'USER': 'cltbld', 05:46:04 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1468327528.630281-599773880', 05:46:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:04 INFO - '_': '/tools/buildbot/bin/python'} 05:46:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:46:05 INFO - Cleaning up... 05:46:05 INFO - Return code: 0 05:46:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:05 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 0x14c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17883b0>, '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 0x17892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1789740>, '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': '337fe3f4b1febe37b85fccc40000019e-1468327528.630281-599773880', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:46:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:46:05 INFO - Using env: {'DISPLAY': ':0', 05:46:05 INFO - 'HOME': '/home/cltbld', 05:46:05 INFO - 'LANG': 'en_US.UTF-8', 05:46:05 INFO - 'LANGUAGE': 'en_US:en', 05:46:05 INFO - 'LOGNAME': 'cltbld', 05:46:05 INFO - 'MAIL': '/var/mail/cltbld', 05:46:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:05 INFO - 'MOZ_NO_REMOTE': '1', 05:46:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:05 INFO - 'NO_EM_RESTART': '1', 05:46:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:05 INFO - 'PWD': '/builds/slave/test', 05:46:05 INFO - 'SHELL': '/bin/bash', 05:46:05 INFO - 'SHLVL': '1', 05:46:05 INFO - 'TERM': 'linux', 05:46:05 INFO - 'TMOUT': '86400', 05:46:05 INFO - 'USER': 'cltbld', 05:46:05 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1468327528.630281-599773880', 05:46:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:05 INFO - '_': '/tools/buildbot/bin/python'} 05:46:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:46:05 INFO - Cleaning up... 05:46:05 INFO - Return code: 0 05:46:05 INFO - Running post-action listener: _resource_record_post_action 05:46:05 INFO - Running post-action listener: _start_resource_monitoring 05:46:05 INFO - Starting resource monitoring. 05:46:05 INFO - ##### 05:46:05 INFO - ##### Finished create-virtualenv step (success) 05:46:05 INFO - ##### 05:46:05 INFO - ##### 05:46:05 INFO - ##### Running install step. 05:46:05 INFO - ##### 05:46:05 INFO - Running pre-action listener: _resource_record_pre_action 05:46:05 INFO - Running main action method: install 05:46:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:05 INFO - Reading from file tmpfile_stdout 05:46:05 INFO - Detecting whether we're running mozinstall >=1.0... 05:46:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:46:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:46:05 INFO - Reading from file tmpfile_stdout 05:46:05 INFO - Output received: 05:46:05 INFO - Usage: mozinstall [options] installer 05:46:05 INFO - Options: 05:46:05 INFO - -h, --help show this help message and exit 05:46:05 INFO - -d DEST, --destination=DEST 05:46:05 INFO - Directory to install application into. [default: 05:46:05 INFO - "/builds/slave/test"] 05:46:05 INFO - --app=APP Application being installed. [default: firefox] 05:46:05 INFO - mkdir: /builds/slave/test/build/application 05:46:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:46:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:46:22 INFO - Reading from file tmpfile_stdout 05:46:22 INFO - Output received: 05:46:22 INFO - /builds/slave/test/build/application/firefox/firefox 05:46:22 INFO - Running post-action listener: _resource_record_post_action 05:46:22 INFO - ##### 05:46:22 INFO - ##### Finished install step (success) 05:46:22 INFO - ##### 05:46:22 INFO - ##### 05:46:22 INFO - ##### Running run-tests step. 05:46:22 INFO - ##### 05:46:22 INFO - Running pre-action listener: _resource_record_pre_action 05:46:22 INFO - Running main action method: run_tests 05:46:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:46:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:46:22 INFO - Python 2.7.3 05:46:22 INFO - Return code: 0 05:46:22 INFO - grabbing minidump binary from tooltool 05:46:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:22 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 0x17883b0>, '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 0x17892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1789740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:46:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:46:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:46:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:46:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:46:22 INFO - Return code: 0 05:46:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:46:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:46:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:46:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:46:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:46:22 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/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 05:46:22 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/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 05:46:22 INFO - Using env: {'DISPLAY': ':0', 05:46:22 INFO - 'HOME': '/home/cltbld', 05:46:22 INFO - 'LANG': 'en_US.UTF-8', 05:46:22 INFO - 'LANGUAGE': 'en_US:en', 05:46:22 INFO - 'LOGNAME': 'cltbld', 05:46:22 INFO - 'MAIL': '/var/mail/cltbld', 05:46:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:46:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:46:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:22 INFO - 'MOZ_NO_REMOTE': '1', 05:46:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:46:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:22 INFO - 'NO_EM_RESTART': '1', 05:46:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:22 INFO - 'PWD': '/builds/slave/test', 05:46:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:46:22 INFO - 'SHELL': '/bin/bash', 05:46:22 INFO - 'SHLVL': '1', 05:46:22 INFO - 'TERM': 'linux', 05:46:22 INFO - 'TMOUT': '86400', 05:46:22 INFO - 'USER': 'cltbld', 05:46:22 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1468327528.630281-599773880', 05:46:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:22 INFO - '_': '/tools/buildbot/bin/python'} 05:46:22 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/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 05:46:23 INFO - mozversion application_buildid: 20160712030234 05:46:23 INFO - mozversion application_changeset: aac8ff1024c553d9c92b85b8b6ba90f65de2ed08 05:46:23 INFO - mozversion application_display_name: Nightly 05:46:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:46:23 INFO - mozversion application_name: Firefox 05:46:23 INFO - mozversion application_remotingname: firefox 05:46:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:46:23 INFO - mozversion application_vendor: Mozilla 05:46:23 INFO - mozversion application_version: 50.0a1 05:46:23 INFO - mozversion platform_buildid: 20160712030234 05:46:23 INFO - mozversion platform_changeset: aac8ff1024c553d9c92b85b8b6ba90f65de2ed08 05:46:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:46:23 INFO - mozversion platform_version: 50.0a1 05:46:23 INFO - using testdate: 1468327583 05:46:23 INFO - actual date: 1468327583 05:46:23 INFO - starting webserver on 'localhost:43272' 05:46:23 INFO - SUITE-START | Running 2 tests 05:46:23 INFO - TEST-START | dromaeo_css 05:46:23 INFO - operating with platform_type : linux_ 05:46:23 INFO - Initialising browser for dromaeo_css test... 05:46:23 INFO - TEST-INFO | started process 22927 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkfgTL6/profile http://localhost:43272/getInfo.html) 05:46:27 INFO - PROCESS | 22927 | __metrics Screen width/height:1600/1200 05:46:27 INFO - PROCESS | 22927 | colorDepth:24 05:46:27 INFO - PROCESS | 22927 | Browser inner width/height: 1024/697 05:46:27 INFO - PROCESS | 22927 | __metrics 05:46:28 ERROR - PROCESS | 22927 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 05:46:28 INFO - TEST-INFO | 22927: exit 0 05:46:28 INFO - Browser initialized. 05:46:28 INFO - Running cycle 1/1 for dromaeo_css test... 05:46:28 INFO - TEST-INFO | started process 23050 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkfgTL6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:46:40 INFO - PROCESS | 23050 | RSS: Main: 167649280 05:46:40 INFO - PROCESS | 23050 | 05:47:30 INFO - PROCESS | 23050 | 1468327650412 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:49:38 INFO - PROCESS | 23050 | Cycle 1(1): loaded http://localhost:43272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43272/tests/dromaeo/cssquery-ext.html) 05:49:39 INFO - PROCESS | 23050 | RSS: Main: 171601920 05:49:39 INFO - PROCESS | 23050 | 05:52:41 INFO - PROCESS | 23050 | Cycle 1(1): loaded http://localhost:43272/tests/dromaeo/cssquery-ext.html (next: http://localhost:43272/tests/dromaeo/cssquery-jquery.html) 05:52:42 INFO - PROCESS | 23050 | RSS: Main: 168333312 05:52:42 INFO - PROCESS | 23050 | 05:55:43 INFO - PROCESS | 23050 | Cycle 1(1): loaded http://localhost:43272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43272/tests/dromaeo/cssquery-mootools.html) 05:55:44 INFO - PROCESS | 23050 | RSS: Main: 171540480 05:55:44 INFO - PROCESS | 23050 | 05:58:46 INFO - PROCESS | 23050 | Cycle 1(1): loaded http://localhost:43272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43272/tests/dromaeo/cssquery-prototype.html) 05:58:47 INFO - PROCESS | 23050 | RSS: Main: 167194624 05:58:47 INFO - PROCESS | 23050 | 06:01:49 INFO - PROCESS | 23050 | Cycle 1(1): loaded http://localhost:43272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43272/tests/dromaeo/cssquery-yui.html) 06:01:50 INFO - PROCESS | 23050 | RSS: Main: 168796160 06:01:50 INFO - PROCESS | 23050 | 06:04:53 INFO - PROCESS | 23050 | Cycle 1(1): loaded http://localhost:43272/tests/dromaeo/cssquery-yui.html (next: http://localhost:43272/tests/dromaeo/cssquery-dojo.html) 06:04:53 INFO - PROCESS | 23050 | RSS: Main: 169844736 06:04:53 INFO - PROCESS | 23050 | 06:04:53 INFO - PROCESS | 23050 | __start_tp_report 06:04:53 INFO - PROCESS | 23050 | _x_x_mozilla_page_load 06:04:53 INFO - PROCESS | 23050 | _x_x_mozilla_page_load_details 06:04:53 INFO - PROCESS | 23050 | |i|pagename|runs| 06:04:53 INFO - PROCESS | 23050 | |0;dojo.html;3057.1134371032404;3133.3889891471144;3141.874325026999;3155.0534839548145;3158.542011408346;5539.279893613824;5570.832875013751;5589.441055894414;5600.103983362663;5619.100943848985;5352.063388906936;5465.808696695616;5472.425395333493;5524.779008839641;5554.1113421852515;4954.281629163778;4982.5764809991015;5061.797528098871;5106.004329155816;5147.1764517677175;769.8826184449747;5024.924626130611;5071.391433028042;5094.414142373619;5109.616778741591;5012.147934851084;5037.1940489521685;5041.873953151182;5049.141645920203;5097.898042039175;4969.52789485002;5068.290439338459;5074.441811400743;5082.669626474304;5100.5919526438165;4961;4999.925001124986;5012.8997420051755;5063.215201643751;5063.291139240509;5479.232907392969;5521.834344969658;5532.75102620383;5570.053090974544;5576.275084239063;5728.112142617901;5759.078547432433;5765.365809760923;5967.403259673998;5978.671173085479;5807.157962095514;5809.593328467009;5811.941880581182;5823.592348535604;5925.762969481216;5441.537469315113;5461.098918678414;5463.590230732711;5465.726713664301;5472.7263636818;5838.4453476919625;5959.374265702126;6050.515958723292;6113.083037544315;6124.448799608057;5895.20414744004;5904.3210030847;5904.468597826216;5905.261842269716;5907.966105931445;5969.403059693996;5970.0746384310505;5970.701464926737;5992.0712289595185;5996.4603185713495;5668.121441176624;5810.50610698087;5814.069748840166;5841.269841269841;5890.293164820163;5696.11710184922;5810.302763668386;5843.503302219359;5888.61723987948;5904.143899134601;4297.957020429818;4317.07182955666;4344.283193273138;4345.869623911288;4374.671899607542;3789.5452545694693;3835.2904712627696;3837.328467518173;3870.3613903706137;3904.8871071744416;5612.691301978349;5692.1461780733225;5693.231413759172;5693.68684722336;5696.715164241771;5946.940530594725;6005.849853753691;6006.189164462829;6018.518518518508;6033.5173186145;5470.480304371078;5531.9723401382735;5594.804181853616;5597.720113994284;5606.131049687305;4931.876703082452;4957.454679985199;4974.452810190876;4976.7262800545595;5016.724080175552;5956.55325850563;6119.785807496716;6125.387461253839;6129.908051379233;6132.724027418777;5876.206712093898;5901.085331773582;5917.881642367042;5949.315828679757;5954.285485741739;6060.515158787198;6113.23584551931;6128.693565321627;6139.079138129317;6145.84635384119;5703.515201207943;5768.913466298093;5811.215485909348;5830.18377427169;5836.387179346108;5891.3224979127945;5927.14056461802;5953.76184952597;5959.523238141025;6017.729202185999;5736.370627066076;5785.4214578541805;5791.247137872218;5802.564807639359;5825.184474173534;5556.583256255878;5774.538036957118;5783.045797443375;5799.565032622486;5813.970930145322;5580.079286917776;5645.576581756302;5661.575381846295;5664.26364572603;5839.883202336015;5793.275840519935;5809.535237180931;5835.241418615553;5857.033589457692;5860.208871802252;5572.136318870582;5622.88754224905;5646.040173170653;5696.629719068247;5697.515711164431 06:04:53 INFO - PROCESS | 23050 | |1;ext.html;559.6435853480342;577.1054864959314;589.1898639370868;605.4611395857687;634.6953462338081;39386.2122757545;43154.19497732645;43263.78368108155;43266;43648.34527482082;43590.78204608973;43875.56124438754;44137.77931110348;44138;44305.335419968724;8759.693410730626;8850.247728943048;8920.643174273022;8922.420042697237;8941.239994600466;8702.738917832476;8777.2100510954;8846.292296616255;8848.159424854628;8852.867206991868;8871.911280887205;8879.689210877621;8879.845620069382;8881.955590222073;8901.154390332907;8744.650213991432;8839.558022098869;8850.73447796567;8859.424137431079;8869.822603547893;8782.912170878273;8867.600957956907;8868.201861832466;8872.645094196225;8899.777505562348;40937;41499.792501037606;41811.1637767246;41819.7909010453;41905.58094419047;3383.2649745388344;3486.755927085105;3490.3542844573835;3580.9283814323567;3942.369220924667;33630.49554256688;33634.66365336364;34038.48942265868;34189.145271368165;35343.4698479523;4353.28170851809;4353.608175264241;4384.101259241847;4413.492448368414;4427.2695005324085;374628;375863;376858;378422;379755.10122449487;31583.368332633218;32519.349613008082;32565.674343256265;56829.147562786595;57002.714986424806;37495.43756843649;37560.812195938845;37570.43644345337;37655.4351684725;37770.81114594409;15335.386584536494;15526.611834703997;15554.066755994676;15567.922160389126;15682;12995.870041299655;12998.870011299767;13064.412101455457;13070.934645326712;13104.541341053207;7695.153533111354;7758.340541053961;7797.415193860483;7802.570858602831;7802.960985195151;3216.4371235033777;3278.0821370016433;3280.5899262592175;3295.538624592559;3325.93348133036;1045.602670985036;1047.1988928469727;1064.9787004260027;1134.6766171641043;1139.2537887683582;33364.332713346084;33651.495227571606;33810.154746131055;34091.659083409344;34436.48345274823;1104.045001074065;1122.7417693930443;1130.6155906991662;1131.5134492168447;1225.7180848404917;17579.56051098707;17663.470095897144;17679.20443580042;17719.29122835098;17791;600411;605443;612426;612877;614978;60129.091609045274;60610.69694651499;60642.393576063674;60655.393446064976;60726.39273607296;1290.7676618208814;1333.9333033348294;1356.2405053170257;1359.4358341288453;1372.876441120304;32427.837860811487;33390.497427616305;33451.163720906196;33650;34083;52492.737536312074;53075.20387194272;53243.201351980526;53253;53364;516025;516557;516963;519378;520986;27877.581836272067;28936.42127157403;29230.415391691622;29247.122586322443;29265;48837.51162488329;49347.25979110388;49753.751231243616;50614.24078638897;50824;41674.791626041675;41799.7910010448;42396.57603423926;42815.78592107019;43551.564484356015;42933;43488.34767478554;43556.34665479957;43640.345394819735;43902.78048609736;41861;42102.789486052374;43258.134837302445;43280.567194327654;43322;36809.81595092007;37331.44002840014;38066.55864389879;38204;38457.615423845404;28679.42641147207;28918.770118990276;29113.126606201848;29260.122196334145;29471.85264073666 06:04:53 INFO - PROCESS | 23050 | |2;jquery.html;389.3245219544091;393.1645253835599;394.85193052605274;401.95578486366503;414.64547811621065;15588.454404095859;18670.253189872405;19659;20433.386998390033;20510.38468845935;19335.516612084706;19600.411987640357;19724.901375493104;19780.208791648318;19781.208751649952;5702.8289151325525;5860.003799354099;5890.941090589104;5891.145783861338;5892.528597712194;5618.831435056954;5778;5798.82603521895;5843.2695913010875;5862.4430679085635;5525.502704756571;5732.111522713965;5739.512141467981;5792.478676919098;5815.360310365856;5718.085106382959;5740.9712951435395;5747.080467125261;5773.451522105393;5843.912341314884;5189.1697328427645;5204.34945631796;5217.191335343028;5217.947820521822;5221.843344699665;15118.848811511854;20628;21823.890880545656;22002.339929802132;22594.661080083813;2222.9110835566557;2408.373822806083;2474.418511649761;2770.612114303999;2820.3513191965963;9358.812823743556;9955.950220248926;10116.49417529128;10136.442495662735;10360.740981475448;1805.4673871208024;1873.8969356685377;1902.9714554281697;1912.540990162351;1917.7794553626372;80594.59702701449;81649.18350816476;83145;83851.58074209651;87154.56422717909;10528.526216320284;10726.892731072745;10796.406197659047;10812.67561973142;10917.672469825759;13059.477620895248;13813.930930345485;14708;14760.852391476163;14801.703965920622;7820.139784623687;7884.9355337028765;7974.960125199337;8087.757367278991;8162.265396114378;7720.0735911689835;7772.300492955661;7820.804479888048;7957.960210198912;8001.839963200703;4565.178267911741;4577.404937358188;4583.991521865251;4586.564276393738;4645.140648979949;1922.3279641298607;1959.4513536209884;1967.2524440712723;1982.1972101298998;1986.9900650496654;394.95655477897407;399.28129367139616;400.0758248446041;887.3655336434481;1009.6112996496402;10690.679279621623;11015.228933974706;11057.889421105687;11326.43367831605;11363;425.23245541797354;426.75674865326465;429.30238362660674;429.38383419792075;449.6065942300487;5903.144044113579;5975.581709280309;5985.25184351956;6072.089186622042;6093.542984276197;471076;471509;472134;483574;496334;87706.56146719225;98868;99561;99793.50103249437;100481;452.7622997926115;454.7362529732747;457.2866328527441;460.6568106760485;462.2834606360195;10235.846462302923;10698.41158736277;10816.891831081903;10859.2398532102;10880.67357979262;36730.081747956516;42001;42630.57369426266;44137.11725765403;44892.55107448884;64936.35063649492;65015.67492162509;65455.34544654683;66089;67145;7357.5217610855125;8432.494050356998;8667.739967800977;8681.6093275804;8771;11675.708107297385;13764.724705506034;13765.518206862711;13999.650008749863;14038.719225615227;11231.775364492501;12280.938595307323;12318.322492263012;12359.938200308941;12671.366431678194;12222.144449888778;12268.325242111412;12504.374781260718;12651.683707907376;12781.8082728761;12026;12750.48998040068;12790.36048197605;12818.55135070268;12915.612531624067;8539.871901921351;8569.143085691381;8610.569471526524;8723.825284239421;8991.865122023044;5744.080947048452;8835.867461988204;11302.547898083985;11473.82789258145;12090.153689241668 06:04:53 INFO - PROCESS | 23050 | |3;mootools.html;1385.0650810702773;1456.075392126;1538.776877352784;1762.9206685699141;1763.0655752451205;7707.807304817368;8508.14918508149;8641.351898607614;9133.497657628828;9151.816963660724;8710.956445217766;8936.91063089369;8939.776505587348;9010.954945225281;9028.729138125867;2138.2409244718133;2171.945701357463;2180.2042254577045;2192.5286063496346;2194.8024677779;2226.5769503794227;2255.8872056397195;2319.7241517165576;2329.10329523134;2329.5457385809773;2280.8859557022083;2284.49741056968;2288.2448791898632;2288.794008539231;2314.2941402872116;2253.290213582716;2268.6143355629583;2270.1260014894383;2274.943126421836;2275.0444813178506;2174.554216385653;2189.5839790439763;2191.0687957617947;2199.450137465634;2210.7899749523767;9050.77373065672;9109.089091090838;9151.542422878829;9169.633214671472;9240.260779137652;5191.273221748958;5275.155975043975;5278.996990571779;5283.392409872837;5300.09898317287;3185.5062465317915;3230.4185246655593;3233.3210025894355;3245.415825151472;3285.6878596533293;1094.5402930769096;1116.6929094498996;1126.0822429719751;1131.5360702112096;1140.8573928258968;12663.430145643468;12709.300988445631;12755.298458584773;12774.680632984157;12786.232826030375;4430.4683437987005;4508.932366014513;4649.395578574831;4660.673752837337;4704.7412392318065;10570.577176912991;10651.627193048205;10692.251542392114;10713.410762407986;10740.194485413625;5327.413984461706;5356.7857285708915;5365.597580181424;5368.0605893968395;5374.892502149935;4342.109867477159;4773.618110551148;4936.358273424432;4955.628327875352;4978.850634480971;3897.376419772823;3986.242613903349;4042.706333973159;4121;4195.853145139906;1250.6248125562477;1267.8922291605131;1274.7195616964252;1275.222114510148;1275.5726831511363;900.9864852027225;986.9605215791431;1003.0471052500009;1005.1556692378291;1014.6099843214843;6085.056816193497;6097.573169878155;6117.327094019654;6138.631682099089;6163.044728067157;419.4274814877731;422.65342419216563;428.5992596921888;444.97330160190495;445.14754245619275;4023.1350259694304;4199.643030342455;4252.21334053195;4262.104957958863;4273.957260427418;11130.944345278222;11456.94271528637;11510.597129100608;11554.711132221593;11584.652460426201;10203.540840662188;10706.78586428267;10718.624848130277;11317.603883864025;11377.829332560019;8323.875141872877;8445.873311900326;8448.66205351779;8469.491830490191;8527.147285271547;5988.730507127103;6347.5239357047485;6348.650824204528;6348.77779277723;6375.171227740364;10524.52639631203;10573.52419141156;10611.363318200623;10618.787624247318;10628.256022078689;9948.850767238353;10333.948330258301;10398.74003149897;10591.788164236827;10722.624708135178;7166.426685865223;7702.191269916578;7940.126586075412;8027.5584842834205;8041.517508949481;8783.912160878564;8847.823043539222;8874.64501419936;8894.86657700148;8897.866532001895;7838.255365740246;8098.473599216032;8140.308073813555;8149.877751833608;8187.71343002992;7667.884981725167;7786.532808031537;7789.922100778919;7815.804604884924;7904.920950790419;6960.37356637905;7251.746188883575;7322.926770732438;7340.632968351668;7349.70601175947;5213.270142180174;5215.504527069922;5287.735613219246;5306.97346513265;5355.785768569213;5182.455842136521;5183.792648294026;5260.8158714446345;5305;5430.8099216527235 06:04:53 INFO - PROCESS | 23050 | |4;prototype.html;321.8632081365421;322.85632893362447;328.8914658162805;329.2378144595261;333.81640097946126;5647.548196144309;5696.174054762057;5705.971470142654;5708.743106560204;5730.914036289459;5564.522173641474;5573.191887176357;5582.637128586639;5584.21820945068;5613.494785469307;4027.7180597358197;4277.893052673677;4419.712718673276;4425.623821975128;4429.889252768674;4246.57534246576;4279.8502052428175;4299.763513006784;4305.225059489307;4325.329573916048;4199.7610704842145;4254.553271906451;4287.356896465524;4299.398084268205;4303.978480107595;4108.465899433069;4142.7571728481635;4241.257779888522;4254.553271906467;4294.957050429518;3733.253349330145;3733.869314574004;3734.439834024918;3741.681957033655;3753.549574051104;5470.699111548864;5487.670739755587;5492.862678433031;5513.145462453326;5533.363663178746;4774.594159496447;4866.732329721864;4906.9263961040615;4908.607311415079;4918.729469879156;5754.74103665336;5766.106253530709;5780.132980052984;5841.6495010299095;5845.649261044308;4102.8512016635095;4107.466029416187;4111.97944010278;4115.855945041909;4117.794110294473;5824.213731146283;6070.787522436738;6072.449571180071;6093.542984276152;6111.180512179888;4199.853005144805;4203.62167404935;4222.662187025031;4225.535191128974;4226.936595951063;4247.830086796555;4252.128313695747;4267.445232119804;4271.206093440763;4271.504973259396;4773.713577185311;4890;4912.1649319615035;4931.18635425158;4932.950670493249;5885.322683035314;5893.528517718572;5922.466977972003;5953.166556682068;5961;1472.5789613023485;1473.336998350725;1486.9925650371679;1490.2250829568563;1490.3144553505508;946.7159852044359;947.7535840681335;994.9701508954743;998.5007496251874;998.8451789972565;5565.9443405566235;5584.301962254718;5605.607607467519;5613.73690919548;5651.519620832275;5970.492508136857;5972.790952316648;5980.372060933626;6003.8198854034445;6063.090126610104;5492.539699988982;5561.805336813273;5601.383847776741;5633.436656334334;5703.173039909273;3197;3211.8394080295893;3217.905911989935;3241.546183534307;3264.967350326466;6048.60684055535;6255.437010669061;6264.624122552661;6273.560850740496;6342.207224096988;6253.499720022387;6261.812145635638;6268.919148426019;6270.404311590391;6272.560920735505;6291.528135389773;6320.652364120017;6322.304546499881;6333.303336633059;6351.841203969938;5831.300243970751;6101.969490152521;6185.350538193425;6214.223222097238;6233.407826256498;6098.908516372347;6149.508039356931;6164.260288765377;6167.784127555514;6185;6120.409692730452;6265.968670156803;6327.683615819283;6328.841778955563;6388.4569811566535;4155.958440415558;4191.161767646422;4196.580341965779;4203.07532342884;4208.242516347087;6106;6125.663088530174;6168.383161683975;6170.167027451416;6186.5360097993735;5849.636459035986;5916.31962324321;5943.673097979479;5955.702214889325;6001.9196544620645;5880.529557635465;5895.469407753323;5985.456181123092;5990.1913241713555;6015.729292181775;5608.803691870765;5801.1878337032;5842.036064049385;5900.64596124234;5905.970470147794;5958;5963.344032156372;5967.880642387041;5981.641101533748;6046.727897244723;5773.24947756789;5830.416958304136;5854.502367298827;5879.677072658788;5885.588008839341 06:04:53 INFO - PROCESS | 23050 | |5;yui.html;809.6356639512218;819.8442295963766;836.8451836410264;847.063994286314;868.7133246028809;13716.862831371684;14495.782563261546;14505.854941450581;14515.637109072279;14539.854601453982;13282.203067815937;13311.201327920331;13319.20084794913;13416.195028298309;13440.521542630328;765.3494529649809;767.8617848787216;787.4369825574713;789.486833558186;791.1258059843876;780.7657702689199;782.3662833105175;788.5781107107698;788.6529926832204;796.4822865137648;860.9440386374897;865.523961820999;865.8268346330727;868.1752335281476;868.6178081644088;853.0062477214069;858.3776761847673;861.3970220845401;862.525610914001;862.5471627395636;624.7969409941787;625.6371304643296;628.3151365012113;628.6510986402545;631.0124654915044;14785.70428591433;14887;14905.627359316104;14969.775453368207;15019.09885406879;14941.402343906231;15013.774793378108;15061.17163556004;15165.772513412197;15345.46290879825;12802.42389092493;12838;12898.09713320068;13085.803712944313;13089.541866034739;3759.342115129841;3913.9804300978312;3919.8432062717457;3943.605639436062;3948.822302996372;87508.5624571873;88482.55758721165;88713;88777.55611221967;88984;11322.63729246482;11644.35956022427;11646.126540509496;11709.882901170879;11820.349880756468;22394.55210895773;22399.664005039936;22401.551968960855;22408.551828963657;22456.775432245468;8669.479831210148;8774.122587741302;8853.247473964786;9064.184223419792;9251.491167985825;4792.400949881265;4802.543758342952;4811.639127065484;4866.343043689057;4986.252062190628;3500.5274287971306;3662.6337366263692;3663.102539877747;3665.706743460517;3665.87169449068;607.1227076873963;609.9908501372483;611.7522403426619;617.1483352972958;618.2889676871633;657.2999755260632;668.7124536449277;692.3388164303078;696.3732640623379;704.2781149321884;8933.729099831131;8971.50656713874;9068.81862362749;9224.123708247706;9433.245340372754;592.9407059294123;635.1711017122699;650.3626446082865;652.9967350163218;674.8717743628695;4206.11671548972;4245.108527209259;4324.8486302979245;4348.521662617173;5481.5340696041285;119335.40332298283;126869;129074;130536.34731826281;131055.89441056008;109384.65383654086;113519;114229.4288528552;114318;114628.42685786518;96515.20908745498;96971;97186.7953864834;98386;99169;10047.849282260919;10106.545205465625;10110.545025473724;10143.594256229668;10225.897741022793;56467.43532564622;56689.716551416976;57122.14316785335;57675.42324576868;58097;81759.59120204361;83787;85606.57196713977;87719.56140219513;87795;13152.276624785345;13666.11170273929;13756.887652250298;13767.105138165987;13884.791728123884;15167.544973650809;15472.226388680747;15605.219739013231;15735.842641573896;15807.68384632278;14989.175595342362;15003.699926001636;15041.6991660164;15128.243587820785;16137.435189768301;14378.856211437751;14613.19627420502;15138.697226055197;15268.694626107193;15445.304961276994;15019.399224030916;15094.54716358511;15171.544853654408;15492.612684682974;15844.841551584797;10300.587976480856;10664.84002739944;11001.504932277907;11226.214165008698;12270;10750.67291396664;11560.94219528897;11580.478878450322;11642.126840487166;11878.168528202943 06:04:53 INFO - PROCESS | 23050 | __end_tp_report 06:04:53 INFO - PROCESS | 23050 | __start_cc_report 06:04:53 INFO - PROCESS | 23050 | _x_x_mozilla_cycle_collect,377 06:04:53 INFO - PROCESS | 23050 | __end_cc_report 06:04:53 INFO - PROCESS | 23050 | __startTimestamp1468328693294__endTimestamp 06:04:53 INFO - PROCESS | 23050 | 06:04:53 INFO - PROCESS | 23050 | ------- Summary: start ------- 06:04:53 INFO - PROCESS | 23050 | Number of tests: 6 06:04:53 INFO - PROCESS | 23050 | 06:04:53 INFO - PROCESS | 23050 | [#0] dojo.html Cycles:165 Average:5446.64 Median:5696.12 stddev:747.47 (13.1%) stddev-sans-first:725.88 06:04:53 INFO - PROCESS | 23050 | Values: 3057.1 3133.4 3141.9 3155.1 3158.5 5539.3 5570.8 5589.4 5600.1 5619.1 5352.1 5465.8 5472.4 5524.8 5554.1 4954.3 4982.6 5061.8 5106.0 5147.2 769.9 5024.9 5071.4 5094.4 5109.6 5012.1 5037.2 5041.9 5049.1 5097.9 4969.5 5068.3 5074.4 5082.7 5100.6 4961.0 4999.9 5012.9 5063.2 5063.3 5479.2 5521.8 5532.8 5570.1 5576.3 5728.1 5759.1 5765.4 5967.4 5978.7 5807.2 5809.6 5811.9 5823.6 5925.8 5441.5 5461.1 5463.6 5465.7 5472.7 5838.4 5959.4 6050.5 6113.1 6124.4 5895.2 5904.3 5904.5 5905.3 5908.0 5969.4 5970.1 5970.7 5992.1 5996.5 5668.1 5810.5 5814.1 5841.3 5890.3 5696.1 5810.3 5843.5 5888.6 5904.1 4298.0 4317.1 4344.3 4345.9 4374.7 3789.5 3835.3 3837.3 3870.4 3904.9 5612.7 5692.1 5693.2 5693.7 5696.7 5946.9 6005.8 6006.2 6018.5 6033.5 5470.5 5532.0 5594.8 5597.7 5606.1 4931.9 4957.5 4974.5 4976.7 5016.7 5956.6 6119.8 6125.4 6129.9 6132.7 5876.2 5901.1 5917.9 5949.3 5954.3 6060.5 6113.2 6128.7 6139.1 6145.8 5703.5 5768.9 5811.2 5830.2 5836.4 5891.3 5927.1 5953.8 5959.5 6017.7 5736.4 5785.4 5791.2 5802.6 5825.2 5556.6 5774.5 5783.0 5799.6 5814.0 5580.1 5645.6 5661.6 5664.3 5839.9 5793.3 5809.5 5835.2 5857.0 5860.2 5572.1 5622.9 5646.0 5696.6 5697.5 06:04:53 INFO - PROCESS | 23050 | 06:04:53 INFO - PROCESS | 23050 | [#1] ext.html Cycles:180 Average:64314.42 Median:41883.29 stddev:136176.25 (325.1%) stddev-sans-first:136474.13 06:04:53 INFO - PROCESS | 23050 | Values: 559.6 577.1 589.2 605.5 634.7 39386.2 43154.2 43263.8 43266.0 43648.3 43590.8 43875.6 44137.8 44138.0 44305.3 8759.7 8850.2 8920.6 8922.4 8941.2 8702.7 8777.2 8846.3 8848.2 8852.9 8871.9 8879.7 8879.8 8882.0 8901.2 8744.7 8839.6 8850.7 8859.4 8869.8 8782.9 8867.6 8868.2 8872.6 8899.8 40937.0 41499.8 41811.2 41819.8 41905.6 3383.3 3486.8 3490.4 3580.9 3942.4 33630.5 33634.7 34038.5 34189.1 35343.5 4353.3 4353.6 4384.1 4413.5 4427.3 374628.0 375863.0 376858.0 378422.0 379755.1 31583.4 32519.3 32565.7 56829.1 57002.7 37495.4 37560.8 37570.4 37655.4 37770.8 15335.4 15526.6 15554.1 15567.9 15682.0 12995.9 12998.9 13064.4 13070.9 13104.5 7695.2 7758.3 7797.4 7802.6 7803.0 3216.4 3278.1 3280.6 3295.5 3325.9 1045.6 1047.2 1065.0 1134.7 1139.3 33364.3 33651.5 33810.2 34091.7 34436.5 1104.0 1122.7 1130.6 1131.5 1225.7 17579.6 17663.5 17679.2 17719.3 17791.0 600411.0 605443.0 612426.0 612877.0 614978.0 60129.1 60610.7 60642.4 60655.4 60726.4 1290.8 1333.9 1356.2 1359.4 1372.9 32427.8 33390.5 33451.2 33650.0 34083.0 52492.7 53075.2 53243.2 53253.0 53364.0 516025.0 516557.0 516963.0 519378.0 520986.0 27877.6 28936.4 29230.4 29247.1 29265.0 48837.5 49347.3 49753.8 50614.2 50824.0 41674.8 41799.8 42396.6 42815.8 43551.6 42933.0 43488.3 43556.3 43640.3 43902.8 41861.0 42102.8 43258.1 43280.6 43322.0 36809.8 37331.4 38066.6 38204.0 38457.6 28679.4 28918.8 29113.1 29260.1 29471.9 06:04:53 INFO - PROCESS | 23050 | 06:04:53 INFO - PROCESS | 23050 | [#2] jquery.html Cycles:180 Average:28441.18 Median:21529.94 stddev:79446.05 (369.0%) stddev-sans-first:79641.00 06:04:53 INFO - PROCESS | 23050 | Values: 389.3 393.2 394.9 402.0 414.6 15588.5 18670.3 19659.0 20433.4 20510.4 19335.5 19600.4 19724.9 19780.2 19781.2 5702.8 5860.0 5890.9 5891.1 5892.5 5618.8 5778.0 5798.8 5843.3 5862.4 5525.5 5732.1 5739.5 5792.5 5815.4 5718.1 5741.0 5747.1 5773.5 5843.9 5189.2 5204.3 5217.2 5217.9 5221.8 15118.8 20628.0 21823.9 22002.3 22594.7 2222.9 2408.4 2474.4 2770.6 2820.4 9358.8 9956.0 10116.5 10136.4 10360.7 1805.5 1873.9 1903.0 1912.5 1917.8 80594.6 81649.2 83145.0 83851.6 87154.6 10528.5 10726.9 10796.4 10812.7 10917.7 13059.5 13813.9 14708.0 14760.9 14801.7 7820.1 7884.9 7975.0 8087.8 8162.3 7720.1 7772.3 7820.8 7958.0 8001.8 4565.2 4577.4 4584.0 4586.6 4645.1 1922.3 1959.5 1967.3 1982.2 1987.0 395.0 399.3 400.1 887.4 1009.6 10690.7 11015.2 11057.9 11326.4 11363.0 425.2 426.8 429.3 429.4 449.6 5903.1 5975.6 5985.3 6072.1 6093.5 471076.0 471509.0 472134.0 483574.0 496334.0 87706.6 98868.0 99561.0 99793.5 100481.0 452.8 454.7 457.3 460.7 462.3 10235.8 10698.4 10816.9 10859.2 10880.7 36730.1 42001.0 42630.6 44137.1 44892.6 64936.4 65015.7 65455.3 66089.0 67145.0 7357.5 8432.5 8667.7 8681.6 8771.0 11675.7 13764.7 13765.5 13999.7 14038.7 11231.8 12280.9 12318.3 12359.9 12671.4 12222.1 12268.3 12504.4 12651.7 12781.8 12026.0 12750.5 12790.4 12818.6 12915.6 8539.9 8569.1 8610.6 8723.8 8991.9 5744.1 8835.9 11302.5 11473.8 12090.2 06:04:53 INFO - PROCESS | 23050 | 06:04:53 INFO - PROCESS | 23050 | [#3] mootools.html Cycles:180 Average:5907.46 Median:4386.29 stddev:3449.57 (78.6%) stddev-sans-first:3442.51 06:04:53 INFO - PROCESS | 23050 | Values: 1385.1 1456.1 1538.8 1762.9 1763.1 7707.8 8508.1 8641.4 9133.5 9151.8 8711.0 8936.9 8939.8 9011.0 9028.7 2138.2 2171.9 2180.2 2192.5 2194.8 2226.6 2255.9 2319.7 2329.1 2329.5 2280.9 2284.5 2288.2 2288.8 2314.3 2253.3 2268.6 2270.1 2274.9 2275.0 2174.6 2189.6 2191.1 2199.5 2210.8 9050.8 9109.1 9151.5 9169.6 9240.3 5191.3 5275.2 5279.0 5283.4 5300.1 3185.5 3230.4 3233.3 3245.4 3285.7 1094.5 1116.7 1126.1 1131.5 1140.9 12663.4 12709.3 12755.3 12774.7 12786.2 4430.5 4508.9 4649.4 4660.7 4704.7 10570.6 10651.6 10692.3 10713.4 10740.2 5327.4 5356.8 5365.6 5368.1 5374.9 4342.1 4773.6 4936.4 4955.6 4978.9 3897.4 3986.2 4042.7 4121.0 4195.9 1250.6 1267.9 1274.7 1275.2 1275.6 901.0 987.0 1003.0 1005.2 1014.6 6085.1 6097.6 6117.3 6138.6 6163.0 419.4 422.7 428.6 445.0 445.1 4023.1 4199.6 4252.2 4262.1 4274.0 11130.9 11456.9 11510.6 11554.7 11584.7 10203.5 10706.8 10718.6 11317.6 11377.8 8323.9 8445.9 8448.7 8469.5 8527.1 5988.7 6347.5 6348.7 6348.8 6375.2 10524.5 10573.5 10611.4 10618.8 10628.3 9948.9 10333.9 10398.7 10591.8 10722.6 7166.4 7702.2 7940.1 8027.6 8041.5 8783.9 8847.8 8874.6 8894.9 8897.9 7838.3 8098.5 8140.3 8149.9 8187.7 7667.9 7786.5 7789.9 7815.8 7904.9 6960.4 7251.7 7322.9 7340.6 7349.7 5213.3 5215.5 5287.7 5307.0 5355.8 5182.5 5183.8 5260.8 5305.0 5430.8 06:04:53 INFO - PROCESS | 23050 | 06:04:53 INFO - PROCESS | 23050 | [#4] prototype.html Cycles:180 Average:4949.32 Median:5673.85 stddev:1493.22 (26.3%) stddev-sans-first:1456.46 06:04:53 INFO - PROCESS | 23050 | Values: 321.9 322.9 328.9 329.2 333.8 5647.5 5696.2 5706.0 5708.7 5730.9 5564.5 5573.2 5582.6 5584.2 5613.5 4027.7 4277.9 4419.7 4425.6 4429.9 4246.6 4279.9 4299.8 4305.2 4325.3 4199.8 4254.6 4287.4 4299.4 4304.0 4108.5 4142.8 4241.3 4254.6 4295.0 3733.3 3733.9 3734.4 3741.7 3753.5 5470.7 5487.7 5492.9 5513.1 5533.4 4774.6 4866.7 4906.9 4908.6 4918.7 5754.7 5766.1 5780.1 5841.6 5845.6 4102.9 4107.5 4112.0 4115.9 4117.8 5824.2 6070.8 6072.4 6093.5 6111.2 4199.9 4203.6 4222.7 4225.5 4226.9 4247.8 4252.1 4267.4 4271.2 4271.5 4773.7 4890.0 4912.2 4931.2 4933.0 5885.3 5893.5 5922.5 5953.2 5961.0 1472.6 1473.3 1487.0 1490.2 1490.3 946.7 947.8 995.0 998.5 998.8 5565.9 5584.3 5605.6 5613.7 5651.5 5970.5 5972.8 5980.4 6003.8 6063.1 5492.5 5561.8 5601.4 5633.4 5703.2 3197.0 3211.8 3217.9 3241.5 3265.0 6048.6 6255.4 6264.6 6273.6 6342.2 6253.5 6261.8 6268.9 6270.4 6272.6 6291.5 6320.7 6322.3 6333.3 6351.8 5831.3 6102.0 6185.4 6214.2 6233.4 6098.9 6149.5 6164.3 6167.8 6185.0 6120.4 6266.0 6327.7 6328.8 6388.5 4156.0 4191.2 4196.6 4203.1 4208.2 6106.0 6125.7 6168.4 6170.2 6186.5 5849.6 5916.3 5943.7 5955.7 6001.9 5880.5 5895.5 5985.5 5990.2 6015.7 5608.8 5801.2 5842.0 5900.6 5906.0 5958.0 5963.3 5967.9 5981.6 6046.7 5773.2 5830.4 5854.5 5879.7 5885.6 06:04:53 INFO - PROCESS | 23050 | 06:04:53 INFO - PROCESS | 23050 | [#5] yui.html Cycles:180 Average:22863.56 Median:3836.66 stddev:34060.56 (887.8%) stddev-sans-first:34115.85 06:04:53 INFO - PROCESS | 23050 | Values: 809.6 819.8 836.8 847.1 868.7 13716.9 14495.8 14505.9 14515.6 14539.9 13282.2 13311.2 13319.2 13416.2 13440.5 765.3 767.9 787.4 789.5 791.1 780.8 782.4 788.6 788.7 796.5 860.9 865.5 865.8 868.2 868.6 853.0 858.4 861.4 862.5 862.5 624.8 625.6 628.3 628.7 631.0 14785.7 14887.0 14905.6 14969.8 15019.1 14941.4 15013.8 15061.2 15165.8 15345.5 12802.4 12838.0 12898.1 13085.8 13089.5 3759.3 3914.0 3919.8 3943.6 3948.8 87508.6 88482.6 88713.0 88777.6 88984.0 11322.6 11644.4 11646.1 11709.9 11820.3 22394.6 22399.7 22401.6 22408.6 22456.8 8669.5 8774.1 8853.2 9064.2 9251.5 4792.4 4802.5 4811.6 4866.3 4986.3 3500.5 3662.6 3663.1 3665.7 3665.9 607.1 610.0 611.8 617.1 618.3 657.3 668.7 692.3 696.4 704.3 8933.7 8971.5 9068.8 9224.1 9433.2 592.9 635.2 650.4 653.0 674.9 4206.1 4245.1 4324.8 4348.5 5481.5 119335.4 126869.0 129074.0 130536.3 131055.9 109384.7 113519.0 114229.4 114318.0 114628.4 96515.2 96971.0 97186.8 98386.0 99169.0 10047.8 10106.5 10110.5 10143.6 10225.9 56467.4 56689.7 57122.1 57675.4 58097.0 81759.6 83787.0 85606.6 87719.6 87795.0 13152.3 13666.1 13756.9 13767.1 13884.8 15167.5 15472.2 15605.2 15735.8 15807.7 14989.2 15003.7 15041.7 15128.2 16137.4 14378.9 14613.2 15138.7 15268.7 15445.3 15019.4 15094.5 15171.5 15492.6 15844.8 10300.6 10664.8 11001.5 11226.2 12270.0 10750.7 11560.9 11580.5 11642.1 11878.2 06:04:53 INFO - PROCESS | 23050 | -------- Summary: end -------- 06:04:53 INFO - PROCESS | 23050 | 06:04:53 INFO - TEST-INFO | 23050: exit 0 06:04:53 INFO - TEST-OK | dromaeo_css | took 1110868ms 06:04:53 INFO - TEST-START | kraken 06:04:53 INFO - operating with platform_type : linux_ 06:04:53 INFO - Initialising browser for kraken test... 06:04:53 INFO - TEST-INFO | started process 23302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS8lI96/profile http://localhost:43272/getInfo.html) 06:04:58 INFO - PROCESS | 23302 | __metrics Screen width/height:1600/1200 06:04:58 INFO - PROCESS | 23302 | colorDepth:24 06:04:58 INFO - PROCESS | 23302 | Browser inner width/height: 1024/697 06:04:58 INFO - PROCESS | 23302 | __metrics 06:04:59 ERROR - PROCESS | 23302 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 06:04:59 INFO - TEST-INFO | 23302: exit 0 06:04:59 INFO - Browser initialized. 06:04:59 INFO - Running cycle 1/1 for kraken test... 06:04:59 INFO - TEST-INFO | started process 23421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS8lI96/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:05:11 INFO - PROCESS | 23421 | RSS: Main: 167120896 06:05:11 INFO - PROCESS | 23421 | 06:05:14 INFO - PROCESS | 23421 | Cycle 1(1): loaded http://localhost:43272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43272/tests/kraken/driver.html?testName=audio-beat-detection) 06:05:15 INFO - PROCESS | 23421 | RSS: Main: 173080576 06:05:15 INFO - PROCESS | 23421 | 06:05:17 INFO - PROCESS | 23421 | Cycle 1(1): loaded http://localhost:43272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43272/tests/kraken/driver.html?testName=audio-dft) 06:05:18 INFO - PROCESS | 23421 | RSS: Main: 172974080 06:05:18 INFO - PROCESS | 23421 | 06:05:21 INFO - PROCESS | 23421 | Cycle 1(1): loaded http://localhost:43272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43272/tests/kraken/driver.html?testName=audio-fft) 06:05:21 INFO - PROCESS | 23421 | RSS: Main: 167677952 06:05:21 INFO - PROCESS | 23421 | 06:05:23 INFO - PROCESS | 23421 | Cycle 1(1): loaded http://localhost:43272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43272/tests/kraken/driver.html?testName=audio-oscillator) 06:05:24 INFO - PROCESS | 23421 | RSS: Main: 168341504 06:05:24 INFO - PROCESS | 23421 | 06:05:26 INFO - PROCESS | 23421 | Cycle 1(1): loaded http://localhost:43272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:05:27 INFO - PROCESS | 23421 | RSS: Main: 168738816 06:05:27 INFO - PROCESS | 23421 | 06:05:30 INFO - PROCESS | 23421 | Cycle 1(1): loaded http://localhost:43272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43272/tests/kraken/driver.html?testName=imaging-darkroom) 06:05:31 INFO - PROCESS | 23421 | RSS: Main: 168546304 06:05:31 INFO - PROCESS | 23421 | 06:05:34 INFO - PROCESS | 23421 | Cycle 1(1): loaded http://localhost:43272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43272/tests/kraken/driver.html?testName=imaging-desaturate) 06:05:35 INFO - PROCESS | 23421 | RSS: Main: 166801408 06:05:35 INFO - PROCESS | 23421 | 06:05:38 INFO - PROCESS | 23421 | Cycle 1(1): loaded http://localhost:43272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43272/tests/kraken/driver.html?testName=json-parse-financial) 06:05:38 INFO - PROCESS | 23421 | RSS: Main: 168185856 06:05:38 INFO - PROCESS | 23421 | 06:05:40 INFO - PROCESS | 23421 | Cycle 1(1): loaded http://localhost:43272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:05:40 INFO - PROCESS | 23421 | RSS: Main: 168742912 06:05:40 INFO - PROCESS | 23421 | 06:05:42 INFO - PROCESS | 23421 | Cycle 1(1): loaded http://localhost:43272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43272/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:05:43 INFO - PROCESS | 23421 | RSS: Main: 168972288 06:05:43 INFO - PROCESS | 23421 | 06:05:45 INFO - PROCESS | 23421 | Cycle 1(1): loaded http://localhost:43272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:05:46 INFO - PROCESS | 23421 | RSS: Main: 168865792 06:05:46 INFO - PROCESS | 23421 | 06:05:48 INFO - PROCESS | 23421 | Cycle 1(1): loaded http://localhost:43272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:05:49 INFO - PROCESS | 23421 | RSS: Main: 168976384 06:05:49 INFO - PROCESS | 23421 | 06:05:51 INFO - PROCESS | 23421 | Cycle 1(1): loaded http://localhost:43272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:05:52 INFO - PROCESS | 23421 | RSS: Main: 169021440 06:05:52 INFO - PROCESS | 23421 | 06:05:54 INFO - PROCESS | 23421 | Cycle 1(1): loaded http://localhost:43272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43272/tests/kraken/driver.html?testName=ai-astar) 06:05:54 INFO - PROCESS | 23421 | RSS: Main: 169758720 06:05:54 INFO - PROCESS | 23421 | 06:05:54 INFO - PROCESS | 23421 | __start_tp_report 06:05:54 INFO - PROCESS | 23421 | _x_x_mozilla_page_load 06:05:54 INFO - PROCESS | 23421 | _x_x_mozilla_page_load_details 06:05:54 INFO - PROCESS | 23421 | |i|pagename|runs| 06:05:54 INFO - PROCESS | 23421 | |0;ai-astar;104;112;106;114;114;113;113;111;112;111 06:05:54 INFO - PROCESS | 23421 | |1;audio-beat-detection;147;120;154;172;119;148;153;121;180;119 06:05:54 INFO - PROCESS | 23421 | |2;audio-dft;162;163;164;162;162;166;175;164;163;161 06:05:54 INFO - PROCESS | 23421 | |3;audio-fft;74;76;76;150;77;75;76;75;169;76 06:05:54 INFO - PROCESS | 23421 | |4;audio-oscillator;86;85;158;86;85;85;156;85;84;150 06:05:54 INFO - PROCESS | 23421 | |5;imaging-gaussian-blur;118;118;117;118;117;117;117;118;117;118 06:05:54 INFO - PROCESS | 23421 | |6;imaging-darkroom;149;146;146;146;148;147;147;147;149;146 06:05:54 INFO - PROCESS | 23421 | |7;imaging-desaturate;95;98;95;96;95;96;96;96;95;96 06:05:54 INFO - PROCESS | 23421 | |8;json-parse-financial;55;55;54;53;56;56;55;54;54;55 06:05:54 INFO - PROCESS | 23421 | |9;json-stringify-tinderbox;62;62;61;61;62;62;63;61;62;61 06:05:54 INFO - PROCESS | 23421 | |10;stanford-crypto-aes;79;77;77;76;77;77;78;77;87;77 06:05:54 INFO - PROCESS | 23421 | |11;stanford-crypto-ccm;120;118;128;125;134;133;127;132;157;130 06:05:54 INFO - PROCESS | 23421 | |12;stanford-crypto-pbkdf2;166;164;159;164;162;157;157;158;159;159 06:05:54 INFO - PROCESS | 23421 | |13;stanford-crypto-sha256-iterative;63;64;65;63;65;68;64;63;65;64 06:05:54 INFO - PROCESS | 23421 | __end_tp_report 06:05:54 INFO - PROCESS | 23421 | __start_cc_report 06:05:54 INFO - PROCESS | 23421 | _x_x_mozilla_cycle_collect,932 06:05:54 INFO - PROCESS | 23421 | __end_cc_report 06:05:54 INFO - PROCESS | 23421 | __startTimestamp1468328754525__endTimestamp 06:05:54 INFO - PROCESS | 23421 | 06:05:54 INFO - PROCESS | 23421 | ------- Summary: start ------- 06:05:54 INFO - PROCESS | 23421 | Number of tests: 14 06:05:54 INFO - PROCESS | 23421 | 06:05:54 INFO - PROCESS | 23421 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.50 stddev:3.37 (3.0%) stddev-sans-first:2.44 06:05:54 INFO - PROCESS | 23421 | Values: 104.0 112.0 106.0 114.0 114.0 113.0 113.0 111.0 112.0 111.0 06:05:54 INFO - PROCESS | 23421 | 06:05:54 INFO - PROCESS | 23421 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:150.50 stddev:22.70 (15.1%) stddev-sans-first:24.03 06:05:54 INFO - PROCESS | 23421 | Values: 147.0 120.0 154.0 172.0 119.0 148.0 153.0 121.0 180.0 119.0 06:05:54 INFO - PROCESS | 23421 | 06:05:54 INFO - PROCESS | 23421 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.50 stddev:4.05 (2.5%) stddev-sans-first:4.22 06:05:54 INFO - PROCESS | 23421 | Values: 162.0 163.0 164.0 162.0 162.0 166.0 175.0 164.0 163.0 161.0 06:05:54 INFO - PROCESS | 23421 | 06:05:54 INFO - PROCESS | 23421 | [#3] audio-fft Cycles:10 Average:92.40 Median:76.00 stddev:35.66 (46.9%) stddev-sans-first:37.19 06:05:54 INFO - PROCESS | 23421 | Values: 74.0 76.0 76.0 150.0 77.0 75.0 76.0 75.0 169.0 76.0 06:05:54 INFO - PROCESS | 23421 | 06:05:54 INFO - PROCESS | 23421 | [#4] audio-oscillator Cycles:10 Average:106.00 Median:85.00 stddev:33.65 (39.6%) stddev-sans-first:34.90 06:05:54 INFO - PROCESS | 23421 | Values: 86.0 85.0 158.0 86.0 85.0 85.0 156.0 85.0 84.0 150.0 06:05:54 INFO - PROCESS | 23421 | 06:05:54 INFO - PROCESS | 23421 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 06:05:54 INFO - PROCESS | 23421 | Values: 118.0 118.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 118.0 06:05:54 INFO - PROCESS | 23421 | 06:05:54 INFO - PROCESS | 23421 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:1.20 (0.8%) stddev-sans-first:1.05 06:05:54 INFO - PROCESS | 23421 | Values: 149.0 146.0 146.0 146.0 148.0 147.0 147.0 147.0 149.0 146.0 06:05:54 INFO - PROCESS | 23421 | 06:05:54 INFO - PROCESS | 23421 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.92 (1.0%) stddev-sans-first:0.93 06:05:54 INFO - PROCESS | 23421 | Values: 95.0 98.0 95.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 06:05:54 INFO - PROCESS | 23421 | 06:05:54 INFO - PROCESS | 23421 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:0.95 (1.7%) stddev-sans-first:1.00 06:05:54 INFO - PROCESS | 23421 | Values: 55.0 55.0 54.0 53.0 56.0 56.0 55.0 54.0 54.0 55.0 06:05:54 INFO - PROCESS | 23421 | 06:05:54 INFO - PROCESS | 23421 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 06:05:54 INFO - PROCESS | 23421 | Values: 62.0 62.0 61.0 61.0 62.0 62.0 63.0 61.0 62.0 61.0 06:05:54 INFO - PROCESS | 23421 | 06:05:54 INFO - PROCESS | 23421 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:77.00 stddev:3.19 (4.1%) stddev-sans-first:3.37 06:05:54 INFO - PROCESS | 23421 | Values: 79.0 77.0 77.0 76.0 77.0 77.0 78.0 77.0 87.0 77.0 06:05:54 INFO - PROCESS | 23421 | 06:05:54 INFO - PROCESS | 23421 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:131.00 stddev:10.74 (8.2%) stddev-sans-first:10.71 06:05:54 INFO - PROCESS | 23421 | Values: 120.0 118.0 128.0 125.0 134.0 133.0 127.0 132.0 157.0 130.0 06:05:54 INFO - PROCESS | 23421 | 06:05:54 INFO - PROCESS | 23421 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:160.50 stddev:3.24 (2.0%) stddev-sans-first:2.76 06:05:54 INFO - PROCESS | 23421 | Values: 166.0 164.0 159.0 164.0 162.0 157.0 157.0 158.0 159.0 159.0 06:05:54 INFO - PROCESS | 23421 | 06:05:54 INFO - PROCESS | 23421 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.50 stddev:1.51 (2.3%) stddev-sans-first:1.51 06:05:54 INFO - PROCESS | 23421 | Values: 63.0 64.0 65.0 63.0 65.0 68.0 64.0 63.0 65.0 64.0 06:05:54 INFO - PROCESS | 23421 | -------- Summary: end -------- 06:05:54 INFO - PROCESS | 23421 | 06:05:55 INFO - TEST-INFO | 23421: exit 0 06:05:55 INFO - TEST-OK | kraken | took 61547ms 06:05:55 INFO - SUITE-END | took 1172s 06:05:55 INFO - Completed test suite (00:19:32) 06:05:55 INFO - javascript benchmark 06:05:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7192.863951498146, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3057.1134371032404, 3133.3889891471144, 3141.874325026999, 3155.0534839548145, 3158.542011408346, 5539.279893613824, 5570.832875013751, 5589.441055894414, 5600.103983362663, 5619.100943848985, 5352.063388906936, 5465.808696695616, 5472.425395333493, 5524.779008839641, 5554.1113421852515, 4954.281629163778, 4982.5764809991015, 5061.797528098871, 5106.004329155816, 5147.1764517677175, 769.8826184449747, 5024.924626130611, 5071.391433028042, 5094.414142373619, 5109.616778741591, 5012.147934851084, 5037.1940489521685, 5041.873953151182, 5049.141645920203, 5097.898042039175, 4969.52789485002, 5068.290439338459, 5074.441811400743, 5082.669626474304, 5100.5919526438165, 4961.0, 4999.925001124986, 5012.8997420051755, 5063.215201643751, 5063.291139240509, 5479.232907392969, 5521.834344969658, 5532.75102620383, 5570.053090974544, 5576.275084239063, 5728.112142617901, 5759.078547432433, 5765.365809760923, 5967.403259673998, 5978.671173085479, 5807.157962095514, 5809.593328467009, 5811.941880581182, 5823.592348535604, 5925.762969481216, 5441.537469315113, 5461.098918678414, 5463.590230732711, 5465.726713664301, 5472.7263636818, 5838.4453476919625, 5959.374265702126, 6050.515958723292, 6113.083037544315, 6124.448799608057, 5895.20414744004, 5904.3210030847, 5904.468597826216, 5905.261842269716, 5907.966105931445, 5969.403059693996, 5970.0746384310505, 5970.701464926737, 5992.0712289595185, 5996.4603185713495, 5668.121441176624, 5810.50610698087, 5814.069748840166, 5841.269841269841, 5890.293164820163, 5696.11710184922, 5810.302763668386, 5843.503302219359, 5888.61723987948, 5904.143899134601, 4297.957020429818, 4317.07182955666, 4344.283193273138, 4345.869623911288, 4374.671899607542, 3789.5452545694693, 3835.2904712627696, 3837.328467518173, 3870.3613903706137, 3904.8871071744416, 5612.691301978349, 5692.1461780733225, 5693.231413759172, 5693.68684722336, 5696.715164241771, 5946.940530594725, 6005.849853753691, 6006.189164462829, 6018.518518518508, 6033.5173186145, 5470.480304371078, 5531.9723401382735, 5594.804181853616, 5597.720113994284, 5606.131049687305, 4931.876703082452, 4957.454679985199, 4974.452810190876, 4976.7262800545595, 5016.724080175552, 5956.55325850563, 6119.785807496716, 6125.387461253839, 6129.908051379233, 6132.724027418777, 5876.206712093898, 5901.085331773582, 5917.881642367042, 5949.315828679757, 5954.285485741739, 6060.515158787198, 6113.23584551931, 6128.693565321627, 6139.079138129317, 6145.84635384119, 5703.515201207943, 5768.913466298093, 5811.215485909348, 5830.18377427169, 5836.387179346108, 5891.3224979127945, 5927.14056461802, 5953.76184952597, 5959.523238141025, 6017.729202185999, 5736.370627066076, 5785.4214578541805, 5791.247137872218, 5802.564807639359, 5825.184474173534, 5556.583256255878, 5774.538036957118, 5783.045797443375, 5799.565032622486, 5813.970930145322, 5580.079286917776, 5645.576581756302, 5661.575381846295, 5664.26364572603, 5839.883202336015, 5793.275840519935, 5809.535237180931, 5835.241418615553, 5857.033589457692, 5860.208871802252, 5572.136318870582, 5622.88754224905, 5646.040173170653, 5696.629719068247, 5697.515711164431], "value": 5395.451566701763, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.6435853480342, 577.1054864959314, 589.1898639370868, 605.4611395857687, 634.6953462338081, 39386.2122757545, 43154.19497732645, 43263.78368108155, 43266.0, 43648.34527482082, 43590.78204608973, 43875.56124438754, 44137.77931110348, 44138.0, 44305.335419968724, 8759.693410730626, 8850.247728943048, 8920.643174273022, 8922.420042697237, 8941.239994600466, 8702.738917832476, 8777.2100510954, 8846.292296616255, 8848.159424854628, 8852.867206991868, 8871.911280887205, 8879.689210877621, 8879.845620069382, 8881.955590222073, 8901.154390332907, 8744.650213991432, 8839.558022098869, 8850.73447796567, 8859.424137431079, 8869.822603547893, 8782.912170878273, 8867.600957956907, 8868.201861832466, 8872.645094196225, 8899.777505562348, 40937.0, 41499.792501037606, 41811.1637767246, 41819.7909010453, 41905.58094419047, 3383.2649745388344, 3486.755927085105, 3490.3542844573835, 3580.9283814323567, 3942.369220924667, 33630.49554256688, 33634.66365336364, 34038.48942265868, 34189.145271368165, 35343.4698479523, 4353.28170851809, 4353.608175264241, 4384.101259241847, 4413.492448368414, 4427.2695005324085, 374628.0, 375863.0, 376858.0, 378422.0, 379755.10122449487, 31583.368332633218, 32519.349613008082, 32565.674343256265, 56829.147562786595, 57002.714986424806, 37495.43756843649, 37560.812195938845, 37570.43644345337, 37655.4351684725, 37770.81114594409, 15335.386584536494, 15526.611834703997, 15554.066755994676, 15567.922160389126, 15682.0, 12995.870041299655, 12998.870011299767, 13064.412101455457, 13070.934645326712, 13104.541341053207, 7695.153533111354, 7758.340541053961, 7797.415193860483, 7802.570858602831, 7802.960985195151, 3216.4371235033777, 3278.0821370016433, 3280.5899262592175, 3295.538624592559, 3325.93348133036, 1045.602670985036, 1047.1988928469727, 1064.9787004260027, 1134.6766171641043, 1139.2537887683582, 33364.332713346084, 33651.495227571606, 33810.154746131055, 34091.659083409344, 34436.48345274823, 1104.045001074065, 1122.7417693930443, 1130.6155906991662, 1131.5134492168447, 1225.7180848404917, 17579.56051098707, 17663.470095897144, 17679.20443580042, 17719.29122835098, 17791.0, 600411.0, 605443.0, 612426.0, 612877.0, 614978.0, 60129.091609045274, 60610.69694651499, 60642.393576063674, 60655.393446064976, 60726.39273607296, 1290.7676618208814, 1333.9333033348294, 1356.2405053170257, 1359.4358341288453, 1372.876441120304, 32427.837860811487, 33390.497427616305, 33451.163720906196, 33650.0, 34083.0, 52492.737536312074, 53075.20387194272, 53243.201351980526, 53253.0, 53364.0, 516025.0, 516557.0, 516963.0, 519378.0, 520986.0, 27877.581836272067, 28936.42127157403, 29230.415391691622, 29247.122586322443, 29265.0, 48837.51162488329, 49347.25979110388, 49753.751231243616, 50614.24078638897, 50824.0, 41674.791626041675, 41799.7910010448, 42396.57603423926, 42815.78592107019, 43551.564484356015, 42933.0, 43488.34767478554, 43556.34665479957, 43640.345394819735, 43902.78048609736, 41861.0, 42102.789486052374, 43258.134837302445, 43280.567194327654, 43322.0, 36809.81595092007, 37331.44002840014, 38066.55864389879, 38204.0, 38457.615423845404, 28679.42641147207, 28918.770118990276, 29113.126606201848, 29260.122196334145, 29471.85264073666], "value": 19258.875030101197, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.3245219544091, 393.1645253835599, 394.85193052605274, 401.95578486366503, 414.64547811621065, 15588.454404095859, 18670.253189872405, 19659.0, 20433.386998390033, 20510.38468845935, 19335.516612084706, 19600.411987640357, 19724.901375493104, 19780.208791648318, 19781.208751649952, 5702.8289151325525, 5860.003799354099, 5890.941090589104, 5891.145783861338, 5892.528597712194, 5618.831435056954, 5778.0, 5798.82603521895, 5843.2695913010875, 5862.4430679085635, 5525.502704756571, 5732.111522713965, 5739.512141467981, 5792.478676919098, 5815.360310365856, 5718.085106382959, 5740.9712951435395, 5747.080467125261, 5773.451522105393, 5843.912341314884, 5189.1697328427645, 5204.34945631796, 5217.191335343028, 5217.947820521822, 5221.843344699665, 15118.848811511854, 20628.0, 21823.890880545656, 22002.339929802132, 22594.661080083813, 2222.9110835566557, 2408.373822806083, 2474.418511649761, 2770.612114303999, 2820.3513191965963, 9358.812823743556, 9955.950220248926, 10116.49417529128, 10136.442495662735, 10360.740981475448, 1805.4673871208024, 1873.8969356685377, 1902.9714554281697, 1912.540990162351, 1917.7794553626372, 80594.59702701449, 81649.18350816476, 83145.0, 83851.58074209651, 87154.56422717909, 10528.526216320284, 10726.892731072745, 10796.406197659047, 10812.67561973142, 10917.672469825759, 13059.477620895248, 13813.930930345485, 14708.0, 14760.852391476163, 14801.703965920622, 7820.139784623687, 7884.9355337028765, 7974.960125199337, 8087.757367278991, 8162.265396114378, 7720.0735911689835, 7772.300492955661, 7820.804479888048, 7957.960210198912, 8001.839963200703, 4565.178267911741, 4577.404937358188, 4583.991521865251, 4586.564276393738, 4645.140648979949, 1922.3279641298607, 1959.4513536209884, 1967.2524440712723, 1982.1972101298998, 1986.9900650496654, 394.95655477897407, 399.28129367139616, 400.0758248446041, 887.3655336434481, 1009.6112996496402, 10690.679279621623, 11015.228933974706, 11057.889421105687, 11326.43367831605, 11363.0, 425.23245541797354, 426.75674865326465, 429.30238362660674, 429.38383419792075, 449.6065942300487, 5903.144044113579, 5975.581709280309, 5985.25184351956, 6072.089186622042, 6093.542984276197, 471076.0, 471509.0, 472134.0, 483574.0, 496334.0, 87706.56146719225, 98868.0, 99561.0, 99793.50103249437, 100481.0, 452.7622997926115, 454.7362529732747, 457.2866328527441, 460.6568106760485, 462.2834606360195, 10235.846462302923, 10698.41158736277, 10816.891831081903, 10859.2398532102, 10880.67357979262, 36730.081747956516, 42001.0, 42630.57369426266, 44137.11725765403, 44892.55107448884, 64936.35063649492, 65015.67492162509, 65455.34544654683, 66089.0, 67145.0, 7357.5217610855125, 8432.494050356998, 8667.739967800977, 8681.6093275804, 8771.0, 11675.708107297385, 13764.724705506034, 13765.518206862711, 13999.650008749863, 14038.719225615227, 11231.775364492501, 12280.938595307323, 12318.322492263012, 12359.938200308941, 12671.366431678194, 12222.144449888778, 12268.325242111412, 12504.374781260718, 12651.683707907376, 12781.8082728761, 12026.0, 12750.48998040068, 12790.36048197605, 12818.55135070268, 12915.612531624067, 8539.871901921351, 8569.143085691381, 8610.569471526524, 8723.825284239421, 8991.865122023044, 5744.080947048452, 8835.867461988204, 11302.547898083985, 11473.82789258145, 12090.153689241668], "value": 8310.87274290937, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1385.0650810702773, 1456.075392126, 1538.776877352784, 1762.9206685699141, 1763.0655752451205, 7707.807304817368, 8508.14918508149, 8641.351898607614, 9133.497657628828, 9151.816963660724, 8710.956445217766, 8936.91063089369, 8939.776505587348, 9010.954945225281, 9028.729138125867, 2138.2409244718133, 2171.945701357463, 2180.2042254577045, 2192.5286063496346, 2194.8024677779, 2226.5769503794227, 2255.8872056397195, 2319.7241517165576, 2329.10329523134, 2329.5457385809773, 2280.8859557022083, 2284.49741056968, 2288.2448791898632, 2288.794008539231, 2314.2941402872116, 2253.290213582716, 2268.6143355629583, 2270.1260014894383, 2274.943126421836, 2275.0444813178506, 2174.554216385653, 2189.5839790439763, 2191.0687957617947, 2199.450137465634, 2210.7899749523767, 9050.77373065672, 9109.089091090838, 9151.542422878829, 9169.633214671472, 9240.260779137652, 5191.273221748958, 5275.155975043975, 5278.996990571779, 5283.392409872837, 5300.09898317287, 3185.5062465317915, 3230.4185246655593, 3233.3210025894355, 3245.415825151472, 3285.6878596533293, 1094.5402930769096, 1116.6929094498996, 1126.0822429719751, 1131.5360702112096, 1140.8573928258968, 12663.430145643468, 12709.300988445631, 12755.298458584773, 12774.680632984157, 12786.232826030375, 4430.4683437987005, 4508.932366014513, 4649.395578574831, 4660.673752837337, 4704.7412392318065, 10570.577176912991, 10651.627193048205, 10692.251542392114, 10713.410762407986, 10740.194485413625, 5327.413984461706, 5356.7857285708915, 5365.597580181424, 5368.0605893968395, 5374.892502149935, 4342.109867477159, 4773.618110551148, 4936.358273424432, 4955.628327875352, 4978.850634480971, 3897.376419772823, 3986.242613903349, 4042.706333973159, 4121.0, 4195.853145139906, 1250.6248125562477, 1267.8922291605131, 1274.7195616964252, 1275.222114510148, 1275.5726831511363, 900.9864852027225, 986.9605215791431, 1003.0471052500009, 1005.1556692378291, 1014.6099843214843, 6085.056816193497, 6097.573169878155, 6117.327094019654, 6138.631682099089, 6163.044728067157, 419.4274814877731, 422.65342419216563, 428.5992596921888, 444.97330160190495, 445.14754245619275, 4023.1350259694304, 4199.643030342455, 4252.21334053195, 4262.104957958863, 4273.957260427418, 11130.944345278222, 11456.94271528637, 11510.597129100608, 11554.711132221593, 11584.652460426201, 10203.540840662188, 10706.78586428267, 10718.624848130277, 11317.603883864025, 11377.829332560019, 8323.875141872877, 8445.873311900326, 8448.66205351779, 8469.491830490191, 8527.147285271547, 5988.730507127103, 6347.5239357047485, 6348.650824204528, 6348.77779277723, 6375.171227740364, 10524.52639631203, 10573.52419141156, 10611.363318200623, 10618.787624247318, 10628.256022078689, 9948.850767238353, 10333.948330258301, 10398.74003149897, 10591.788164236827, 10722.624708135178, 7166.426685865223, 7702.191269916578, 7940.126586075412, 8027.5584842834205, 8041.517508949481, 8783.912160878564, 8847.823043539222, 8874.64501419936, 8894.86657700148, 8897.866532001895, 7838.255365740246, 8098.473599216032, 8140.308073813555, 8149.877751833608, 8187.71343002992, 7667.884981725167, 7786.532808031537, 7789.922100778919, 7815.804604884924, 7904.920950790419, 6960.37356637905, 7251.746188883575, 7322.926770732438, 7340.632968351668, 7349.70601175947, 5213.270142180174, 5215.504527069922, 5287.735613219246, 5306.97346513265, 5355.785768569213, 5182.455842136521, 5183.792648294026, 5260.8158714446345, 5305.0, 5430.8099216527235], "value": 4594.838511240252, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.8632081365421, 322.85632893362447, 328.8914658162805, 329.2378144595261, 333.81640097946126, 5647.548196144309, 5696.174054762057, 5705.971470142654, 5708.743106560204, 5730.914036289459, 5564.522173641474, 5573.191887176357, 5582.637128586639, 5584.21820945068, 5613.494785469307, 4027.7180597358197, 4277.893052673677, 4419.712718673276, 4425.623821975128, 4429.889252768674, 4246.57534246576, 4279.8502052428175, 4299.763513006784, 4305.225059489307, 4325.329573916048, 4199.7610704842145, 4254.553271906451, 4287.356896465524, 4299.398084268205, 4303.978480107595, 4108.465899433069, 4142.7571728481635, 4241.257779888522, 4254.553271906467, 4294.957050429518, 3733.253349330145, 3733.869314574004, 3734.439834024918, 3741.681957033655, 3753.549574051104, 5470.699111548864, 5487.670739755587, 5492.862678433031, 5513.145462453326, 5533.363663178746, 4774.594159496447, 4866.732329721864, 4906.9263961040615, 4908.607311415079, 4918.729469879156, 5754.74103665336, 5766.106253530709, 5780.132980052984, 5841.6495010299095, 5845.649261044308, 4102.8512016635095, 4107.466029416187, 4111.97944010278, 4115.855945041909, 4117.794110294473, 5824.213731146283, 6070.787522436738, 6072.449571180071, 6093.542984276152, 6111.180512179888, 4199.853005144805, 4203.62167404935, 4222.662187025031, 4225.535191128974, 4226.936595951063, 4247.830086796555, 4252.128313695747, 4267.445232119804, 4271.206093440763, 4271.504973259396, 4773.713577185311, 4890.0, 4912.1649319615035, 4931.18635425158, 4932.950670493249, 5885.322683035314, 5893.528517718572, 5922.466977972003, 5953.166556682068, 5961.0, 1472.5789613023485, 1473.336998350725, 1486.9925650371679, 1490.2250829568563, 1490.3144553505508, 946.7159852044359, 947.7535840681335, 994.9701508954743, 998.5007496251874, 998.8451789972565, 5565.9443405566235, 5584.301962254718, 5605.607607467519, 5613.73690919548, 5651.519620832275, 5970.492508136857, 5972.790952316648, 5980.372060933626, 6003.8198854034445, 6063.090126610104, 5492.539699988982, 5561.805336813273, 5601.383847776741, 5633.436656334334, 5703.173039909273, 3197.0, 3211.8394080295893, 3217.905911989935, 3241.546183534307, 3264.967350326466, 6048.60684055535, 6255.437010669061, 6264.624122552661, 6273.560850740496, 6342.207224096988, 6253.499720022387, 6261.812145635638, 6268.919148426019, 6270.404311590391, 6272.560920735505, 6291.528135389773, 6320.652364120017, 6322.304546499881, 6333.303336633059, 6351.841203969938, 5831.300243970751, 6101.969490152521, 6185.350538193425, 6214.223222097238, 6233.407826256498, 6098.908516372347, 6149.508039356931, 6164.260288765377, 6167.784127555514, 6185.0, 6120.409692730452, 6265.968670156803, 6327.683615819283, 6328.841778955563, 6388.4569811566535, 4155.958440415558, 4191.161767646422, 4196.580341965779, 4203.07532342884, 4208.242516347087, 6106.0, 6125.663088530174, 6168.383161683975, 6170.167027451416, 6186.5360097993735, 5849.636459035986, 5916.31962324321, 5943.673097979479, 5955.702214889325, 6001.9196544620645, 5880.529557635465, 5895.469407753323, 5985.456181123092, 5990.1913241713555, 6015.729292181775, 5608.803691870765, 5801.1878337032, 5842.036064049385, 5900.64596124234, 5905.970470147794, 5958.0, 5963.344032156372, 5967.880642387041, 5981.641101533748, 6046.727897244723, 5773.24947756789, 5830.416958304136, 5854.502367298827, 5879.677072658788, 5885.588008839341], "value": 4465.334607393587, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [809.6356639512218, 819.8442295963766, 836.8451836410264, 847.063994286314, 868.7133246028809, 13716.862831371684, 14495.782563261546, 14505.854941450581, 14515.637109072279, 14539.854601453982, 13282.203067815937, 13311.201327920331, 13319.20084794913, 13416.195028298309, 13440.521542630328, 765.3494529649809, 767.8617848787216, 787.4369825574713, 789.486833558186, 791.1258059843876, 780.7657702689199, 782.3662833105175, 788.5781107107698, 788.6529926832204, 796.4822865137648, 860.9440386374897, 865.523961820999, 865.8268346330727, 868.1752335281476, 868.6178081644088, 853.0062477214069, 858.3776761847673, 861.3970220845401, 862.525610914001, 862.5471627395636, 624.7969409941787, 625.6371304643296, 628.3151365012113, 628.6510986402545, 631.0124654915044, 14785.70428591433, 14887.0, 14905.627359316104, 14969.775453368207, 15019.09885406879, 14941.402343906231, 15013.774793378108, 15061.17163556004, 15165.772513412197, 15345.46290879825, 12802.42389092493, 12838.0, 12898.09713320068, 13085.803712944313, 13089.541866034739, 3759.342115129841, 3913.9804300978312, 3919.8432062717457, 3943.605639436062, 3948.822302996372, 87508.5624571873, 88482.55758721165, 88713.0, 88777.55611221967, 88984.0, 11322.63729246482, 11644.35956022427, 11646.126540509496, 11709.882901170879, 11820.349880756468, 22394.55210895773, 22399.664005039936, 22401.551968960855, 22408.551828963657, 22456.775432245468, 8669.479831210148, 8774.122587741302, 8853.247473964786, 9064.184223419792, 9251.491167985825, 4792.400949881265, 4802.543758342952, 4811.639127065484, 4866.343043689057, 4986.252062190628, 3500.5274287971306, 3662.6337366263692, 3663.102539877747, 3665.706743460517, 3665.87169449068, 607.1227076873963, 609.9908501372483, 611.7522403426619, 617.1483352972958, 618.2889676871633, 657.2999755260632, 668.7124536449277, 692.3388164303078, 696.3732640623379, 704.2781149321884, 8933.729099831131, 8971.50656713874, 9068.81862362749, 9224.123708247706, 9433.245340372754, 592.9407059294123, 635.1711017122699, 650.3626446082865, 652.9967350163218, 674.8717743628695, 4206.11671548972, 4245.108527209259, 4324.8486302979245, 4348.521662617173, 5481.5340696041285, 119335.40332298283, 126869.0, 129074.0, 130536.34731826281, 131055.89441056008, 109384.65383654086, 113519.0, 114229.4288528552, 114318.0, 114628.42685786518, 96515.20908745498, 96971.0, 97186.7953864834, 98386.0, 99169.0, 10047.849282260919, 10106.545205465625, 10110.545025473724, 10143.594256229668, 10225.897741022793, 56467.43532564622, 56689.716551416976, 57122.14316785335, 57675.42324576868, 58097.0, 81759.59120204361, 83787.0, 85606.57196713977, 87719.56140219513, 87795.0, 13152.276624785345, 13666.11170273929, 13756.887652250298, 13767.105138165987, 13884.791728123884, 15167.544973650809, 15472.226388680747, 15605.219739013231, 15735.842641573896, 15807.68384632278, 14989.175595342362, 15003.699926001636, 15041.6991660164, 15128.243587820785, 16137.435189768301, 14378.856211437751, 14613.19627420502, 15138.697226055197, 15268.694626107193, 15445.304961276994, 15019.399224030916, 15094.54716358511, 15171.544853654408, 15492.612684682974, 15844.841551584797, 10300.587976480856, 10664.84002739944, 11001.504932277907, 11226.214165008698, 12270.0, 10750.67291396664, 11560.94219528897, 11580.478878450322, 11642.126840487166, 11878.168528202943], "value": 7815.218142522456, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1527.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 106.0, 114.0, 114.0, 113.0, 113.0, 111.0, 112.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 120.0, 154.0, 172.0, 119.0, 148.0, 153.0, 121.0, 180.0, 119.0], "value": 143.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 162.0, 162.0, 166.0, 175.0, 164.0, 163.0, 161.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 150.0, 77.0, 75.0, 76.0, 75.0, 169.0, 76.0], "value": 92.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 158.0, 86.0, 85.0, 85.0, 156.0, 85.0, 84.0, 150.0], "value": 106.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 146.0, 146.0, 146.0, 148.0, 147.0, 147.0, 147.0, 149.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 98.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 53.0, 56.0, 56.0, 55.0, 54.0, 54.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 61.0, 62.0, 62.0, 63.0, 61.0, 62.0, 61.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 77.0, 76.0, 77.0, 77.0, 78.0, 77.0, 87.0, 77.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 118.0, 128.0, 125.0, 134.0, 133.0, 127.0, 132.0, 157.0, 130.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 159.0, 164.0, 162.0, 157.0, 157.0, 158.0, 159.0, 159.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 63.0, 65.0, 68.0, 64.0, 63.0, 65.0, 64.0], "value": 64.4, "unit": "score"}]}]} 06:05:55 INFO - Return code: 0 06:05:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:05:55 ERROR - # TBPL SUCCESS # 06:05:55 INFO - Running post-action listener: _resource_record_post_action 06:05:55 INFO - ##### 06:05:55 INFO - ##### Finished run-tests step (success) 06:05:55 INFO - ##### 06:05:55 INFO - Running post-run listener: _resource_record_post_run 06:05:55 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 554389504; Read time: 24; Write time: 418848 06:05:55 INFO - TinderboxPrint: CPU usage
13.3% 06:05:55 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 06:05:55 INFO - TinderboxPrint: I/O write bytes / time
554,389,504 / 418,848 06:05:55 INFO - TinderboxPrint: CPU idle
8,233.0 (86.7%) 06:05:55 INFO - TinderboxPrint: CPU user
1,210.8 (12.7%) 06:05:55 INFO - TinderboxPrint: Swap in / out
0 / 0 06:05:55 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 263122944; Read time: 0; Write time: 237160 06:05:55 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291266560; Read time: 8; Write time: 181688 06:05:56 INFO - Running post-run listener: _upload_blobber_files 06:05:56 INFO - Blob upload gear active. 06:05:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:05:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:05:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:05:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:05:56 INFO - (blobuploader) - INFO - Open directory for files ... 06:05:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:05:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:05:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:05:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:05:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:05:57 INFO - (blobuploader) - INFO - Done attempting. 06:05:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:05:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:05:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:06:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:01 INFO - (blobuploader) - INFO - Done attempting. 06:06:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:06:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:06:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:02 INFO - (blobuploader) - INFO - Done attempting. 06:06:02 INFO - (blobuploader) - INFO - Iteration through files over. 06:06:02 INFO - Return code: 0 06:06:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:06:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:06:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03d2a55759dd4844dcadaf043b9e61eadf7afb69f1682fb4ac9c3f90cacbbd8dce0b80c11133696fc50a77dfa3fc73c894aa6314c11c29443188e5dd46f5a5fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1a50b7e7534b1f81b7fcb756feff906b0d99f38db8dbda351064c1ef248e934edd2eaefb84fa232399e5696063cb319c58413080f44b52b56e5a8af0fe7b03c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4348985e6a7be004f2956d8c76a93383bfaa38c73b3f0be2a3c61fdce7a4da48fc670d5bc2add3bb0a71c92e2544b937192ecd2390a5fccd82c59cf7951a5f9"} 06:06:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:06:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:06:02 INFO - Contents: 06:06:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03d2a55759dd4844dcadaf043b9e61eadf7afb69f1682fb4ac9c3f90cacbbd8dce0b80c11133696fc50a77dfa3fc73c894aa6314c11c29443188e5dd46f5a5fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1a50b7e7534b1f81b7fcb756feff906b0d99f38db8dbda351064c1ef248e934edd2eaefb84fa232399e5696063cb319c58413080f44b52b56e5a8af0fe7b03c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4348985e6a7be004f2956d8c76a93383bfaa38c73b3f0be2a3c61fdce7a4da48fc670d5bc2add3bb0a71c92e2544b937192ecd2390a5fccd82c59cf7951a5f9"} 06:06:02 INFO - Running post-run listener: copy_logs_to_upload_dir 06:06:02 INFO - Copying logs to upload dir... 06:06:02 INFO - mkdir: /builds/slave/test/build/upload/logs 06:06:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.538814 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-12 06:06:02.106314) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 06:06:02.109796) ========= 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=337fe3f4b1febe37b85fccc40000019e-1468327528.630281-599773880 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/03d2a55759dd4844dcadaf043b9e61eadf7afb69f1682fb4ac9c3f90cacbbd8dce0b80c11133696fc50a77dfa3fc73c894aa6314c11c29443188e5dd46f5a5fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1a50b7e7534b1f81b7fcb756feff906b0d99f38db8dbda351064c1ef248e934edd2eaefb84fa232399e5696063cb319c58413080f44b52b56e5a8af0fe7b03c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4348985e6a7be004f2956d8c76a93383bfaa38c73b3f0be2a3c61fdce7a4da48fc670d5bc2add3bb0a71c92e2544b937192ecd2390a5fccd82c59cf7951a5f9"} build_url:https://queue.taskcluster.net/v1/task/QPxo2yWnTgu3WeCgIc8r4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011212 build_url: 'https://queue.taskcluster.net/v1/task/QPxo2yWnTgu3WeCgIc8r4A/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/03d2a55759dd4844dcadaf043b9e61eadf7afb69f1682fb4ac9c3f90cacbbd8dce0b80c11133696fc50a77dfa3fc73c894aa6314c11c29443188e5dd46f5a5fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1a50b7e7534b1f81b7fcb756feff906b0d99f38db8dbda351064c1ef248e934edd2eaefb84fa232399e5696063cb319c58413080f44b52b56e5a8af0fe7b03c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4348985e6a7be004f2956d8c76a93383bfaa38c73b3f0be2a3c61fdce7a4da48fc670d5bc2add3bb0a71c92e2544b937192ecd2390a5fccd82c59cf7951a5f9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 06:06:02.138185) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 06:06:02.138785) ========= 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=337fe3f4b1febe37b85fccc40000019e-1468327528.630281-599773880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 06:06:02.223357) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 06:06:02.223704) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 06:06:02.224047) ========= ========= Total master_lag: 0.18 =========