builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-058 starttime: 1468275213.14 results: success (0) buildid: 20160711135528 builduid: f6213b0e1d52462b997b17c0724fb4ef revision: 6b329e5cac8634acbfb8a10bcfc441f7498bab23 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 15:13:33.139122) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 15:13:33.139500) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 15:13:33.139849) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 15:13:33.161364) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 15:13:33.161632) ========= 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=0e2a256762fed810e2f0f810000001b3-1468272487.516176-340079855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-11 15:13:34-- 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% 46.4M=0s 2016-07-11 15:13:34 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072092 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 15:13:33.249015) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 15:13:33.249332) ========= 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=0e2a256762fed810e2f0f810000001b3-1468272487.516176-340079855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018209 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 15:13:33.299064) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 15:13:33.299418) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6b329e5cac8634acbfb8a10bcfc441f7498bab23 --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 6b329e5cac8634acbfb8a10bcfc441f7498bab23 --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=0e2a256762fed810e2f0f810000001b3-1468272487.516176-340079855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-11 15:13:34,704 truncating revision to first 12 chars 2016-07-11 15:13:34,704 Setting DEBUG logging. 2016-07-11 15:13:34,704 attempt 1/10 2016-07-11 15:13:34,704 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6b329e5cac86?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 15:13:35,012 unpacking tar archive at: mozilla-central-6b329e5cac86/testing/mozharness/ program finished with exit code 0 elapsedTime=0.621416 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 15:13:33.933938) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 15:13:33.934263) ========= script_repo_revision: 6b329e5cac8634acbfb8a10bcfc441f7498bab23 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 15:13:33.934646) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 15:13:33.934941) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 15:13:33.943914) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-11 15:13:33.944218) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1468272487.516176-340079855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:13:35 INFO - MultiFileLogger online at 20160711 15:13:35 in /builds/slave/test 15:13:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:13:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:13:35 INFO - {'append_to_log': False, 15:13:35 INFO - 'base_work_dir': '/builds/slave/test', 15:13:35 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:13:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:13:35 INFO - 'branch': 'Firefox-Non-PGO', 15:13:35 INFO - 'buildbot_json_path': 'buildprops.json', 15:13:35 INFO - 'config_files': ('talos/linux_config.py',), 15:13:35 INFO - 'default_actions': ('clobber', 15:13:35 INFO - 'read-buildbot-config', 15:13:35 INFO - 'download-and-extract', 15:13:35 INFO - 'populate-webroot', 15:13:35 INFO - 'create-virtualenv', 15:13:35 INFO - 'install', 15:13:35 INFO - 'run-tests'), 15:13:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:13:35 INFO - 'download_minidump_stackwalk': True, 15:13:35 INFO - 'download_symbols': 'ondemand', 15:13:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:13:35 INFO - 'tooltool.py': '/tools/tooltool.py', 15:13:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:13:35 INFO - '/tools/misc-python/virtualenv.py')}, 15:13:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:13:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:13:35 INFO - 'installer_path': 'installer.exe', 15:13:35 INFO - 'log_level': 'info', 15:13:35 INFO - 'log_name': 'talos', 15:13:35 INFO - 'log_to_console': True, 15:13:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:13:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:13:35 INFO - 'opt_config_files': (), 15:13:35 INFO - 'pip_index': False, 15:13:35 INFO - 'sps_profile': False, 15:13:35 INFO - 'sps_profile_interval': 0, 15:13:35 INFO - 'suite': 'dromaeojs-e10s', 15:13:35 INFO - 'system_bits': '32', 15:13:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:13:35 INFO - 'title': 'talos-linux64-ix-058', 15:13:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:13:35 INFO - 'use_talos_json': True, 15:13:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:13:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:13:35 INFO - 'work_dir': 'build'} 15:13:35 INFO - ##### 15:13:35 INFO - ##### Running clobber step. 15:13:35 INFO - ##### 15:13:35 INFO - Running pre-action listener: _resource_record_pre_action 15:13:35 INFO - Running main action method: clobber 15:13:35 INFO - rmtree: /builds/slave/test/build 15:13:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:13:36 INFO - Running post-action listener: _resource_record_post_action 15:13:36 INFO - ##### 15:13:36 INFO - ##### Finished clobber step (success) 15:13:36 INFO - ##### 15:13:36 INFO - ##### 15:13:36 INFO - ##### Running read-buildbot-config step. 15:13:36 INFO - ##### 15:13:36 INFO - Running pre-action listener: _resource_record_pre_action 15:13:36 INFO - Running main action method: read_buildbot_config 15:13:36 INFO - Using buildbot properties: 15:13:36 INFO - { 15:13:36 INFO - "project": "", 15:13:36 INFO - "product": "firefox", 15:13:36 INFO - "script_repo_revision": "production", 15:13:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:13:36 INFO - "repository": "", 15:13:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 15:13:36 INFO - "buildid": "20160711135528", 15:13:36 INFO - "pgo_build": "False", 15:13:36 INFO - "basedir": "/builds/slave/test", 15:13:36 INFO - "buildnumber": 395, 15:13:36 INFO - "slavename": "talos-linux64-ix-058", 15:13:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:13:36 INFO - "platform": "ubuntu64_hw", 15:13:36 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:13:36 INFO - "branch": "mozilla-central", 15:13:36 INFO - "repo_path": "mozilla-central", 15:13:36 INFO - "revision": "6b329e5cac8634acbfb8a10bcfc441f7498bab23", 15:13:36 INFO - "stage_platform": "linux64", 15:13:36 INFO - "builduid": "f6213b0e1d52462b997b17c0724fb4ef", 15:13:36 INFO - "slavebuilddir": "test" 15:13:36 INFO - } 15:13:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:13:36 INFO - Running post-action listener: _resource_record_post_action 15:13:36 INFO - ##### 15:13:36 INFO - ##### Finished read-buildbot-config step (success) 15:13:36 INFO - ##### 15:13:36 INFO - ##### 15:13:36 INFO - ##### Running download-and-extract step. 15:13:36 INFO - ##### 15:13:36 INFO - Running pre-action listener: _resource_record_pre_action 15:13:36 INFO - Running main action method: download_and_extract 15:13:36 INFO - mkdir: /builds/slave/test/build/tests 15:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:36 INFO - https://queue.taskcluster.net/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:13:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:13:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:13:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/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 15:13:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/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 15:13:37 INFO - Downloaded 1361 bytes. 15:13:37 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:13:37 INFO - Using the following test package requirements: 15:13:37 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:13:37 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:13:37 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:13:37 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:37 INFO - u'jsshell-linux-x86_64.zip'], 15:13:37 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:13:37 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:13:37 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:13:37 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:13:37 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:13:37 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:13:37 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:13:37 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')]} 15:13:37 INFO - https://queue.taskcluster.net/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:13:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:13:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:13:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/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 15:13:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/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 15:13:38 INFO - Downloaded 22737688 bytes. 15:13:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:13:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:13:39 INFO - Return code: 0 15:13:39 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:39 INFO - https://queue.taskcluster.net/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:13:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:13:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:13:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/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 15:13:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/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 15:13:40 INFO - Downloaded 22737688 bytes. 15:13:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:13:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:13:42 INFO - Return code: 0 15:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:42 INFO - https://queue.taskcluster.net/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:13:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:13:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:13:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/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 15:13:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/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 15:13:43 INFO - Downloaded 14403333 bytes. 15:13:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:13:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:13:43 INFO - Return code: 0 15:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:43 INFO - https://queue.taskcluster.net/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:13:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:13:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:13:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/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 15:13:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/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 15:13:45 INFO - Downloaded 56653985 bytes. 15:13:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:13:45 INFO - mkdir: /builds/slave/test/properties 15:13:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:13:45 INFO - Writing to file /builds/slave/test/properties/build_url 15:13:45 INFO - Contents: 15:13:45 INFO - build_url:https://queue.taskcluster.net/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:13:46 INFO - Running post-action listener: _resource_record_post_action 15:13:46 INFO - Running post-action listener: set_extra_try_arguments 15:13:46 INFO - ##### 15:13:46 INFO - ##### Finished download-and-extract step (success) 15:13:46 INFO - ##### 15:13:46 INFO - ##### 15:13:46 INFO - ##### Running populate-webroot step. 15:13:46 INFO - ##### 15:13:46 INFO - Running pre-action listener: _resource_record_pre_action 15:13:46 INFO - Running main action method: populate_webroot 15:13:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:13:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:13:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:13:46 INFO - '--tppagecycles', 15:13:46 INFO - '7'], 15:13:46 INFO - 'tests': ['tsvgm']}}, 15:13:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:13:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:13:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:13:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:13:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:13:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:13:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:46 INFO - 'talos_options': ['--disable-e10s'], 15:13:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:13:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:13:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:46 INFO - 'talos_options': ['--disable-e10s'], 15:13:46 INFO - 'tests': ['damp', 'tps']}, 15:13:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:46 INFO - 'tests': ['damp', 'tps']}, 15:13:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:13:46 INFO - 'tests': ['dromaeo_dom']}, 15:13:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:13:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:13:46 INFO - 'tests': ['basic_compositor_video']}, 15:13:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:13:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:13:46 INFO - 'tests': ['a11yr', 15:13:46 INFO - 'ts_paint', 15:13:46 INFO - 'tpaint', 15:13:46 INFO - 'sessionrestore', 15:13:46 INFO - 'sessionrestore_no_auto_restore', 15:13:46 INFO - 'tabpaint']}, 15:13:46 INFO - 'other-e10s': {'tests': ['a11yr', 15:13:46 INFO - 'ts_paint', 15:13:46 INFO - 'tpaint', 15:13:46 INFO - 'sessionrestore', 15:13:46 INFO - 'sessionrestore_no_auto_restore', 15:13:46 INFO - 'tabpaint']}, 15:13:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:13:46 INFO - 'ts_paint', 15:13:46 INFO - 'tpaint', 15:13:46 INFO - 'sessionrestore', 15:13:46 INFO - 'sessionrestore_no_auto_restore', 15:13:46 INFO - 'tabpaint']}, 15:13:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:13:46 INFO - 'ts_paint', 15:13:46 INFO - 'tpaint', 15:13:46 INFO - 'sessionrestore', 15:13:46 INFO - 'sessionrestore_no_auto_restore', 15:13:46 INFO - 'tabpaint']}, 15:13:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:13:46 INFO - 'tests': ['a11yr', 15:13:46 INFO - 'ts_paint', 15:13:46 INFO - 'tpaint', 15:13:46 INFO - 'sessionrestore', 15:13:46 INFO - 'sessionrestore_no_auto_restore', 15:13:46 INFO - 'tabpaint']}, 15:13:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:13:46 INFO - 'tests': ['a11yr', 15:13:46 INFO - 'ts_paint', 15:13:46 INFO - 'tpaint', 15:13:46 INFO - 'sessionrestore', 15:13:46 INFO - 'sessionrestore_no_auto_restore', 15:13:46 INFO - 'tabpaint']}, 15:13:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:13:46 INFO - 'tests': ['tsvgx', 15:13:46 INFO - 'tsvgr_opacity', 15:13:46 INFO - 'tart', 15:13:46 INFO - 'tscrollx', 15:13:46 INFO - 'cart']}, 15:13:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:13:46 INFO - 'tsvgr_opacity', 15:13:46 INFO - 'tart', 15:13:46 INFO - 'tscrollx', 15:13:46 INFO - 'cart']}, 15:13:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:46 INFO - 'talos_options': ['--disable-e10s'], 15:13:46 INFO - 'tests': ['tp5o']}, 15:13:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:46 INFO - 'tests': ['tp5o']}, 15:13:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:46 INFO - 'talos_options': ['--disable-e10s', 15:13:46 INFO - '--xperf_path', 15:13:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:13:46 INFO - 'tests': ['tp5n']}, 15:13:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:46 INFO - 'talos_options': ['--xperf_path', 15:13:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:13:46 INFO - 'tests': ['tp5n']}}, 15:13:46 INFO - 'talos.zip': {'path': '', 15:13:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:13:46 INFO - Running post-action listener: _resource_record_post_action 15:13:46 INFO - ##### 15:13:46 INFO - ##### Finished populate-webroot step (success) 15:13:46 INFO - ##### 15:13:46 INFO - ##### 15:13:46 INFO - ##### Running create-virtualenv step. 15:13:46 INFO - ##### 15:13:46 INFO - Running pre-action listener: _resource_record_pre_action 15:13:46 INFO - Running main action method: create_virtualenv 15:13:46 INFO - Creating virtualenv /builds/slave/test/build/venv 15:13:46 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 15:13:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:13:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:13:46 INFO - Using real prefix '/usr' 15:13:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:13:46 INFO - Installing distribute.............................................................................................................................................................................................done. 15:13:48 INFO - Installing pip.................done. 15:13:48 INFO - Return code: 0 15:13:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:13: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')]} 15:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13: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')]} 15:13:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2542030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2800570>, '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 0x2801470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2801900>, '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': '0e2a256762fed810e2f0f810000001b3-1468272487.516176-340079855', '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 15:13: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', 'pip>=1.5'] in /builds/slave/test/build 15:13: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 pip>=1.5 15:13:48 INFO - Using env: {'DISPLAY': ':0', 15:13:48 INFO - 'HOME': '/home/cltbld', 15:13:48 INFO - 'LANG': 'en_US.UTF-8', 15:13:48 INFO - 'LANGUAGE': 'en_US:en', 15:13:48 INFO - 'LOGNAME': 'cltbld', 15:13:48 INFO - 'MAIL': '/var/mail/cltbld', 15:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:48 INFO - 'MOZ_NO_REMOTE': '1', 15:13:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:48 INFO - 'NO_EM_RESTART': '1', 15:13:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:48 INFO - 'PWD': '/builds/slave/test', 15:13:48 INFO - 'SHELL': '/bin/bash', 15:13:48 INFO - 'SHLVL': '1', 15:13:48 INFO - 'TERM': 'linux', 15:13:48 INFO - 'TMOUT': '86400', 15:13:48 INFO - 'USER': 'cltbld', 15:13:48 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1468272487.516176-340079855', 15:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:48 INFO - '_': '/tools/buildbot/bin/python'} 15:13:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:13:49 INFO - Cleaning up... 15:13:49 INFO - Return code: 0 15:13:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2542030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2800570>, '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 0x2801470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2801900>, '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': '0e2a256762fed810e2f0f810000001b3-1468272487.516176-340079855', '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 15:13:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:13:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:13:49 INFO - Using env: {'DISPLAY': ':0', 15:13:49 INFO - 'HOME': '/home/cltbld', 15:13:49 INFO - 'LANG': 'en_US.UTF-8', 15:13:49 INFO - 'LANGUAGE': 'en_US:en', 15:13:49 INFO - 'LOGNAME': 'cltbld', 15:13:49 INFO - 'MAIL': '/var/mail/cltbld', 15:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:49 INFO - 'MOZ_NO_REMOTE': '1', 15:13:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:49 INFO - 'NO_EM_RESTART': '1', 15:13:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:49 INFO - 'PWD': '/builds/slave/test', 15:13:49 INFO - 'SHELL': '/bin/bash', 15:13:49 INFO - 'SHLVL': '1', 15:13:49 INFO - 'TERM': 'linux', 15:13:49 INFO - 'TMOUT': '86400', 15:13:49 INFO - 'USER': 'cltbld', 15:13:49 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1468272487.516176-340079855', 15:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:49 INFO - '_': '/tools/buildbot/bin/python'} 15:13:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:49 INFO - Downloading/unpacking psutil>=3.1.1 15:13:49 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 15:13:49 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 15:13:49 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 15:13:49 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 15:13:49 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 15:13:49 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 15:13:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:13:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:13:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:13:51 INFO - Installing collected packages: psutil 15:13:51 INFO - Running setup.py install for psutil 15:13:51 INFO - building 'psutil._psutil_linux' extension 15:13:51 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 15:13:51 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 15:13:51 INFO - building 'psutil._psutil_posix' extension 15:13:51 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 15:13:51 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 15:13:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:13:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:13:51 INFO - Successfully installed psutil 15:13:51 INFO - Cleaning up... 15:13:51 INFO - Return code: 0 15:13:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:51 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 0x2542030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2800570>, '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 0x2801470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2801900>, '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': '0e2a256762fed810e2f0f810000001b3-1468272487.516176-340079855', '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 15:13:51 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 15:13:51 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 15:13:51 INFO - Using env: {'DISPLAY': ':0', 15:13:51 INFO - 'HOME': '/home/cltbld', 15:13:51 INFO - 'LANG': 'en_US.UTF-8', 15:13:51 INFO - 'LANGUAGE': 'en_US:en', 15:13:51 INFO - 'LOGNAME': 'cltbld', 15:13:51 INFO - 'MAIL': '/var/mail/cltbld', 15:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:51 INFO - 'MOZ_NO_REMOTE': '1', 15:13:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:51 INFO - 'NO_EM_RESTART': '1', 15:13:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:51 INFO - 'PWD': '/builds/slave/test', 15:13:51 INFO - 'SHELL': '/bin/bash', 15:13:51 INFO - 'SHLVL': '1', 15:13:51 INFO - 'TERM': 'linux', 15:13:51 INFO - 'TMOUT': '86400', 15:13:51 INFO - 'USER': 'cltbld', 15:13:51 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1468272487.516176-340079855', 15:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:51 INFO - '_': '/tools/buildbot/bin/python'} 15:13:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:13:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:13:54 INFO - Installing collected packages: mozsystemmonitor 15:13:54 INFO - Running setup.py install for mozsystemmonitor 15:13:54 INFO - Successfully installed mozsystemmonitor 15:13:54 INFO - Cleaning up... 15:13:54 INFO - Return code: 0 15:13:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:13: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')]} 15:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13: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')]} 15:13:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13: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', '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 0x2542030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2800570>, '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 0x2801470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2801900>, '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': '0e2a256762fed810e2f0f810000001b3-1468272487.516176-340079855', '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 15:13: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:13: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 jsonschema==2.5.1 15:13:54 INFO - Using env: {'DISPLAY': ':0', 15:13:54 INFO - 'HOME': '/home/cltbld', 15:13:54 INFO - 'LANG': 'en_US.UTF-8', 15:13:54 INFO - 'LANGUAGE': 'en_US:en', 15:13:54 INFO - 'LOGNAME': 'cltbld', 15:13:54 INFO - 'MAIL': '/var/mail/cltbld', 15:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:54 INFO - 'MOZ_NO_REMOTE': '1', 15:13:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:54 INFO - 'NO_EM_RESTART': '1', 15:13:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:54 INFO - 'PWD': '/builds/slave/test', 15:13:54 INFO - 'SHELL': '/bin/bash', 15:13:54 INFO - 'SHLVL': '1', 15:13:54 INFO - 'TERM': 'linux', 15:13:54 INFO - 'TMOUT': '86400', 15:13:54 INFO - 'USER': 'cltbld', 15:13:54 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1468272487.516176-340079855', 15:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:54 INFO - '_': '/tools/buildbot/bin/python'} 15:13:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:54 INFO - Downloading/unpacking jsonschema==2.5.1 15:13: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 15:13: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 15:13: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 15:13: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 15:13: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 15:13: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 15:13:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:13:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:13: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 15:13: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 15:13: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 15:13: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 15:13: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 15:13: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 15:13:56 INFO - Downloading functools32-3.2.3-2.tar.gz 15:13:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:13:56 INFO - warning: no files found matching '*.txt' 15:13:56 INFO - no previously-included directories found matching 'build' 15:13:56 INFO - no previously-included directories found matching 'dist' 15:13:56 INFO - no previously-included directories found matching '.git*' 15:13:56 INFO - Installing collected packages: jsonschema, functools32 15:13:56 INFO - Running setup.py install for functools32 15:13:56 INFO - warning: no files found matching '*.txt' 15:13:56 INFO - no previously-included directories found matching 'build' 15:13:56 INFO - no previously-included directories found matching 'dist' 15:13:56 INFO - no previously-included directories found matching '.git*' 15:13:56 INFO - Successfully installed jsonschema functools32 15:13:56 INFO - Cleaning up... 15:13:56 INFO - Return code: 0 15:13:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2542030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2800570>, '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 0x2801470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2801900>, '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': '0e2a256762fed810e2f0f810000001b3-1468272487.516176-340079855', '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 15:13:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:13:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:13:56 INFO - Using env: {'DISPLAY': ':0', 15:13:56 INFO - 'HOME': '/home/cltbld', 15:13:56 INFO - 'LANG': 'en_US.UTF-8', 15:13:56 INFO - 'LANGUAGE': 'en_US:en', 15:13:56 INFO - 'LOGNAME': 'cltbld', 15:13:56 INFO - 'MAIL': '/var/mail/cltbld', 15:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:56 INFO - 'MOZ_NO_REMOTE': '1', 15:13:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:56 INFO - 'NO_EM_RESTART': '1', 15:13:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:56 INFO - 'PWD': '/builds/slave/test', 15:13:56 INFO - 'SHELL': '/bin/bash', 15:13:56 INFO - 'SHLVL': '1', 15:13:56 INFO - 'TERM': 'linux', 15:13:56 INFO - 'TMOUT': '86400', 15:13:56 INFO - 'USER': 'cltbld', 15:13:56 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1468272487.516176-340079855', 15:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:56 INFO - '_': '/tools/buildbot/bin/python'} 15:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:56 INFO - Downloading/unpacking blobuploader==1.2.4 15:13: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 15:13: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 15:13: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 15:13: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 15:13: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 15:13: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 15:13:58 INFO - Downloading blobuploader-1.2.4.tar.gz 15:13:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:13:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:13:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:59 INFO - Downloading docopt-0.6.1.tar.gz 15:13:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:13:59 INFO - Installing collected packages: blobuploader, requests, docopt 15:13:59 INFO - Running setup.py install for blobuploader 15:13:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:13:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:13:59 INFO - Running setup.py install for requests 15:14:00 INFO - Running setup.py install for docopt 15:14:00 INFO - Successfully installed blobuploader requests docopt 15:14:00 INFO - Cleaning up... 15:14:00 INFO - Return code: 0 15:14:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2542030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2800570>, '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 0x2801470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2801900>, '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': '0e2a256762fed810e2f0f810000001b3-1468272487.516176-340079855', '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 15:14:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:14:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:14:00 INFO - Using env: {'DISPLAY': ':0', 15:14:00 INFO - 'HOME': '/home/cltbld', 15:14:00 INFO - 'LANG': 'en_US.UTF-8', 15:14:00 INFO - 'LANGUAGE': 'en_US:en', 15:14:00 INFO - 'LOGNAME': 'cltbld', 15:14:00 INFO - 'MAIL': '/var/mail/cltbld', 15:14:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:00 INFO - 'MOZ_NO_REMOTE': '1', 15:14:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:00 INFO - 'NO_EM_RESTART': '1', 15:14:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:00 INFO - 'PWD': '/builds/slave/test', 15:14:00 INFO - 'SHELL': '/bin/bash', 15:14:00 INFO - 'SHLVL': '1', 15:14:00 INFO - 'TERM': 'linux', 15:14:00 INFO - 'TMOUT': '86400', 15:14:00 INFO - 'USER': 'cltbld', 15:14:00 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1468272487.516176-340079855', 15:14:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:00 INFO - '_': '/tools/buildbot/bin/python'} 15:14:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:14:00 INFO - Running setup.py (path:/tmp/pip-hPr3aJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:14:00 INFO - Running setup.py (path:/tmp/pip-KC2C6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:14:00 INFO - Running setup.py (path:/tmp/pip-8RvjWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:14:00 INFO - Running setup.py (path:/tmp/pip-KHtm5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:14:00 INFO - Running setup.py (path:/tmp/pip-jDKIlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:14:00 INFO - Running setup.py (path:/tmp/pip-W2T1lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:14:00 INFO - Running setup.py (path:/tmp/pip-7MXPip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:14:00 INFO - Running setup.py (path:/tmp/pip-nMPdV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:14:01 INFO - Running setup.py (path:/tmp/pip-qr264b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:14:01 INFO - Running setup.py (path:/tmp/pip-75KDIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:14:01 INFO - Running setup.py (path:/tmp/pip-NYMqPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:14:01 INFO - Running setup.py (path:/tmp/pip-pGhOd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:14:01 INFO - Running setup.py (path:/tmp/pip-FKd4lq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:14:01 INFO - Running setup.py (path:/tmp/pip-jzyoMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:14:01 INFO - Running setup.py (path:/tmp/pip-5WVpEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:14:01 INFO - Running setup.py (path:/tmp/pip-JzkfG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:14:01 INFO - Running setup.py (path:/tmp/pip-ZelrvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:14:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:14:01 INFO - Running setup.py install for manifestparser 15:14:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:14:01 INFO - Running setup.py install for mozcrash 15:14:01 INFO - Running setup.py install for mozdebug 15:14:02 INFO - Running setup.py install for mozdevice 15:14:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:14:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:14:02 INFO - Running setup.py install for mozfile 15:14:02 INFO - Running setup.py install for mozhttpd 15:14:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:14:02 INFO - Running setup.py install for mozinfo 15:14:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:14:02 INFO - Running setup.py install for mozInstall 15:14:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:14:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:14:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:14:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:14:02 INFO - Running setup.py install for mozleak 15:14:02 INFO - Running setup.py install for mozlog 15:14:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:14:02 INFO - Running setup.py install for moznetwork 15:14:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:14:02 INFO - Running setup.py install for mozprocess 15:14:02 INFO - Running setup.py install for mozprofile 15:14:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:14:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:14:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:14:03 INFO - Running setup.py install for mozrunner 15:14:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:14:03 INFO - Running setup.py install for mozscreenshot 15:14:03 INFO - Running setup.py install for moztest 15:14:03 INFO - Running setup.py install for mozversion 15:14:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:14:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:14:03 INFO - Cleaning up... 15:14:03 INFO - Return code: 0 15:14:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:14:03 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')]} 15:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:03 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')]} 15:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:03 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 0x2542030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2800570>, '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 0x2801470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2801900>, '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': '0e2a256762fed810e2f0f810000001b3-1468272487.516176-340079855', '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 15:14:03 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 15:14:03 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 15:14:03 INFO - Using env: {'DISPLAY': ':0', 15:14:03 INFO - 'HOME': '/home/cltbld', 15:14:03 INFO - 'LANG': 'en_US.UTF-8', 15:14:03 INFO - 'LANGUAGE': 'en_US:en', 15:14:03 INFO - 'LOGNAME': 'cltbld', 15:14:03 INFO - 'MAIL': '/var/mail/cltbld', 15:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:03 INFO - 'MOZ_NO_REMOTE': '1', 15:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:03 INFO - 'NO_EM_RESTART': '1', 15:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:03 INFO - 'PWD': '/builds/slave/test', 15:14:03 INFO - 'SHELL': '/bin/bash', 15:14:03 INFO - 'SHLVL': '1', 15:14:03 INFO - 'TERM': 'linux', 15:14:03 INFO - 'TMOUT': '86400', 15:14:03 INFO - 'USER': 'cltbld', 15:14:03 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1468272487.516176-340079855', 15:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:03 INFO - '_': '/tools/buildbot/bin/python'} 15:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:14:03 INFO - Running setup.py (path:/tmp/pip-hZa4d5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:14:03 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)) 15:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:14:03 INFO - Running setup.py (path:/tmp/pip-wusLSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:14:03 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)) 15:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:14:03 INFO - Running setup.py (path:/tmp/pip-w_iu1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:14:03 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)) 15:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:14:03 INFO - Running setup.py (path:/tmp/pip-Aip_Gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:14:04 INFO - Running setup.py (path:/tmp/pip-Oztnk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:14:04 INFO - Running setup.py (path:/tmp/pip-ew8gpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:14:04 INFO - Running setup.py (path:/tmp/pip-SelL3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:14:04 INFO - Running setup.py (path:/tmp/pip-ViBndG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:14:04 INFO - Running setup.py (path:/tmp/pip-LU_uEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:14:04 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:14:04 INFO - Running setup.py (path:/tmp/pip-Qs5DXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:14:04 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:14:04 INFO - Running setup.py (path:/tmp/pip-qf_Gup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:14:04 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:14:04 INFO - Running setup.py (path:/tmp/pip-5K8pmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:14:04 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:14:04 INFO - Running setup.py (path:/tmp/pip-MbKRIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:14:04 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:14:04 INFO - Running setup.py (path:/tmp/pip-iLfvU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:14:04 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:14:04 INFO - Running setup.py (path:/tmp/pip-FMZ8ol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:14:04 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:14:04 INFO - Running setup.py (path:/tmp/pip-IBKyWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:14:04 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:14:04 INFO - Running setup.py (path:/tmp/pip-dKrTr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:14:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:07 INFO - Downloading blessings-1.6.tar.gz 15:14:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:14:07 INFO - Installing collected packages: blessings 15:14:07 INFO - Running setup.py install for blessings 15:14:08 INFO - Successfully installed blessings 15:14:08 INFO - Cleaning up... 15:14:08 INFO - Return code: 0 15:14:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:14:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:14:08 INFO - Reading from file tmpfile_stdout 15:14:08 INFO - Current package versions: 15:14:08 INFO - argparse == 1.2.1 15:14:08 INFO - blessings == 1.6 15:14:08 INFO - blobuploader == 1.2.4 15:14:08 INFO - docopt == 0.6.1 15:14:08 INFO - functools32 == 3.2.3-2 15:14:08 INFO - jsonschema == 2.5.1 15:14:08 INFO - manifestparser == 1.1 15:14:08 INFO - mozInstall == 1.12 15:14:08 INFO - mozcrash == 0.17 15:14:08 INFO - mozdebug == 0.1 15:14:08 INFO - mozdevice == 0.48 15:14:08 INFO - mozfile == 1.2 15:14:08 INFO - mozhttpd == 0.7 15:14:08 INFO - mozinfo == 0.9 15:14:08 INFO - mozleak == 0.1 15:14:08 INFO - mozlog == 3.2 15:14:08 INFO - moznetwork == 0.27 15:14:08 INFO - mozprocess == 0.23 15:14:08 INFO - mozprofile == 0.28 15:14:08 INFO - mozrunner == 6.12 15:14:08 INFO - mozscreenshot == 0.1 15:14:08 INFO - mozsystemmonitor == 0.3 15:14:08 INFO - moztest == 0.7 15:14:08 INFO - mozversion == 1.4 15:14:08 INFO - psutil == 3.1.1 15:14:08 INFO - requests == 1.2.3 15:14:08 INFO - wsgiref == 0.1.2 15:14:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2542030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2800570>, '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 0x2801470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2801900>, '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': '0e2a256762fed810e2f0f810000001b3-1468272487.516176-340079855', '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 15:14:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:14:08 INFO - Using env: {'DISPLAY': ':0', 15:14:08 INFO - 'HOME': '/home/cltbld', 15:14:08 INFO - 'LANG': 'en_US.UTF-8', 15:14:08 INFO - 'LANGUAGE': 'en_US:en', 15:14:08 INFO - 'LOGNAME': 'cltbld', 15:14:08 INFO - 'MAIL': '/var/mail/cltbld', 15:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:08 INFO - 'MOZ_NO_REMOTE': '1', 15:14:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:08 INFO - 'NO_EM_RESTART': '1', 15:14:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:08 INFO - 'PWD': '/builds/slave/test', 15:14:08 INFO - 'SHELL': '/bin/bash', 15:14:08 INFO - 'SHLVL': '1', 15:14:08 INFO - 'TERM': 'linux', 15:14:08 INFO - 'TMOUT': '86400', 15:14:08 INFO - 'USER': 'cltbld', 15:14:08 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1468272487.516176-340079855', 15:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:08 INFO - '_': '/tools/buildbot/bin/python'} 15:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:14:08 INFO - Cleaning up... 15:14:08 INFO - Return code: 0 15:14:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2542030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2800570>, '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 0x2801470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2801900>, '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': '0e2a256762fed810e2f0f810000001b3-1468272487.516176-340079855', '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 15:14:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:14:08 INFO - Using env: {'DISPLAY': ':0', 15:14:08 INFO - 'HOME': '/home/cltbld', 15:14:08 INFO - 'LANG': 'en_US.UTF-8', 15:14:08 INFO - 'LANGUAGE': 'en_US:en', 15:14:08 INFO - 'LOGNAME': 'cltbld', 15:14:08 INFO - 'MAIL': '/var/mail/cltbld', 15:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:08 INFO - 'MOZ_NO_REMOTE': '1', 15:14:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:08 INFO - 'NO_EM_RESTART': '1', 15:14:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:08 INFO - 'PWD': '/builds/slave/test', 15:14:08 INFO - 'SHELL': '/bin/bash', 15:14:08 INFO - 'SHLVL': '1', 15:14:08 INFO - 'TERM': 'linux', 15:14:08 INFO - 'TMOUT': '86400', 15:14:08 INFO - 'USER': 'cltbld', 15:14:08 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1468272487.516176-340079855', 15:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:08 INFO - '_': '/tools/buildbot/bin/python'} 15:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:14:08 INFO - Cleaning up... 15:14:08 INFO - Return code: 0 15:14:08 INFO - Running post-action listener: _resource_record_post_action 15:14:08 INFO - Running post-action listener: _start_resource_monitoring 15:14:08 INFO - Starting resource monitoring. 15:14:08 INFO - ##### 15:14:08 INFO - ##### Finished create-virtualenv step (success) 15:14:08 INFO - ##### 15:14:08 INFO - ##### 15:14:08 INFO - ##### Running install step. 15:14:08 INFO - ##### 15:14:08 INFO - Running pre-action listener: _resource_record_pre_action 15:14:08 INFO - Running main action method: install 15:14:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:14:09 INFO - Reading from file tmpfile_stdout 15:14:09 INFO - Detecting whether we're running mozinstall >=1.0... 15:14:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:14:09 INFO - Reading from file tmpfile_stdout 15:14:09 INFO - Output received: 15:14:09 INFO - Usage: mozinstall [options] installer 15:14:09 INFO - Options: 15:14:09 INFO - -h, --help show this help message and exit 15:14:09 INFO - -d DEST, --destination=DEST 15:14:09 INFO - Directory to install application into. [default: 15:14:09 INFO - "/builds/slave/test"] 15:14:09 INFO - --app=APP Application being installed. [default: firefox] 15:14:09 INFO - mkdir: /builds/slave/test/build/application 15:14:09 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'] 15:14:09 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 15:14:25 INFO - Reading from file tmpfile_stdout 15:14:25 INFO - Output received: 15:14:25 INFO - /builds/slave/test/build/application/firefox/firefox 15:14:25 INFO - Running post-action listener: _resource_record_post_action 15:14:25 INFO - ##### 15:14:25 INFO - ##### Finished install step (success) 15:14:25 INFO - ##### 15:14:25 INFO - ##### 15:14:25 INFO - ##### Running run-tests step. 15:14:25 INFO - ##### 15:14:25 INFO - Running pre-action listener: _resource_record_pre_action 15:14:25 INFO - Running main action method: run_tests 15:14:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:14:25 INFO - Python 2.7.3 15:14:25 INFO - Return code: 0 15:14:25 INFO - grabbing minidump binary from tooltool 15:14:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:25 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2800570>, '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 0x2801470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2801900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:14:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:14:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:14:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:14:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:14:25 INFO - Return code: 0 15:14:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:14:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:14:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:14:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:14:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:14:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 15:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 15:14:25 INFO - Using env: {'DISPLAY': ':0', 15:14:25 INFO - 'HOME': '/home/cltbld', 15:14:25 INFO - 'LANG': 'en_US.UTF-8', 15:14:25 INFO - 'LANGUAGE': 'en_US:en', 15:14:25 INFO - 'LOGNAME': 'cltbld', 15:14:25 INFO - 'MAIL': '/var/mail/cltbld', 15:14:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:14:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:25 INFO - 'MOZ_NO_REMOTE': '1', 15:14:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:14:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:25 INFO - 'NO_EM_RESTART': '1', 15:14:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:25 INFO - 'PWD': '/builds/slave/test', 15:14:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:14:25 INFO - 'SHELL': '/bin/bash', 15:14:25 INFO - 'SHLVL': '1', 15:14:25 INFO - 'TERM': 'linux', 15:14:25 INFO - 'TMOUT': '86400', 15:14:25 INFO - 'USER': 'cltbld', 15:14:25 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1468272487.516176-340079855', 15:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:25 INFO - '_': '/tools/buildbot/bin/python'} 15:14:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 15:14:25 INFO - mozversion application_buildid: 20160711135528 15:14:25 INFO - mozversion application_changeset: 6b329e5cac8634acbfb8a10bcfc441f7498bab23 15:14:25 INFO - mozversion application_display_name: Nightly 15:14:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:14:25 INFO - mozversion application_name: Firefox 15:14:25 INFO - mozversion application_remotingname: firefox 15:14:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:14:25 INFO - mozversion application_vendor: Mozilla 15:14:25 INFO - mozversion application_version: 50.0a1 15:14:25 INFO - mozversion platform_buildid: 20160711135528 15:14:25 INFO - mozversion platform_changeset: 6b329e5cac8634acbfb8a10bcfc441f7498bab23 15:14:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:14:25 INFO - mozversion platform_version: 50.0a1 15:14:25 INFO - using testdate: 1468275265 15:14:25 INFO - actual date: 1468275265 15:14:25 INFO - starting webserver on 'localhost:48287' 15:14:25 INFO - SUITE-START | Running 2 tests 15:14:25 INFO - TEST-START | dromaeo_css 15:14:25 INFO - operating with platform_type : linux_ 15:14:25 INFO - Initialising browser for dromaeo_css test... 15:14:25 INFO - TEST-INFO | started process 29616 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKOwL5E/profile http://localhost:48287/getInfo.html) 15:14:30 INFO - PROCESS | 29616 | __metrics Screen width/height:1600/1200 15:14:30 INFO - PROCESS | 29616 | colorDepth:24 15:14:30 INFO - PROCESS | 29616 | Browser inner width/height: 1024/697 15:14:30 INFO - PROCESS | 29616 | __metrics 15:14:31 ERROR - PROCESS | 29616 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 15:14:32 INFO - TEST-INFO | 29616: exit 0 15:14:32 INFO - Browser initialized. 15:14:32 INFO - Running cycle 1/1 for dromaeo_css test... 15:14:32 INFO - TEST-INFO | started process 29735 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKOwL5E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:14:44 INFO - PROCESS | 29735 | RSS: Main: 169213952 15:14:44 INFO - PROCESS | 29735 | 15:15:33 INFO - PROCESS | 29735 | 1468275333703 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] 15:17:46 INFO - PROCESS | 29735 | Cycle 1(1): loaded http://localhost:48287/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48287/tests/dromaeo/cssquery-ext.html) 15:17:47 INFO - PROCESS | 29735 | RSS: Main: 168787968 15:17:47 INFO - PROCESS | 29735 | 15:20:49 INFO - PROCESS | 29735 | Cycle 1(1): loaded http://localhost:48287/tests/dromaeo/cssquery-ext.html (next: http://localhost:48287/tests/dromaeo/cssquery-jquery.html) 15:20:50 INFO - PROCESS | 29735 | RSS: Main: 168787968 15:20:50 INFO - PROCESS | 29735 | 15:23:52 INFO - PROCESS | 29735 | Cycle 1(1): loaded http://localhost:48287/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48287/tests/dromaeo/cssquery-mootools.html) 15:23:52 INFO - PROCESS | 29735 | RSS: Main: 171364352 15:23:52 INFO - PROCESS | 29735 | 15:26:54 INFO - PROCESS | 29735 | Cycle 1(1): loaded http://localhost:48287/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48287/tests/dromaeo/cssquery-prototype.html) 15:26:55 INFO - PROCESS | 29735 | RSS: Main: 166973440 15:26:55 INFO - PROCESS | 29735 | 15:29:58 INFO - PROCESS | 29735 | Cycle 1(1): loaded http://localhost:48287/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48287/tests/dromaeo/cssquery-yui.html) 15:29:58 INFO - PROCESS | 29735 | RSS: Main: 168722432 15:29:58 INFO - PROCESS | 29735 | 15:33:01 INFO - PROCESS | 29735 | Cycle 1(1): loaded http://localhost:48287/tests/dromaeo/cssquery-yui.html (next: http://localhost:48287/tests/dromaeo/cssquery-dojo.html) 15:33:01 INFO - PROCESS | 29735 | RSS: Main: 171012096 15:33:01 INFO - PROCESS | 29735 | 15:33:01 INFO - PROCESS | 29735 | __start_tp_report 15:33:01 INFO - PROCESS | 29735 | _x_x_mozilla_page_load 15:33:01 INFO - PROCESS | 29735 | _x_x_mozilla_page_load_details 15:33:01 INFO - PROCESS | 29735 | |i|pagename|runs| 15:33:01 INFO - PROCESS | 29735 | |0;dojo.html;2636.0773729194784;2651.2443953473253;2661.560842460994;2668.8265262757923;2671.0784779251153;4711.010687755567;4750.691205071672;4778.7610619469015;4788.880277993052;4810.110129626021;4681.2275974464255;4772.379590653219;4774.570288674018;4779.64152688548;4842.370491836056;4362.694611377205;4409.779511024436;4451.065276291983;4467.865964021084;4479.955200448003;162.79182141887156;4346.413234213373;4385.320275357325;4456.3983862178675;4469.932951005738;4399.714018588797;4403.8458653946955;4422.601965823092;4434.977825110854;4467.508574056851;4418.5581441855875;4424.756638384888;4444.688871778977;4446.244138496463;4492.348609451611;4361.149575832714;4423.0711550574415;4429.202743506167;4455.4207952966235;4457.509673935864;4804.711717296974;4837.4920633333695;4848.369711937426;4853.39332583427;4858.829940952085;4963.205887058053;5060.190369540893;5141.948580514184;5145.614078944094;5168.508991645787;5134.383873935151;5134.614903882224;5136.178211486182;5162.561182299509;5165.63840531163;4861.392325959255;4870.95129048705;4872.342233798463;4882.096812089704;4925.950740492585;5234.947650523446;5273.235380869753;5310.654807437504;5328.547073498718;5337.546308563816;5088.745562721923;5104.3619547556555;5112.207607820794;5114.156164232934;5116.283720279164;5192.1173400522;5197.740112994411;5208;5211;5212.582993360522;4960.131976904027;5060.51925067118;5120.743962801919;5133.922991155136;5151.5363617274625;5114.974425127925;5117.43708192106;5124.205748109049;5139.897202055938;5193.143131383355;4306.720063195882;4361.934570981438;4390.319500477431;4398.940829815985;4439.311906654474;3728.794916279631;3761.22894806564;3766.303233901737;3821.082940094357;3823.330917089498;4340.370646256275;4370.278903980871;4377.737335759864;4391.7584532851;4434.312681534368;5124.692518448905;5145.639805213674;5155.690658560498;5169.896602068013;5203.661761985459;4303.031817841023;4406.603405693503;4407.647388208936;4408.272635015251;4434.667399944952;4560.726356418625;4590.196715574761;4642.605378542794;4644.164050470948;4654.138984287918;4789.425268967746;4818.638602104927;4819.807207711652;4826.565609095198;4855.6601037927;4977.552020318189;4999.475055119306;5170.948290517197;5177.145770947752;5238.607104467104;4671.43942726875;4719.480857105785;4721.763911804464;4722.386089808303;4779.569838714393;5020.598352131748;5020.824271150492;5023.974880125576;5027.622928280321;5068.670536415121;4955.876103097451;5024.88528853478;5087.669301495391;5120.48795120485;5155.407128180307;5040.269160971712;5040.546350828443;5064.5948324134715;5074.289599456153;5102.132637451717;4963.801447942042;4992.750362481934;5059.544640982329;5077.7461126944245;5105.821296254613;4814.1815891297865;4914.311996320446;4926.3349447824085;4927.802887884444;4960.578350840219;5079.314292570456;5087.211482220262;5094.847154585368;5112.130937740668;5138.588912887035;4755.690880092783;4923.532264434873;4924.556789888928;4940.209566469348;4989.650724449254 15:33:01 INFO - PROCESS | 29735 | |1;ext.html;563.9915401268979;564.3538148819601;565.9586361095584;567.986144731654;596.9791057312995;34733.47899781505;38322;38367.61632383675;38372.61627383729;38392.61607383925;37790.43314350287;38415.61584384155;38758.80620596893;38784.61215387852;38810;7775.1447340792465;7817.335526480256;7914.3272821810215;7922.683092676286;7924.207579242087;7852.842943141134;7898.723544675938;7900.209979002111;7925.405594580401;7947.284744373005;7942;7963;7974.401919856005;7991.041075070971;7992.920070799305;7900.209979002111;7901.328387087047;7914;7920.326772224368;7942.880856787153;7687.500312479671;7871.252231038042;7883.448158628898;7889.921100788976;7898.407619428566;36762.81618591917;36818.815905920565;36989.44515832265;37316.44025339622;37337.439938400945;2662.8136030477876;3011.728944395015;3108.7512998960256;3126;3187.9043628691174;26646.866765666047;27986.160415187373;28762;28766.137015889555;29554.852225738734;3219.5814544109116;3244.545763593099;3280.721138703213;3381.205416727067;3416.5558477398026;212123;278195;280588;280759;282654;32160.517592236134;33241.501377479355;55488.44511554913;56246.718766406724;56294.15558766622;33543.83228083844;33597.32805343928;33805.66194338074;33840.49239261413;33847;11571.01646360052;11660.18378713482;11747.47136378848;11788.528458861549;11844.230125041844;9532.332736708502;9611.807763844685;9618.182454491447;9626.374285671409;9732.95133524342;7824.647890844925;7899.09160446556;7919;7920.366370690331;7952.562609056442;3079.3687294104657;3101.984490077535;3107.0655048856574;3117.173948903542;3127.5465057566526;799.8320352725876;809.9109097999216;840.1346612988632;849.8045449546639;858.5106489301163;27664.446711065666;27811.304717381823;27985.58021629677;28350.574741378896;28507.42985140327;910.5037754423855;942.7784470649392;972.1833659725864;1000.279798545061;1007.6674697349857;14975.625609359853;15153;15181.848181518044;15300.311485983157;15443.30505127272;396171.0191449082;397932;399391;401504;401626;48817;49097.75451122793;49153.26270105951;49163.75418122958;49303.753481232365;1138.5559631743627;1140.1278022312938;1166.562539047857;1167.5796713183247;1191.6663334266245;26609;27840;27881.581776272968;28269.858650706614;28377;41980.370294445;42305.78847105745;42593.36109958291;42711.7864410676;42715.35926961036;331667;332471;333151;334500;335255;25097.74902251027;25525.87237063803;25567.87216063908;25588.872055639604;26491.205263842116;39736.80131599324;39744.40383394309;40459;40497.39253911252;40528.3920741195;33683;34610.653893460745;34821;35179.824100879334;35243.47134793032;34602.82698586491;34899.4765078519;35265.29469410546;35721.46417803787;36058.45912311265;34278.82860585681;34500.82749586236;34513.30973380568;34664.30671386508;34734;30461.695383045884;31489.527657084705;31502.212444689067;31683.36633267368;31964.68035319617;24566.263012109666;24864.37839054038;24892.626610600495;25087.32391550963;25204 15:33:01 INFO - PROCESS | 29735 | |2;jquery.html;365.2202547560958;366.28939856678045;372.07539264926663;378.8030224283371;387.80997311317446;16107.275172617232;17922.37271695491;17951.910240448797;18279.908600457013;18439.354622588213;11380.715482112952;15676.84323156768;16468.176591170424;16468.505944821645;17386.913065434655;4669.603083737878;4777.546133117348;4814.0371925614845;4816.181249187629;4824.807007719687;3453.8963831084984;5249.737513124348;5534.916976245359;5536.806211782588;5619.072852979253;5571.721413929287;5579.442055794429;5596.468335508141;5596.972015139919;5603.719814009283;5994.520438364921;6188.040853667666;6200.193974783295;6204.286507051702;6213.5339849511465;4520.841770538048;4890.584300334476;5437.374701909292;5448.37343705475;5469.644473109275;12266.877331226751;12480.063995200397;12598.937005314914;12624;18128.637427251382;1897.7343171955938;1901.3630433804692;1930.7972662870477;2027.7972202779752;2320.1995311617466;9108.180263776292;9170.128837760401;9291.58187881547;9363.157315841607;9521.714348569554;1570.6151992761731;1589.3801417447205;1600.231888693422;1627.601237696772;1661.2109248107174;69404.65297673529;72072;73538.69075891598;73816;74695.87956180607;9943.502824858728;10033.498325083863;10507.94746026265;10595.894041059644;10710.839337409945;14124;14144.22206778637;14147.434102635985;14169;14207.218602976936;6705.4970877184405;6766.120404347404;6897.55165914214;6975.720971161199;7046;6391.296957334689;6394.648294343763;6437.517186211053;6574.211094668671;6581.769638062645;4305.9569404306185;4306;4351.564843515623;4397.164538737629;4413.426254586947;1673.1048888844653;1780.7685000949793;1849.7525506509655;1855.3506272804411;1886.547228665138;793.1949071692237;806.7095845495617;890.9420887642283;904.2359206470522;949.3164921256684;17089.230984605474;17466.476005719596;17557.912210438866;17745.7338139928;17901.820981790275;818.9713360032371;830.3274347778319;839.1650307943635;843.700486327345;846.5597889097635;9375;10012.349197302152;10067.647632332833;10092.243081768896;10092.495375231209;138618;139216;261854;360116;365254;50712.23931641028;76395.61802190954;78056.21943780604;78498.21501784908;80555.59722201352;918.7473444802732;925.509479975614;929.2751653710117;944.4191822029402;949.0462085603924;14866.614348766923;14995.700085998;15593.76609350838;15697.529074127795;16139.354425823305;37446.06384840401;37487.43768843415;38698.61301387063;39445.60554394419;39505.604943950195;48523;49507.75246123746;50113;51015.74492127515;51053.74473127611;7458.664360103917;7507.88738168917;7709.0749110107145;7791.4935529190425;7878.290953814184;11050.557977681125;11265.155113366367;11321.320720756781;11386.146039047271;11708.590199342982;9765.560549775419;10072.748181295234;10229.795404091728;10400.635977740743;10474.68575942723;10164.186865050926;10222.437765922945;10267.640632577824;10304.330218535772;10526.842097368393;9885.654002109892;10164.949175254076;10164.949175254076;10309.22680798928;10450.895491045296;7337.889931650922;7379.704811807467;7434.3309102181065;7537.773866783786;7632.045994250719;9145.771355715895;9641.951790241004;9814.018598140128;9936.701898943043;10389.272750907365 15:33:01 INFO - PROCESS | 29735 | |3;mootools.html;1368.2064402646463;1399.1744870526388;1488.449273768705;1675.1624187906048;1675.2042779679646;6439;6999.090118284628;7028.894566581499;7570.735024274159;7610.657520411581;7136.8929466057925;7325.084364454443;7361.153467351256;7400.296971787685;7419.406447484202;2124.4901223706315;2162.308061420346;2166.0902420983225;2168.078566609193;2173.576152650234;2047.0890453748088;2064.2981386328647;2147.45239963809;2148.6884401761736;2149.1296025109855;2114.7356580427445;2156.212982261479;2156.6549352103666;2162.6323525000707;2177.4012146659716;2120.120150137691;2122.3420739570706;2123.0764617391483;2132.1577976699273;2135.9145634174615;2065.0810389376734;2092.184048221195;2092.3409126125375;2093.7801530839197;2096.3815674376096;7429.814254643623;7482.176960534337;7526.5107767994905;7526.962365188139;7528.134264559591;4400.185965596375;4426.269665505188;4429.53489883564;4436.600705936449;4439.5560443955665;2693.46130773846;2706.093458691341;2709.336212627899;2729.249456399486;2810.241234866595;845.6870957745673;860.3762272352494;862.4264863865521;881.5283823154646;887.2325438495719;10012.399256044588;10062.19502439803;10074.14369778577;10074.9496252519;10111.292209545334;3929.548101968253;3957.109650328711;4134.545200027995;4139.2135494256;4198.223328684203;8644.394892357475;8687.131286871389;8689.261412779984;8698.608562614698;8719.38964272495;4606.078784243165;4616.0767846430845;4630.560096790799;4635.860924172281;4643.349931009661;3687;4011.4183443400543;4185.267578173868;4239.215745087169;4265.466816647919;3532.894013179609;3545.1137215696076;3573.3032058748295;3631.473436351767;3671.0271777978855;1144.7080994346554;1152.948117334722;1163.5811108001112;1167.3462860797981;1175.2360965372404;769.8152443413652;780.9492382995087;808.4098608016182;809.9352051835839;820.4502983001404;4635.559621835921;4816.277558366273;4927.384076990376;4988.127077761377;5024.321716568216;782.964766585505;789.0610173893049;807.725373373056;881.9259677651114;894.6376717429451;3201.551782750417;3243.6756324367375;3314.585676790401;3340.9498857517156;3377.3920694275266;8800.8679869802;9169.679061232824;9265.536723163816;9287.396319239228;9301.162895339452;9148.542572871464;9170.86243706345;9181.35730498872;9222.907770922338;9253.352265341497;6656.201255849329;6706.429953454011;6724.125863637696;6797.592144471348;6799.660016999131;4550.431196100488;4649.628029757679;4680.4149481314835;4685.929711054405;4749.192637251606;7916;7942.6028698566;7952.681892724458;8029.839403211786;8048.601361917406;8021.478603890729;8081.15147909461;8159.224873636995;8258.215469530385;8267.875981860398;5490.862728431821;5912.940870591411;6127.632342059491;6197.25632924052;6264.31092579825;7078.115235595551;7105.964470177616;7143.321384468467;7150.678219480032;7190.604516751629;6326.367363263821;6369.363063693593;6406.551541392244;6434.324395938359;6541.116949211795;6311.558190926775;6434.678266086583;6451.741930322734;6504.934950650433;6572;5791.797287094932;5817;5820.883582328245;5830.53355731532;5839.15332276809;4224.091820258659;4272.4445822042935;4293.806778694904;4349.478062632505;4466.57567531084;4152.979235103805;4245.554216807314;4264.317709166518;4288.356746487927;4391.1217756448195 15:33:01 INFO - PROCESS | 29735 | |4;prototype.html;298.4285094044904;308.40016168552165;311.8051217988757;316.31044323375033;320.18353199341675;4880.170371036923;4944.332515110459;5014.8244811431605;5088.185890257564;5098.362704661918;4992.875178120549;5004.449510553845;5019.799208031674;5047.394312682483;5049.873753156173;3958.584348643394;3991.900202494939;3999.6600288975474;4013.9598604013877;4014.6788256939376;3913.236918800835;3996.320625493673;4003.9199216015663;4025.9798701006453;4038.899027524306;3948.368261078228;3958.5447673517624;3959.227950549644;3970.9205815883665;3981.840726370942;3948.921021579581;3966.4050392441363;3984.3226651469176;3992.201559688074;4000.199860097943;3534.4344904815107;3544.61009288978;3545.6244316308134;3546.3616549021167;3556.448750443685;4873.610111191097;4881.389826271716;4950.306957025983;4969.527894849984;5029.723365214912;4513.323001549761;4523.525029871849;4537.3647689323525;4540.77296135192;4552.112338094073;5233.4243233244315;5300.257963885059;5301.496357845998;5302.814401495968;5331.2003199519995;3744.569374521938;3783.1109689223285;3817.2365526894455;3831.8658846940502;3847.903802404934;5471.534919531805;5540.196671482653;5551.945130425247;5596.916046259309;5597.244372009726;3878.5151856017997;3900.1419687668667;3939.901502462404;3949.4075888616935;3949.92100158001;3917.2361389529337;4007.579204183577;4011;4014.237294913957;4018.1963607278662;4488.326750987378;4503.144402563503;4515.571020753023;4536.434929949162;4553.203189441834;5294.814681486129;5314.362276526842;5362.946370536245;5372.811951581676;5381.434949330264;1298.0978220137104;1345.724126554054;1371.71879764648;1375.8073869658256;1376.5388594820647;945.2201933404968;953.9475328856979;956.3974695941512;968.4770224078918;976.1653786012998;4468.17338792318;4490.348899409567;4502.482214545369;4506.166359223488;4520.819167233274;5325.520703136659;5348;5349.438308977579;5374.731263436813;5381;4366;4486.977565112154;4501.887452813706;4555.931661025087;4556.658250631216;2530.962035569468;2538.37809736612;2547.847129172256;2549.961750573743;2561.218828257362;4481.624738888394;4482.282834746425;4486.711776993691;4490.955090449119;4504.211762941472;4460.330950357407;4713.97299161357;4833.728147770542;4892.486288939681;4895.31465594817;4387.473503179639;4394.494633117169;4432.556744325541;4459.699822131599;4466.106778644349;4664.510226426177;4666.650001249987;4714.4106986626675;4750.406199225097;4802.375691160127;4623.144718227139;4625.884352891205;4640.86077417678;4645.790939407667;4649.256119021075;4723.598494128038;5121;5132.178851383761;5160.354955630546;5170.793168273227;3847.6533213375096;3865.9420108698955;3878.166194268246;3883.902902427462;3893.4159876018825;5185.9222111667605;5250.448702886142;5476.67139971603;5492.80775172867;5493.725313734218;5268.367795864521;5289.8677533060445;5294.682319060868;5295.232191332312;5304.9204261936875;5285.867853303698;5287.788488460418;5292.285541451854;5292.682439053515;5301.655392399482;4907.533784290486;5146.150885103916;5151.768170432265;5199.532042116228;5210.192420174879;5298.682079075268;5371.40914499397;5379.462053794746;5396.595255355785;5402.243685883901;5183.015227106837;5194.506521880416;5215.765290561858;5220.686758794484;5252.9737351313 15:33:01 INFO - PROCESS | 29735 | |5;yui.html;667.4993754683987;688.555881456461;711.3846522757813;719.5502810743285;725.6009194942782;11065.280756750806;11937.403129843517;11991.280523168616;12008.879911200886;12009.159358844885;11733.061355091593;11808.173427860032;12005.099617528676;12007.579734709287;12013.459394327254;622.6855438003802;749.9925000750004;764.9923500764977;766.2414209932183;771.9845603087934;742.0724094881398;765.4985984180371;771.2095102519905;775.6974779835869;777.7899967008905;823.6581818545296;828.5277391886627;832.0265289611169;832.2094010689839;832.9625166867505;806.1293802693077;812.8658771302728;819.0171793847406;819.0949001353479;823.6746485138397;609.2810483629315;611.3794498583941;611.4863514647673;611.5138464920399;613.5429105316567;12129.090318226168;12185.634430967086;12191.207571507824;12217.266963982189;12219.205751626116;13573.389197486038;13910.095843770123;13936.163830170222;13959.930200348934;14052.789208161887;10796.51415686296;10832.945835270852;10843.186760992958;10878.401687907162;10881.292715973437;3240.513922911582;3257.218267615779;3273.836308184605;3287.6383597804224;3341.9498707519406;53641.73179134118;55954.16068758972;56083.719581401834;63297.68351158261;63517.36482635161;10752.354858708502;10771.299865508718;10809.729756755987;10928.781424371467;10983.890161098287;18585;18652.44042678722;18673.15970781318;18681.53296167607;19510.31713890007;6736.157980252468;7035.6482175891;7117.395021423237;7121.181064177686;7346.118465784033;3458.342914846171;3590.982045089758;3610;3621.420572708354;3627.05696518907;2747.917562473129;2824.0539419294764;3027.4550580895652;3159.605049368829;3194.6326172490462;531.1024368816687;537.7472587883767;539.9659651766823;554.3763266325384;564.2495481010246;475.5672338172247;538.1067428069387;560.6411896386317;566.6458463460337;572.4304317204409;8459.95770021146;8697.347698922606;8884;8966.103389660982;9071.365004449624;480.56988994849416;560.5963706131579;620.6958590290725;634.429013887505;636.5734957578434;4159.1265834175165;4209.557996410333;4219.662427005894;4248.4477017987465;4279.40088387626;61092.69453652703;92379.0762092384;99426;107639.46180269048;108606;56798.71600642053;97064;97437.51281243691;97457.20905897414;98878.5056074715;63610;65928;71639;74109.6294518524;83727;8727.345449091217;9318.72043838686;9431.245500360092;9448.244140468609;9489.240860731263;42105.36841947312;43872.78063609661;44147.558524414344;45369;46535.53464465447;35022.82488587541;35807;35831.46252806158;39517.60482395254;62332.68833655984;10559.313644613076;10927.508262128064;10974.506147223554;11065.502052407823;11141.16441266892;11906.940465297617;12209.816852747394;12571.685707857378;12998.350082496027;13270.071095023255;12648.494060237488;12683.365831708563;12747.936260318638;12857.568533969159;12978.091533592558;12148.696282593006;12280;12311;12343.321117338273;12584;9690.8370995481;10967.890321097006;11582.710432238924;11746.29522228669;11915.523379065087;10476.580936762444;10641.308314959502;10741.838872417076;10840.205036772775;11021.44892755375;10278.691639250834;10563.94718026405;10591.258611897401;10656.786864262516;10694.41180735067 15:33:01 INFO - PROCESS | 29735 | __end_tp_report 15:33:01 INFO - PROCESS | 29735 | __start_cc_report 15:33:01 INFO - PROCESS | 29735 | _x_x_mozilla_cycle_collect,390 15:33:01 INFO - PROCESS | 29735 | __end_cc_report 15:33:01 INFO - PROCESS | 29735 | __startTimestamp1468276381933__endTimestamp 15:33:01 INFO - PROCESS | 29735 | 15:33:01 INFO - PROCESS | 29735 | ------- Summary: start ------- 15:33:01 INFO - PROCESS | 29735 | Number of tests: 6 15:33:01 INFO - PROCESS | 29735 | 15:33:01 INFO - PROCESS | 29735 | [#0] dojo.html Cycles:165 Average:4720.66 Median:4861.39 stddev:617.71 (12.7%) stddev-sans-first:597.57 15:33:01 INFO - PROCESS | 29735 | Values: 2636.1 2651.2 2661.6 2668.8 2671.1 4711.0 4750.7 4778.8 4788.9 4810.1 4681.2 4772.4 4774.6 4779.6 4842.4 4362.7 4409.8 4451.1 4467.9 4480.0 162.8 4346.4 4385.3 4456.4 4469.9 4399.7 4403.8 4422.6 4435.0 4467.5 4418.6 4424.8 4444.7 4446.2 4492.3 4361.1 4423.1 4429.2 4455.4 4457.5 4804.7 4837.5 4848.4 4853.4 4858.8 4963.2 5060.2 5141.9 5145.6 5168.5 5134.4 5134.6 5136.2 5162.6 5165.6 4861.4 4871.0 4872.3 4882.1 4926.0 5234.9 5273.2 5310.7 5328.5 5337.5 5088.7 5104.4 5112.2 5114.2 5116.3 5192.1 5197.7 5208.0 5211.0 5212.6 4960.1 5060.5 5120.7 5133.9 5151.5 5115.0 5117.4 5124.2 5139.9 5193.1 4306.7 4361.9 4390.3 4398.9 4439.3 3728.8 3761.2 3766.3 3821.1 3823.3 4340.4 4370.3 4377.7 4391.8 4434.3 5124.7 5145.6 5155.7 5169.9 5203.7 4303.0 4406.6 4407.6 4408.3 4434.7 4560.7 4590.2 4642.6 4644.2 4654.1 4789.4 4818.6 4819.8 4826.6 4855.7 4977.6 4999.5 5170.9 5177.1 5238.6 4671.4 4719.5 4721.8 4722.4 4779.6 5020.6 5020.8 5024.0 5027.6 5068.7 4955.9 5024.9 5087.7 5120.5 5155.4 5040.3 5040.5 5064.6 5074.3 5102.1 4963.8 4992.8 5059.5 5077.7 5105.8 4814.2 4914.3 4926.3 4927.8 4960.6 5079.3 5087.2 5094.8 5112.1 5138.6 4755.7 4923.5 4924.6 4940.2 4989.7 15:33:01 INFO - PROCESS | 29735 | 15:33:01 INFO - PROCESS | 29735 | [#1] ext.html Cycles:180 Average:47018.29 Median:35211.65 stddev:89334.56 (253.7%) stddev-sans-first:89517.08 15:33:01 INFO - PROCESS | 29735 | Values: 564.0 564.4 566.0 568.0 597.0 34733.5 38322.0 38367.6 38372.6 38392.6 37790.4 38415.6 38758.8 38784.6 38810.0 7775.1 7817.3 7914.3 7922.7 7924.2 7852.8 7898.7 7900.2 7925.4 7947.3 7942.0 7963.0 7974.4 7991.0 7992.9 7900.2 7901.3 7914.0 7920.3 7942.9 7687.5 7871.3 7883.4 7889.9 7898.4 36762.8 36818.8 36989.4 37316.4 37337.4 2662.8 3011.7 3108.8 3126.0 3187.9 26646.9 27986.2 28762.0 28766.1 29554.9 3219.6 3244.5 3280.7 3381.2 3416.6 212123.0 278195.0 280588.0 280759.0 282654.0 32160.5 33241.5 55488.4 56246.7 56294.2 33543.8 33597.3 33805.7 33840.5 33847.0 11571.0 11660.2 11747.5 11788.5 11844.2 9532.3 9611.8 9618.2 9626.4 9733.0 7824.6 7899.1 7919.0 7920.4 7952.6 3079.4 3102.0 3107.1 3117.2 3127.5 799.8 809.9 840.1 849.8 858.5 27664.4 27811.3 27985.6 28350.6 28507.4 910.5 942.8 972.2 1000.3 1007.7 14975.6 15153.0 15181.8 15300.3 15443.3 396171.0 397932.0 399391.0 401504.0 401626.0 48817.0 49097.8 49153.3 49163.8 49303.8 1138.6 1140.1 1166.6 1167.6 1191.7 26609.0 27840.0 27881.6 28269.9 28377.0 41980.4 42305.8 42593.4 42711.8 42715.4 331667.0 332471.0 333151.0 334500.0 335255.0 25097.7 25525.9 25567.9 25588.9 26491.2 39736.8 39744.4 40459.0 40497.4 40528.4 33683.0 34610.7 34821.0 35179.8 35243.5 34602.8 34899.5 35265.3 35721.5 36058.5 34278.8 34500.8 34513.3 34664.3 34734.0 30461.7 31489.5 31502.2 31683.4 31964.7 24566.3 24864.4 24892.6 25087.3 25204.0 15:33:01 INFO - PROCESS | 29735 | 15:33:01 INFO - PROCESS | 29735 | [#2] jquery.html Cycles:180 Average:20293.52 Median:4374.36 stddev:46269.93 (1057.8%) stddev-sans-first:46375.54 15:33:01 INFO - PROCESS | 29735 | Values: 365.2 366.3 372.1 378.8 387.8 16107.3 17922.4 17951.9 18279.9 18439.4 11380.7 15676.8 16468.2 16468.5 17386.9 4669.6 4777.5 4814.0 4816.2 4824.8 3453.9 5249.7 5534.9 5536.8 5619.1 5571.7 5579.4 5596.5 5597.0 5603.7 5994.5 6188.0 6200.2 6204.3 6213.5 4520.8 4890.6 5437.4 5448.4 5469.6 12266.9 12480.1 12598.9 12624.0 18128.6 1897.7 1901.4 1930.8 2027.8 2320.2 9108.2 9170.1 9291.6 9363.2 9521.7 1570.6 1589.4 1600.2 1627.6 1661.2 69404.7 72072.0 73538.7 73816.0 74695.9 9943.5 10033.5 10507.9 10595.9 10710.8 14124.0 14144.2 14147.4 14169.0 14207.2 6705.5 6766.1 6897.6 6975.7 7046.0 6391.3 6394.6 6437.5 6574.2 6581.8 4306.0 4306.0 4351.6 4397.2 4413.4 1673.1 1780.8 1849.8 1855.4 1886.5 793.2 806.7 890.9 904.2 949.3 17089.2 17466.5 17557.9 17745.7 17901.8 819.0 830.3 839.2 843.7 846.6 9375.0 10012.3 10067.6 10092.2 10092.5 138618.0 139216.0 261854.0 360116.0 365254.0 50712.2 76395.6 78056.2 78498.2 80555.6 918.7 925.5 929.3 944.4 949.0 14866.6 14995.7 15593.8 15697.5 16139.4 37446.1 37487.4 38698.6 39445.6 39505.6 48523.0 49507.8 50113.0 51015.7 51053.7 7458.7 7507.9 7709.1 7791.5 7878.3 11050.6 11265.2 11321.3 11386.1 11708.6 9765.6 10072.7 10229.8 10400.6 10474.7 10164.2 10222.4 10267.6 10304.3 10526.8 9885.7 10164.9 10164.9 10309.2 10450.9 7337.9 7379.7 7434.3 7537.8 7632.0 9145.8 9642.0 9814.0 9936.7 10389.3 15:33:01 INFO - PROCESS | 29735 | 15:33:01 INFO - PROCESS | 29735 | [#3] mootools.html Cycles:180 Average:4848.16 Median:4782.74 stddev:2673.17 (55.9%) stddev-sans-first:2667.88 15:33:01 INFO - PROCESS | 29735 | Values: 1368.2 1399.2 1488.4 1675.2 1675.2 6439.0 6999.1 7028.9 7570.7 7610.7 7136.9 7325.1 7361.2 7400.3 7419.4 2124.5 2162.3 2166.1 2168.1 2173.6 2047.1 2064.3 2147.5 2148.7 2149.1 2114.7 2156.2 2156.7 2162.6 2177.4 2120.1 2122.3 2123.1 2132.2 2135.9 2065.1 2092.2 2092.3 2093.8 2096.4 7429.8 7482.2 7526.5 7527.0 7528.1 4400.2 4426.3 4429.5 4436.6 4439.6 2693.5 2706.1 2709.3 2729.2 2810.2 845.7 860.4 862.4 881.5 887.2 10012.4 10062.2 10074.1 10074.9 10111.3 3929.5 3957.1 4134.5 4139.2 4198.2 8644.4 8687.1 8689.3 8698.6 8719.4 4606.1 4616.1 4630.6 4635.9 4643.3 3687.0 4011.4 4185.3 4239.2 4265.5 3532.9 3545.1 3573.3 3631.5 3671.0 1144.7 1152.9 1163.6 1167.3 1175.2 769.8 780.9 808.4 809.9 820.5 4635.6 4816.3 4927.4 4988.1 5024.3 783.0 789.1 807.7 881.9 894.6 3201.6 3243.7 3314.6 3340.9 3377.4 8800.9 9169.7 9265.5 9287.4 9301.2 9148.5 9170.9 9181.4 9222.9 9253.4 6656.2 6706.4 6724.1 6797.6 6799.7 4550.4 4649.6 4680.4 4685.9 4749.2 7916.0 7942.6 7952.7 8029.8 8048.6 8021.5 8081.2 8159.2 8258.2 8267.9 5490.9 5912.9 6127.6 6197.3 6264.3 7078.1 7106.0 7143.3 7150.7 7190.6 6326.4 6369.4 6406.6 6434.3 6541.1 6311.6 6434.7 6451.7 6504.9 6572.0 5791.8 5817.0 5820.9 5830.5 5839.2 4224.1 4272.4 4293.8 4349.5 4466.6 4153.0 4245.6 4264.3 4288.4 4391.1 15:33:01 INFO - PROCESS | 29735 | 15:33:01 INFO - PROCESS | 29735 | [#4] prototype.html Cycles:180 Average:4293.55 Median:4589.90 stddev:1226.69 (26.7%) stddev-sans-first:1192.92 15:33:01 INFO - PROCESS | 29735 | Values: 298.4 308.4 311.8 316.3 320.2 4880.2 4944.3 5014.8 5088.2 5098.4 4992.9 5004.4 5019.8 5047.4 5049.9 3958.6 3991.9 3999.7 4014.0 4014.7 3913.2 3996.3 4003.9 4026.0 4038.9 3948.4 3958.5 3959.2 3970.9 3981.8 3948.9 3966.4 3984.3 3992.2 4000.2 3534.4 3544.6 3545.6 3546.4 3556.4 4873.6 4881.4 4950.3 4969.5 5029.7 4513.3 4523.5 4537.4 4540.8 4552.1 5233.4 5300.3 5301.5 5302.8 5331.2 3744.6 3783.1 3817.2 3831.9 3847.9 5471.5 5540.2 5551.9 5596.9 5597.2 3878.5 3900.1 3939.9 3949.4 3949.9 3917.2 4007.6 4011.0 4014.2 4018.2 4488.3 4503.1 4515.6 4536.4 4553.2 5294.8 5314.4 5362.9 5372.8 5381.4 1298.1 1345.7 1371.7 1375.8 1376.5 945.2 953.9 956.4 968.5 976.2 4468.2 4490.3 4502.5 4506.2 4520.8 5325.5 5348.0 5349.4 5374.7 5381.0 4366.0 4487.0 4501.9 4555.9 4556.7 2531.0 2538.4 2547.8 2550.0 2561.2 4481.6 4482.3 4486.7 4491.0 4504.2 4460.3 4714.0 4833.7 4892.5 4895.3 4387.5 4394.5 4432.6 4459.7 4466.1 4664.5 4666.7 4714.4 4750.4 4802.4 4623.1 4625.9 4640.9 4645.8 4649.3 4723.6 5121.0 5132.2 5160.4 5170.8 3847.7 3865.9 3878.2 3883.9 3893.4 5185.9 5250.4 5476.7 5492.8 5493.7 5268.4 5289.9 5294.7 5295.2 5304.9 5285.9 5287.8 5292.3 5292.7 5301.7 4907.5 5146.2 5151.8 5199.5 5210.2 5298.7 5371.4 5379.5 5396.6 5402.2 5183.0 5194.5 5215.8 5220.7 5253.0 15:33:01 INFO - PROCESS | 29735 | 15:33:01 INFO - PROCESS | 29735 | [#5] yui.html Cycles:180 Average:17127.18 Median:4184.34 stddev:24633.60 (588.7%) stddev-sans-first:24671.70 15:33:01 INFO - PROCESS | 29735 | Values: 667.5 688.6 711.4 719.6 725.6 11065.3 11937.4 11991.3 12008.9 12009.2 11733.1 11808.2 12005.1 12007.6 12013.5 622.7 750.0 765.0 766.2 772.0 742.1 765.5 771.2 775.7 777.8 823.7 828.5 832.0 832.2 833.0 806.1 812.9 819.0 819.1 823.7 609.3 611.4 611.5 611.5 613.5 12129.1 12185.6 12191.2 12217.3 12219.2 13573.4 13910.1 13936.2 13959.9 14052.8 10796.5 10832.9 10843.2 10878.4 10881.3 3240.5 3257.2 3273.8 3287.6 3341.9 53641.7 55954.2 56083.7 63297.7 63517.4 10752.4 10771.3 10809.7 10928.8 10983.9 18585.0 18652.4 18673.2 18681.5 19510.3 6736.2 7035.6 7117.4 7121.2 7346.1 3458.3 3591.0 3610.0 3621.4 3627.1 2747.9 2824.1 3027.5 3159.6 3194.6 531.1 537.7 540.0 554.4 564.2 475.6 538.1 560.6 566.6 572.4 8460.0 8697.3 8884.0 8966.1 9071.4 480.6 560.6 620.7 634.4 636.6 4159.1 4209.6 4219.7 4248.4 4279.4 61092.7 92379.1 99426.0 107639.5 108606.0 56798.7 97064.0 97437.5 97457.2 98878.5 63610.0 65928.0 71639.0 74109.6 83727.0 8727.3 9318.7 9431.2 9448.2 9489.2 42105.4 43872.8 44147.6 45369.0 46535.5 35022.8 35807.0 35831.5 39517.6 62332.7 10559.3 10927.5 10974.5 11065.5 11141.2 11906.9 12209.8 12571.7 12998.4 13270.1 12648.5 12683.4 12747.9 12857.6 12978.1 12148.7 12280.0 12311.0 12343.3 12584.0 9690.8 10967.9 11582.7 11746.3 11915.5 10476.6 10641.3 10741.8 10840.2 11021.4 10278.7 10563.9 10591.3 10656.8 10694.4 15:33:01 INFO - PROCESS | 29735 | -------- Summary: end -------- 15:33:01 INFO - PROCESS | 29735 | 15:33:02 INFO - TEST-INFO | 29735: exit 0 15:33:02 INFO - TEST-OK | dromaeo_css | took 1116978ms 15:33:02 INFO - TEST-START | kraken 15:33:02 INFO - operating with platform_type : linux_ 15:33:02 INFO - Initialising browser for kraken test... 15:33:02 INFO - TEST-INFO | started process 29984 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYYqgpU/profile http://localhost:48287/getInfo.html) 15:33:07 INFO - PROCESS | 29984 | __metrics Screen width/height:1600/1200 15:33:07 INFO - PROCESS | 29984 | colorDepth:24 15:33:07 INFO - PROCESS | 29984 | Browser inner width/height: 1024/697 15:33:07 INFO - PROCESS | 29984 | __metrics 15:33:08 ERROR - PROCESS | 29984 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 15:33:08 INFO - TEST-INFO | 29984: exit 0 15:33:08 INFO - Browser initialized. 15:33:08 INFO - Running cycle 1/1 for kraken test... 15:33:09 INFO - TEST-INFO | started process 30108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYYqgpU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:33:20 INFO - PROCESS | 30108 | RSS: Main: 168701952 15:33:20 INFO - PROCESS | 30108 | 15:33:23 INFO - PROCESS | 30108 | Cycle 1(1): loaded http://localhost:48287/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48287/tests/kraken/driver.html?testName=audio-beat-detection) 15:33:24 INFO - PROCESS | 30108 | RSS: Main: 173953024 15:33:24 INFO - PROCESS | 30108 | 15:33:27 INFO - PROCESS | 30108 | Cycle 1(1): loaded http://localhost:48287/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48287/tests/kraken/driver.html?testName=audio-dft) 15:33:27 INFO - PROCESS | 30108 | RSS: Main: 174080000 15:33:27 INFO - PROCESS | 30108 | 15:33:30 INFO - PROCESS | 30108 | Cycle 1(1): loaded http://localhost:48287/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48287/tests/kraken/driver.html?testName=audio-fft) 15:33:31 INFO - PROCESS | 30108 | RSS: Main: 169439232 15:33:31 INFO - PROCESS | 30108 | 15:33:33 INFO - PROCESS | 30108 | Cycle 1(1): loaded http://localhost:48287/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48287/tests/kraken/driver.html?testName=audio-oscillator) 15:33:34 INFO - PROCESS | 30108 | RSS: Main: 169058304 15:33:34 INFO - PROCESS | 30108 | 15:33:36 INFO - PROCESS | 30108 | Cycle 1(1): loaded http://localhost:48287/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48287/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:33:37 INFO - PROCESS | 30108 | RSS: Main: 169340928 15:33:37 INFO - PROCESS | 30108 | 15:33:40 INFO - PROCESS | 30108 | Cycle 1(1): loaded http://localhost:48287/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48287/tests/kraken/driver.html?testName=imaging-darkroom) 15:33:41 INFO - PROCESS | 30108 | RSS: Main: 169566208 15:33:41 INFO - PROCESS | 30108 | 15:33:44 INFO - PROCESS | 30108 | Cycle 1(1): loaded http://localhost:48287/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48287/tests/kraken/driver.html?testName=imaging-desaturate) 15:33:45 INFO - PROCESS | 30108 | RSS: Main: 167522304 15:33:45 INFO - PROCESS | 30108 | 15:33:48 INFO - PROCESS | 30108 | Cycle 1(1): loaded http://localhost:48287/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48287/tests/kraken/driver.html?testName=json-parse-financial) 15:33:48 INFO - PROCESS | 30108 | RSS: Main: 168906752 15:33:48 INFO - PROCESS | 30108 | 15:33:50 INFO - PROCESS | 30108 | Cycle 1(1): loaded http://localhost:48287/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48287/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:33:51 INFO - PROCESS | 30108 | RSS: Main: 169525248 15:33:51 INFO - PROCESS | 30108 | 15:33:53 INFO - PROCESS | 30108 | Cycle 1(1): loaded http://localhost:48287/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48287/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:33:53 INFO - PROCESS | 30108 | RSS: Main: 169111552 15:33:53 INFO - PROCESS | 30108 | 15:33:55 INFO - PROCESS | 30108 | Cycle 1(1): loaded http://localhost:48287/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48287/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:33:56 INFO - PROCESS | 30108 | RSS: Main: 169447424 15:33:56 INFO - PROCESS | 30108 | 15:33:59 INFO - PROCESS | 30108 | Cycle 1(1): loaded http://localhost:48287/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48287/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:34:00 INFO - PROCESS | 30108 | RSS: Main: 169541632 15:34:00 INFO - PROCESS | 30108 | 15:34:03 INFO - PROCESS | 30108 | Cycle 1(1): loaded http://localhost:48287/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48287/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:34:03 INFO - PROCESS | 30108 | RSS: Main: 169693184 15:34:03 INFO - PROCESS | 30108 | 15:34:05 INFO - PROCESS | 30108 | Cycle 1(1): loaded http://localhost:48287/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48287/tests/kraken/driver.html?testName=ai-astar) 15:34:05 INFO - PROCESS | 30108 | RSS: Main: 170426368 15:34:05 INFO - PROCESS | 30108 | 15:34:05 INFO - PROCESS | 30108 | __start_tp_report 15:34:05 INFO - PROCESS | 30108 | _x_x_mozilla_page_load 15:34:05 INFO - PROCESS | 30108 | _x_x_mozilla_page_load_details 15:34:05 INFO - PROCESS | 30108 | |i|pagename|runs| 15:34:05 INFO - PROCESS | 30108 | |0;ai-astar;108;115;109;117;117;118;120;115;116;117 15:34:05 INFO - PROCESS | 30108 | |1;audio-beat-detection;166;130;151;187;124;150;148;125;186;125 15:34:05 INFO - PROCESS | 30108 | |2;audio-dft;163;167;165;166;170;165;171;164;164;163 15:34:05 INFO - PROCESS | 30108 | |3;audio-fft;76;76;77;160;77;76;76;81;161;77 15:34:05 INFO - PROCESS | 30108 | |4;audio-oscillator;86;85;149;86;86;87;144;85;86;144 15:34:05 INFO - PROCESS | 30108 | |5;imaging-gaussian-blur;118;118;117;117;117;119;119;118;118;118 15:34:05 INFO - PROCESS | 30108 | |6;imaging-darkroom;148;152;149;149;148;147;147;148;148;148 15:34:05 INFO - PROCESS | 30108 | |7;imaging-desaturate;96;97;95;96;96;95;97;96;96;96 15:34:05 INFO - PROCESS | 30108 | |8;json-parse-financial;64;65;64;64;65;64;65;65;64;65 15:34:05 INFO - PROCESS | 30108 | |9;json-stringify-tinderbox;65;66;65;66;65;65;66;66;66;65 15:34:05 INFO - PROCESS | 30108 | |10;stanford-crypto-aes;79;80;81;79;79;81;84;80;85;81 15:34:05 INFO - PROCESS | 30108 | |11;stanford-crypto-ccm;132;141;141;141;132;134;137;141;177;153 15:34:05 INFO - PROCESS | 30108 | |12;stanford-crypto-pbkdf2;175;174;172;173;171;175;175;176;172;169 15:34:05 INFO - PROCESS | 30108 | |13;stanford-crypto-sha256-iterative;69;68;68;69;69;72;69;71;68;75 15:34:05 INFO - PROCESS | 30108 | __end_tp_report 15:34:05 INFO - PROCESS | 30108 | __start_cc_report 15:34:05 INFO - PROCESS | 30108 | _x_x_mozilla_cycle_collect,999 15:34:05 INFO - PROCESS | 30108 | __end_cc_report 15:34:05 INFO - PROCESS | 30108 | __startTimestamp1468276445726__endTimestamp 15:34:05 INFO - PROCESS | 30108 | 15:34:05 INFO - PROCESS | 30108 | ------- Summary: start ------- 15:34:05 INFO - PROCESS | 30108 | Number of tests: 14 15:34:05 INFO - PROCESS | 30108 | 15:34:05 INFO - PROCESS | 30108 | [#0] ai-astar Cycles:10 Average:115.20 Median:117.00 stddev:3.82 (3.3%) stddev-sans-first:3.04 15:34:05 INFO - PROCESS | 30108 | Values: 108.0 115.0 109.0 117.0 117.0 118.0 120.0 115.0 116.0 117.0 15:34:05 INFO - PROCESS | 30108 | 15:34:05 INFO - PROCESS | 30108 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:150.50 stddev:24.14 (16.0%) stddev-sans-first:24.83 15:34:05 INFO - PROCESS | 30108 | Values: 166.0 130.0 151.0 187.0 124.0 150.0 148.0 125.0 186.0 125.0 15:34:05 INFO - PROCESS | 30108 | 15:34:05 INFO - PROCESS | 30108 | [#2] audio-dft Cycles:10 Average:165.80 Median:165.50 stddev:2.78 (1.7%) stddev-sans-first:2.76 15:34:05 INFO - PROCESS | 30108 | Values: 163.0 167.0 165.0 166.0 170.0 165.0 171.0 164.0 164.0 163.0 15:34:05 INFO - PROCESS | 30108 | 15:34:05 INFO - PROCESS | 30108 | [#3] audio-fft Cycles:10 Average:93.70 Median:76.50 stddev:35.24 (46.1%) stddev-sans-first:36.79 15:34:05 INFO - PROCESS | 30108 | Values: 76.0 76.0 77.0 160.0 77.0 76.0 76.0 81.0 161.0 77.0 15:34:05 INFO - PROCESS | 30108 | 15:34:05 INFO - PROCESS | 30108 | [#4] audio-oscillator Cycles:10 Average:103.80 Median:86.00 stddev:28.93 (33.6%) stddev-sans-first:29.96 15:34:05 INFO - PROCESS | 30108 | Values: 86.0 85.0 149.0 86.0 86.0 87.0 144.0 85.0 86.0 144.0 15:34:05 INFO - PROCESS | 30108 | 15:34:05 INFO - PROCESS | 30108 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 15:34:05 INFO - PROCESS | 30108 | Values: 118.0 118.0 117.0 117.0 117.0 119.0 119.0 118.0 118.0 118.0 15:34:05 INFO - PROCESS | 30108 | 15:34:05 INFO - PROCESS | 30108 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.00 stddev:1.43 (1.0%) stddev-sans-first:1.51 15:34:05 INFO - PROCESS | 30108 | Values: 148.0 152.0 149.0 149.0 148.0 147.0 147.0 148.0 148.0 148.0 15:34:05 INFO - PROCESS | 30108 | 15:34:05 INFO - PROCESS | 30108 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 15:34:05 INFO - PROCESS | 30108 | Values: 96.0 97.0 95.0 96.0 96.0 95.0 97.0 96.0 96.0 96.0 15:34:05 INFO - PROCESS | 30108 | 15:34:05 INFO - PROCESS | 30108 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 15:34:05 INFO - PROCESS | 30108 | Values: 64.0 65.0 64.0 64.0 65.0 64.0 65.0 65.0 64.0 65.0 15:34:05 INFO - PROCESS | 30108 | 15:34:05 INFO - PROCESS | 30108 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 15:34:05 INFO - PROCESS | 30108 | Values: 65.0 66.0 65.0 66.0 65.0 65.0 66.0 66.0 66.0 65.0 15:34:05 INFO - PROCESS | 30108 | 15:34:05 INFO - PROCESS | 30108 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:81.00 stddev:2.08 (2.6%) stddev-sans-first:2.09 15:34:05 INFO - PROCESS | 30108 | Values: 79.0 80.0 81.0 79.0 79.0 81.0 84.0 80.0 85.0 81.0 15:34:05 INFO - PROCESS | 30108 | 15:34:05 INFO - PROCESS | 30108 | [#11] stanford-crypto-ccm Cycles:10 Average:142.90 Median:141.00 stddev:13.46 (9.5%) stddev-sans-first:13.69 15:34:05 INFO - PROCESS | 30108 | Values: 132.0 141.0 141.0 141.0 132.0 134.0 137.0 141.0 177.0 153.0 15:34:05 INFO - PROCESS | 30108 | 15:34:05 INFO - PROCESS | 30108 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:174.50 stddev:2.20 (1.3%) stddev-sans-first:2.24 15:34:05 INFO - PROCESS | 30108 | Values: 175.0 174.0 172.0 173.0 171.0 175.0 175.0 176.0 172.0 169.0 15:34:05 INFO - PROCESS | 30108 | 15:34:05 INFO - PROCESS | 30108 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:69.00 stddev:2.25 (3.3%) stddev-sans-first:2.37 15:34:05 INFO - PROCESS | 30108 | Values: 69.0 68.0 68.0 69.0 69.0 72.0 69.0 71.0 68.0 75.0 15:34:05 INFO - PROCESS | 30108 | -------- Summary: end -------- 15:34:05 INFO - PROCESS | 30108 | 15:34:06 INFO - TEST-INFO | 30108: exit 0 15:34:06 INFO - TEST-OK | kraken | took 64112ms 15:34:06 INFO - SUITE-END | took 1181s 15:34:06 INFO - Completed test suite (00:19:41) 15:34:06 INFO - javascript benchmark 15:34:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6272.933100248067, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2636.0773729194784, 2651.2443953473253, 2661.560842460994, 2668.8265262757923, 2671.0784779251153, 4711.010687755567, 4750.691205071672, 4778.7610619469015, 4788.880277993052, 4810.110129626021, 4681.2275974464255, 4772.379590653219, 4774.570288674018, 4779.64152688548, 4842.370491836056, 4362.694611377205, 4409.779511024436, 4451.065276291983, 4467.865964021084, 4479.955200448003, 162.79182141887156, 4346.413234213373, 4385.320275357325, 4456.3983862178675, 4469.932951005738, 4399.714018588797, 4403.8458653946955, 4422.601965823092, 4434.977825110854, 4467.508574056851, 4418.5581441855875, 4424.756638384888, 4444.688871778977, 4446.244138496463, 4492.348609451611, 4361.149575832714, 4423.0711550574415, 4429.202743506167, 4455.4207952966235, 4457.509673935864, 4804.711717296974, 4837.4920633333695, 4848.369711937426, 4853.39332583427, 4858.829940952085, 4963.205887058053, 5060.190369540893, 5141.948580514184, 5145.614078944094, 5168.508991645787, 5134.383873935151, 5134.614903882224, 5136.178211486182, 5162.561182299509, 5165.63840531163, 4861.392325959255, 4870.95129048705, 4872.342233798463, 4882.096812089704, 4925.950740492585, 5234.947650523446, 5273.235380869753, 5310.654807437504, 5328.547073498718, 5337.546308563816, 5088.745562721923, 5104.3619547556555, 5112.207607820794, 5114.156164232934, 5116.283720279164, 5192.1173400522, 5197.740112994411, 5208.0, 5211.0, 5212.582993360522, 4960.131976904027, 5060.51925067118, 5120.743962801919, 5133.922991155136, 5151.5363617274625, 5114.974425127925, 5117.43708192106, 5124.205748109049, 5139.897202055938, 5193.143131383355, 4306.720063195882, 4361.934570981438, 4390.319500477431, 4398.940829815985, 4439.311906654474, 3728.794916279631, 3761.22894806564, 3766.303233901737, 3821.082940094357, 3823.330917089498, 4340.370646256275, 4370.278903980871, 4377.737335759864, 4391.7584532851, 4434.312681534368, 5124.692518448905, 5145.639805213674, 5155.690658560498, 5169.896602068013, 5203.661761985459, 4303.031817841023, 4406.603405693503, 4407.647388208936, 4408.272635015251, 4434.667399944952, 4560.726356418625, 4590.196715574761, 4642.605378542794, 4644.164050470948, 4654.138984287918, 4789.425268967746, 4818.638602104927, 4819.807207711652, 4826.565609095198, 4855.6601037927, 4977.552020318189, 4999.475055119306, 5170.948290517197, 5177.145770947752, 5238.607104467104, 4671.43942726875, 4719.480857105785, 4721.763911804464, 4722.386089808303, 4779.569838714393, 5020.598352131748, 5020.824271150492, 5023.974880125576, 5027.622928280321, 5068.670536415121, 4955.876103097451, 5024.88528853478, 5087.669301495391, 5120.48795120485, 5155.407128180307, 5040.269160971712, 5040.546350828443, 5064.5948324134715, 5074.289599456153, 5102.132637451717, 4963.801447942042, 4992.750362481934, 5059.544640982329, 5077.7461126944245, 5105.821296254613, 4814.1815891297865, 4914.311996320446, 4926.3349447824085, 4927.802887884444, 4960.578350840219, 5079.314292570456, 5087.211482220262, 5094.847154585368, 5112.130937740668, 5138.588912887035, 4755.690880092783, 4923.532264434873, 4924.556789888928, 4940.209566469348, 4989.650724449254], "value": 4683.135734891447, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.9915401268979, 564.3538148819601, 565.9586361095584, 567.986144731654, 596.9791057312995, 34733.47899781505, 38322.0, 38367.61632383675, 38372.61627383729, 38392.61607383925, 37790.43314350287, 38415.61584384155, 38758.80620596893, 38784.61215387852, 38810.0, 7775.1447340792465, 7817.335526480256, 7914.3272821810215, 7922.683092676286, 7924.207579242087, 7852.842943141134, 7898.723544675938, 7900.209979002111, 7925.405594580401, 7947.284744373005, 7942.0, 7963.0, 7974.401919856005, 7991.041075070971, 7992.920070799305, 7900.209979002111, 7901.328387087047, 7914.0, 7920.326772224368, 7942.880856787153, 7687.500312479671, 7871.252231038042, 7883.448158628898, 7889.921100788976, 7898.407619428566, 36762.81618591917, 36818.815905920565, 36989.44515832265, 37316.44025339622, 37337.439938400945, 2662.8136030477876, 3011.728944395015, 3108.7512998960256, 3126.0, 3187.9043628691174, 26646.866765666047, 27986.160415187373, 28762.0, 28766.137015889555, 29554.852225738734, 3219.5814544109116, 3244.545763593099, 3280.721138703213, 3381.205416727067, 3416.5558477398026, 212123.0, 278195.0, 280588.0, 280759.0, 282654.0, 32160.517592236134, 33241.501377479355, 55488.44511554913, 56246.718766406724, 56294.15558766622, 33543.83228083844, 33597.32805343928, 33805.66194338074, 33840.49239261413, 33847.0, 11571.01646360052, 11660.18378713482, 11747.47136378848, 11788.528458861549, 11844.230125041844, 9532.332736708502, 9611.807763844685, 9618.182454491447, 9626.374285671409, 9732.95133524342, 7824.647890844925, 7899.09160446556, 7919.0, 7920.366370690331, 7952.562609056442, 3079.3687294104657, 3101.984490077535, 3107.0655048856574, 3117.173948903542, 3127.5465057566526, 799.8320352725876, 809.9109097999216, 840.1346612988632, 849.8045449546639, 858.5106489301163, 27664.446711065666, 27811.304717381823, 27985.58021629677, 28350.574741378896, 28507.42985140327, 910.5037754423855, 942.7784470649392, 972.1833659725864, 1000.279798545061, 1007.6674697349857, 14975.625609359853, 15153.0, 15181.848181518044, 15300.311485983157, 15443.30505127272, 396171.0191449082, 397932.0, 399391.0, 401504.0, 401626.0, 48817.0, 49097.75451122793, 49153.26270105951, 49163.75418122958, 49303.753481232365, 1138.5559631743627, 1140.1278022312938, 1166.562539047857, 1167.5796713183247, 1191.6663334266245, 26609.0, 27840.0, 27881.581776272968, 28269.858650706614, 28377.0, 41980.370294445, 42305.78847105745, 42593.36109958291, 42711.7864410676, 42715.35926961036, 331667.0, 332471.0, 333151.0, 334500.0, 335255.0, 25097.74902251027, 25525.87237063803, 25567.87216063908, 25588.872055639604, 26491.205263842116, 39736.80131599324, 39744.40383394309, 40459.0, 40497.39253911252, 40528.3920741195, 33683.0, 34610.653893460745, 34821.0, 35179.824100879334, 35243.47134793032, 34602.82698586491, 34899.4765078519, 35265.29469410546, 35721.46417803787, 36058.45912311265, 34278.82860585681, 34500.82749586236, 34513.30973380568, 34664.30671386508, 34734.0, 30461.695383045884, 31489.527657084705, 31502.212444689067, 31683.36633267368, 31964.68035319617, 24566.263012109666, 24864.37839054038, 24892.626610600495, 25087.32391550963, 25204.0], "value": 16174.086271162896, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.2202547560958, 366.28939856678045, 372.07539264926663, 378.8030224283371, 387.80997311317446, 16107.275172617232, 17922.37271695491, 17951.910240448797, 18279.908600457013, 18439.354622588213, 11380.715482112952, 15676.84323156768, 16468.176591170424, 16468.505944821645, 17386.913065434655, 4669.603083737878, 4777.546133117348, 4814.0371925614845, 4816.181249187629, 4824.807007719687, 3453.8963831084984, 5249.737513124348, 5534.916976245359, 5536.806211782588, 5619.072852979253, 5571.721413929287, 5579.442055794429, 5596.468335508141, 5596.972015139919, 5603.719814009283, 5994.520438364921, 6188.040853667666, 6200.193974783295, 6204.286507051702, 6213.5339849511465, 4520.841770538048, 4890.584300334476, 5437.374701909292, 5448.37343705475, 5469.644473109275, 12266.877331226751, 12480.063995200397, 12598.937005314914, 12624.0, 18128.637427251382, 1897.7343171955938, 1901.3630433804692, 1930.7972662870477, 2027.7972202779752, 2320.1995311617466, 9108.180263776292, 9170.128837760401, 9291.58187881547, 9363.157315841607, 9521.714348569554, 1570.6151992761731, 1589.3801417447205, 1600.231888693422, 1627.601237696772, 1661.2109248107174, 69404.65297673529, 72072.0, 73538.69075891598, 73816.0, 74695.87956180607, 9943.502824858728, 10033.498325083863, 10507.94746026265, 10595.894041059644, 10710.839337409945, 14124.0, 14144.22206778637, 14147.434102635985, 14169.0, 14207.218602976936, 6705.4970877184405, 6766.120404347404, 6897.55165914214, 6975.720971161199, 7046.0, 6391.296957334689, 6394.648294343763, 6437.517186211053, 6574.211094668671, 6581.769638062645, 4305.9569404306185, 4306.0, 4351.564843515623, 4397.164538737629, 4413.426254586947, 1673.1048888844653, 1780.7685000949793, 1849.7525506509655, 1855.3506272804411, 1886.547228665138, 793.1949071692237, 806.7095845495617, 890.9420887642283, 904.2359206470522, 949.3164921256684, 17089.230984605474, 17466.476005719596, 17557.912210438866, 17745.7338139928, 17901.820981790275, 818.9713360032371, 830.3274347778319, 839.1650307943635, 843.700486327345, 846.5597889097635, 9375.0, 10012.349197302152, 10067.647632332833, 10092.243081768896, 10092.495375231209, 138618.0, 139216.0, 261854.0, 360116.0, 365254.0, 50712.23931641028, 76395.61802190954, 78056.21943780604, 78498.21501784908, 80555.59722201352, 918.7473444802732, 925.509479975614, 929.2751653710117, 944.4191822029402, 949.0462085603924, 14866.614348766923, 14995.700085998, 15593.76609350838, 15697.529074127795, 16139.354425823305, 37446.06384840401, 37487.43768843415, 38698.61301387063, 39445.60554394419, 39505.604943950195, 48523.0, 49507.75246123746, 50113.0, 51015.74492127515, 51053.74473127611, 7458.664360103917, 7507.88738168917, 7709.0749110107145, 7791.4935529190425, 7878.290953814184, 11050.557977681125, 11265.155113366367, 11321.320720756781, 11386.146039047271, 11708.590199342982, 9765.560549775419, 10072.748181295234, 10229.795404091728, 10400.635977740743, 10474.68575942723, 10164.186865050926, 10222.437765922945, 10267.640632577824, 10304.330218535772, 10526.842097368393, 9885.654002109892, 10164.949175254076, 10164.949175254076, 10309.22680798928, 10450.895491045296, 7337.889931650922, 7379.704811807467, 7434.3309102181065, 7537.773866783786, 7632.045994250719, 9145.771355715895, 9641.951790241004, 9814.018598140128, 9936.701898943043, 10389.272750907365], "value": 7983.731929833789, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.2064402646463, 1399.1744870526388, 1488.449273768705, 1675.1624187906048, 1675.2042779679646, 6439.0, 6999.090118284628, 7028.894566581499, 7570.735024274159, 7610.657520411581, 7136.8929466057925, 7325.084364454443, 7361.153467351256, 7400.296971787685, 7419.406447484202, 2124.4901223706315, 2162.308061420346, 2166.0902420983225, 2168.078566609193, 2173.576152650234, 2047.0890453748088, 2064.2981386328647, 2147.45239963809, 2148.6884401761736, 2149.1296025109855, 2114.7356580427445, 2156.212982261479, 2156.6549352103666, 2162.6323525000707, 2177.4012146659716, 2120.120150137691, 2122.3420739570706, 2123.0764617391483, 2132.1577976699273, 2135.9145634174615, 2065.0810389376734, 2092.184048221195, 2092.3409126125375, 2093.7801530839197, 2096.3815674376096, 7429.814254643623, 7482.176960534337, 7526.5107767994905, 7526.962365188139, 7528.134264559591, 4400.185965596375, 4426.269665505188, 4429.53489883564, 4436.600705936449, 4439.5560443955665, 2693.46130773846, 2706.093458691341, 2709.336212627899, 2729.249456399486, 2810.241234866595, 845.6870957745673, 860.3762272352494, 862.4264863865521, 881.5283823154646, 887.2325438495719, 10012.399256044588, 10062.19502439803, 10074.14369778577, 10074.9496252519, 10111.292209545334, 3929.548101968253, 3957.109650328711, 4134.545200027995, 4139.2135494256, 4198.223328684203, 8644.394892357475, 8687.131286871389, 8689.261412779984, 8698.608562614698, 8719.38964272495, 4606.078784243165, 4616.0767846430845, 4630.560096790799, 4635.860924172281, 4643.349931009661, 3687.0, 4011.4183443400543, 4185.267578173868, 4239.215745087169, 4265.466816647919, 3532.894013179609, 3545.1137215696076, 3573.3032058748295, 3631.473436351767, 3671.0271777978855, 1144.7080994346554, 1152.948117334722, 1163.5811108001112, 1167.3462860797981, 1175.2360965372404, 769.8152443413652, 780.9492382995087, 808.4098608016182, 809.9352051835839, 820.4502983001404, 4635.559621835921, 4816.277558366273, 4927.384076990376, 4988.127077761377, 5024.321716568216, 782.964766585505, 789.0610173893049, 807.725373373056, 881.9259677651114, 894.6376717429451, 3201.551782750417, 3243.6756324367375, 3314.585676790401, 3340.9498857517156, 3377.3920694275266, 8800.8679869802, 9169.679061232824, 9265.536723163816, 9287.396319239228, 9301.162895339452, 9148.542572871464, 9170.86243706345, 9181.35730498872, 9222.907770922338, 9253.352265341497, 6656.201255849329, 6706.429953454011, 6724.125863637696, 6797.592144471348, 6799.660016999131, 4550.431196100488, 4649.628029757679, 4680.4149481314835, 4685.929711054405, 4749.192637251606, 7916.0, 7942.6028698566, 7952.681892724458, 8029.839403211786, 8048.601361917406, 8021.478603890729, 8081.15147909461, 8159.224873636995, 8258.215469530385, 8267.875981860398, 5490.862728431821, 5912.940870591411, 6127.632342059491, 6197.25632924052, 6264.31092579825, 7078.115235595551, 7105.964470177616, 7143.321384468467, 7150.678219480032, 7190.604516751629, 6326.367363263821, 6369.363063693593, 6406.551541392244, 6434.324395938359, 6541.116949211795, 6311.558190926775, 6434.678266086583, 6451.741930322734, 6504.934950650433, 6572.0, 5791.797287094932, 5817.0, 5820.883582328245, 5830.53355731532, 5839.15332276809, 4224.091820258659, 4272.4445822042935, 4293.806778694904, 4349.478062632505, 4466.57567531084, 4152.979235103805, 4245.554216807314, 4264.317709166518, 4288.356746487927, 4391.1217756448195], "value": 3937.279413632771, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.4285094044904, 308.40016168552165, 311.8051217988757, 316.31044323375033, 320.18353199341675, 4880.170371036923, 4944.332515110459, 5014.8244811431605, 5088.185890257564, 5098.362704661918, 4992.875178120549, 5004.449510553845, 5019.799208031674, 5047.394312682483, 5049.873753156173, 3958.584348643394, 3991.900202494939, 3999.6600288975474, 4013.9598604013877, 4014.6788256939376, 3913.236918800835, 3996.320625493673, 4003.9199216015663, 4025.9798701006453, 4038.899027524306, 3948.368261078228, 3958.5447673517624, 3959.227950549644, 3970.9205815883665, 3981.840726370942, 3948.921021579581, 3966.4050392441363, 3984.3226651469176, 3992.201559688074, 4000.199860097943, 3534.4344904815107, 3544.61009288978, 3545.6244316308134, 3546.3616549021167, 3556.448750443685, 4873.610111191097, 4881.389826271716, 4950.306957025983, 4969.527894849984, 5029.723365214912, 4513.323001549761, 4523.525029871849, 4537.3647689323525, 4540.77296135192, 4552.112338094073, 5233.4243233244315, 5300.257963885059, 5301.496357845998, 5302.814401495968, 5331.2003199519995, 3744.569374521938, 3783.1109689223285, 3817.2365526894455, 3831.8658846940502, 3847.903802404934, 5471.534919531805, 5540.196671482653, 5551.945130425247, 5596.916046259309, 5597.244372009726, 3878.5151856017997, 3900.1419687668667, 3939.901502462404, 3949.4075888616935, 3949.92100158001, 3917.2361389529337, 4007.579204183577, 4011.0, 4014.237294913957, 4018.1963607278662, 4488.326750987378, 4503.144402563503, 4515.571020753023, 4536.434929949162, 4553.203189441834, 5294.814681486129, 5314.362276526842, 5362.946370536245, 5372.811951581676, 5381.434949330264, 1298.0978220137104, 1345.724126554054, 1371.71879764648, 1375.8073869658256, 1376.5388594820647, 945.2201933404968, 953.9475328856979, 956.3974695941512, 968.4770224078918, 976.1653786012998, 4468.17338792318, 4490.348899409567, 4502.482214545369, 4506.166359223488, 4520.819167233274, 5325.520703136659, 5348.0, 5349.438308977579, 5374.731263436813, 5381.0, 4366.0, 4486.977565112154, 4501.887452813706, 4555.931661025087, 4556.658250631216, 2530.962035569468, 2538.37809736612, 2547.847129172256, 2549.961750573743, 2561.218828257362, 4481.624738888394, 4482.282834746425, 4486.711776993691, 4490.955090449119, 4504.211762941472, 4460.330950357407, 4713.97299161357, 4833.728147770542, 4892.486288939681, 4895.31465594817, 4387.473503179639, 4394.494633117169, 4432.556744325541, 4459.699822131599, 4466.106778644349, 4664.510226426177, 4666.650001249987, 4714.4106986626675, 4750.406199225097, 4802.375691160127, 4623.144718227139, 4625.884352891205, 4640.86077417678, 4645.790939407667, 4649.256119021075, 4723.598494128038, 5121.0, 5132.178851383761, 5160.354955630546, 5170.793168273227, 3847.6533213375096, 3865.9420108698955, 3878.166194268246, 3883.902902427462, 3893.4159876018825, 5185.9222111667605, 5250.448702886142, 5476.67139971603, 5492.80775172867, 5493.725313734218, 5268.367795864521, 5289.8677533060445, 5294.682319060868, 5295.232191332312, 5304.9204261936875, 5285.867853303698, 5287.788488460418, 5292.285541451854, 5292.682439053515, 5301.655392399482, 4907.533784290486, 5146.150885103916, 5151.768170432265, 5199.532042116228, 5210.192420174879, 5298.682079075268, 5371.40914499397, 5379.462053794746, 5396.595255355785, 5402.243685883901, 5183.015227106837, 5194.506521880416, 5215.765290561858, 5220.686758794484, 5252.9737351313], "value": 3910.16542631337, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [667.4993754683987, 688.555881456461, 711.3846522757813, 719.5502810743285, 725.6009194942782, 11065.280756750806, 11937.403129843517, 11991.280523168616, 12008.879911200886, 12009.159358844885, 11733.061355091593, 11808.173427860032, 12005.099617528676, 12007.579734709287, 12013.459394327254, 622.6855438003802, 749.9925000750004, 764.9923500764977, 766.2414209932183, 771.9845603087934, 742.0724094881398, 765.4985984180371, 771.2095102519905, 775.6974779835869, 777.7899967008905, 823.6581818545296, 828.5277391886627, 832.0265289611169, 832.2094010689839, 832.9625166867505, 806.1293802693077, 812.8658771302728, 819.0171793847406, 819.0949001353479, 823.6746485138397, 609.2810483629315, 611.3794498583941, 611.4863514647673, 611.5138464920399, 613.5429105316567, 12129.090318226168, 12185.634430967086, 12191.207571507824, 12217.266963982189, 12219.205751626116, 13573.389197486038, 13910.095843770123, 13936.163830170222, 13959.930200348934, 14052.789208161887, 10796.51415686296, 10832.945835270852, 10843.186760992958, 10878.401687907162, 10881.292715973437, 3240.513922911582, 3257.218267615779, 3273.836308184605, 3287.6383597804224, 3341.9498707519406, 53641.73179134118, 55954.16068758972, 56083.719581401834, 63297.68351158261, 63517.36482635161, 10752.354858708502, 10771.299865508718, 10809.729756755987, 10928.781424371467, 10983.890161098287, 18585.0, 18652.44042678722, 18673.15970781318, 18681.53296167607, 19510.31713890007, 6736.157980252468, 7035.6482175891, 7117.395021423237, 7121.181064177686, 7346.118465784033, 3458.342914846171, 3590.982045089758, 3610.0, 3621.420572708354, 3627.05696518907, 2747.917562473129, 2824.0539419294764, 3027.4550580895652, 3159.605049368829, 3194.6326172490462, 531.1024368816687, 537.7472587883767, 539.9659651766823, 554.3763266325384, 564.2495481010246, 475.5672338172247, 538.1067428069387, 560.6411896386317, 566.6458463460337, 572.4304317204409, 8459.95770021146, 8697.347698922606, 8884.0, 8966.103389660982, 9071.365004449624, 480.56988994849416, 560.5963706131579, 620.6958590290725, 634.429013887505, 636.5734957578434, 4159.1265834175165, 4209.557996410333, 4219.662427005894, 4248.4477017987465, 4279.40088387626, 61092.69453652703, 92379.0762092384, 99426.0, 107639.46180269048, 108606.0, 56798.71600642053, 97064.0, 97437.51281243691, 97457.20905897414, 98878.5056074715, 63610.0, 65928.0, 71639.0, 74109.6294518524, 83727.0, 8727.345449091217, 9318.72043838686, 9431.245500360092, 9448.244140468609, 9489.240860731263, 42105.36841947312, 43872.78063609661, 44147.558524414344, 45369.0, 46535.53464465447, 35022.82488587541, 35807.0, 35831.46252806158, 39517.60482395254, 62332.68833655984, 10559.313644613076, 10927.508262128064, 10974.506147223554, 11065.502052407823, 11141.16441266892, 11906.940465297617, 12209.816852747394, 12571.685707857378, 12998.350082496027, 13270.071095023255, 12648.494060237488, 12683.365831708563, 12747.936260318638, 12857.568533969159, 12978.091533592558, 12148.696282593006, 12280.0, 12311.0, 12343.321117338273, 12584.0, 9690.8370995481, 10967.890321097006, 11582.710432238924, 11746.29522228669, 11915.523379065087, 10476.580936762444, 10641.308314959502, 10741.838872417076, 10840.205036772775, 11021.44892755375, 10278.691639250834, 10563.94718026405, 10591.258611897401, 10656.786864262516, 10694.41180735067], "value": 6543.706465028155, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 115.0, 109.0, 117.0, 117.0, 118.0, 120.0, 115.0, 116.0, 117.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 130.0, 151.0, 187.0, 124.0, 150.0, 148.0, 125.0, 186.0, 125.0], "value": 149.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 167.0, 165.0, 166.0, 170.0, 165.0, 171.0, 164.0, 164.0, 163.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 160.0, 77.0, 76.0, 76.0, 81.0, 161.0, 77.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 149.0, 86.0, 86.0, 87.0, 144.0, 85.0, 86.0, 144.0], "value": 103.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 119.0, 119.0, 118.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 152.0, 149.0, 149.0, 148.0, 147.0, 147.0, 148.0, 148.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 96.0, 96.0, 95.0, 97.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 65.0, 65.0, 66.0, 66.0, 66.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 81.0, 79.0, 79.0, 81.0, 84.0, 80.0, 85.0, 81.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 141.0, 141.0, 141.0, 132.0, 134.0, 137.0, 141.0, 177.0, 153.0], "value": 142.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 174.0, 172.0, 173.0, 171.0, 175.0, 175.0, 176.0, 172.0, 169.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 69.0, 69.0, 72.0, 69.0, 71.0, 68.0, 75.0], "value": 69.8, "unit": "score"}]}]} 15:34:06 INFO - Return code: 0 15:34:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:34:07 ERROR - # TBPL SUCCESS # 15:34:07 INFO - Running post-action listener: _resource_record_post_action 15:34:07 INFO - ##### 15:34:07 INFO - ##### Finished run-tests step (success) 15:34:07 INFO - ##### 15:34:07 INFO - Running post-run listener: _resource_record_post_run 15:34:07 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 565006336; Read time: 20; Write time: 578496 15:34:07 INFO - TinderboxPrint: CPU usage
13.4% 15:34:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 15:34:07 INFO - TinderboxPrint: I/O write bytes / time
565,006,336 / 578,496 15:34:07 INFO - TinderboxPrint: CPU idle
8,280.3 (86.6%) 15:34:07 INFO - TinderboxPrint: CPU user
1,223.1 (12.8%) 15:34:07 INFO - TinderboxPrint: Swap in / out
0 / 0 15:34:07 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 260759552; Read time: 0; Write time: 318840 15:34:07 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 300306432; Read time: 0; Write time: 258992 15:34:07 INFO - Running post-run listener: _upload_blobber_files 15:34:07 INFO - Blob upload gear active. 15:34:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:34:07 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 15:34:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:34:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:34:08 INFO - (blobuploader) - INFO - Open directory for files ... 15:34:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:34:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:34:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:34:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:34:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:34:11 INFO - (blobuploader) - INFO - Done attempting. 15:34:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:34:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:34:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:34:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:34:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:34:12 INFO - (blobuploader) - INFO - Done attempting. 15:34:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:34:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:34:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:34:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:34:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:34:13 INFO - (blobuploader) - INFO - Done attempting. 15:34:13 INFO - (blobuploader) - INFO - Iteration through files over. 15:34:13 INFO - Return code: 0 15:34:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:34:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:34:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54c1b5fb3aef027e89e39bb76dbdfb60dd5fd3b606c1e337e74d2e9874dee477f36562d7873ee5dfada2b7969ea01814a6168e3a3f65f2bfb5c9b3f77e2da111", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f00cd8d7d831c3b91a36845b23cd96165594329766c32e5d901ab417cfa077842dae1810a464305ef8fd92715cdea15cc4b858239589c004d0534a7cfc25c8da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/faf3c20501720b83627e66dc04b8d3ab0a734f2c6481305cd721c41fe4c25e00e6d3b70df9aba247c8a44173e9ed6af07dc19bbb71054c75f8af195cd707fbc5"} 15:34:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:34:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:34:13 INFO - Contents: 15:34:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54c1b5fb3aef027e89e39bb76dbdfb60dd5fd3b606c1e337e74d2e9874dee477f36562d7873ee5dfada2b7969ea01814a6168e3a3f65f2bfb5c9b3f77e2da111", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f00cd8d7d831c3b91a36845b23cd96165594329766c32e5d901ab417cfa077842dae1810a464305ef8fd92715cdea15cc4b858239589c004d0534a7cfc25c8da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/faf3c20501720b83627e66dc04b8d3ab0a734f2c6481305cd721c41fe4c25e00e6d3b70df9aba247c8a44173e9ed6af07dc19bbb71054c75f8af195cd707fbc5"} 15:34:13 INFO - Running post-run listener: copy_logs_to_upload_dir 15:34:13 INFO - Copying logs to upload dir... 15:34:13 INFO - mkdir: /builds/slave/test/build/upload/logs 15:34:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.361299 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-11 15:34:12.324765) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 15:34:12.328685) ========= 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=0e2a256762fed810e2f0f810000001b3-1468272487.516176-340079855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54c1b5fb3aef027e89e39bb76dbdfb60dd5fd3b606c1e337e74d2e9874dee477f36562d7873ee5dfada2b7969ea01814a6168e3a3f65f2bfb5c9b3f77e2da111", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f00cd8d7d831c3b91a36845b23cd96165594329766c32e5d901ab417cfa077842dae1810a464305ef8fd92715cdea15cc4b858239589c004d0534a7cfc25c8da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/faf3c20501720b83627e66dc04b8d3ab0a734f2c6481305cd721c41fe4c25e00e6d3b70df9aba247c8a44173e9ed6af07dc19bbb71054c75f8af195cd707fbc5"} build_url:https://queue.taskcluster.net/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011211 build_url: 'https://queue.taskcluster.net/v1/task/Y6KdBvKPSbiq4DEFmOlN1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54c1b5fb3aef027e89e39bb76dbdfb60dd5fd3b606c1e337e74d2e9874dee477f36562d7873ee5dfada2b7969ea01814a6168e3a3f65f2bfb5c9b3f77e2da111", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f00cd8d7d831c3b91a36845b23cd96165594329766c32e5d901ab417cfa077842dae1810a464305ef8fd92715cdea15cc4b858239589c004d0534a7cfc25c8da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/faf3c20501720b83627e66dc04b8d3ab0a734f2c6481305cd721c41fe4c25e00e6d3b70df9aba247c8a44173e9ed6af07dc19bbb71054c75f8af195cd707fbc5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 15:34:12.355394) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 15:34:12.355785) ========= 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=0e2a256762fed810e2f0f810000001b3-1468272487.516176-340079855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 15:34:12.439966) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 15:34:12.440299) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 15:34:12.440626) ========= ========= Total master_lag: 0.17 =========