builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-027 starttime: 1467855422.32 results: success (0) buildid: 20160706181823 builduid: 3193f8b721d9424aa4d34289ce8f58da revision: f89429b567cc881c5de58042c465fcd830415a04 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 18:37:02.317042) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 18:37:02.317495) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 18:37:02.317796) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 18:37:02.365641) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 18:37:02.366124) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1467846842.734340-921813110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 18:37:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-07-06 18:37:02 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081427 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 18:37:02.464380) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 18:37:02.464704) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1467846842.734340-921813110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015886 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 18:37:02.527109) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 18:37:02.527488) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev f89429b567cc881c5de58042c465fcd830415a04 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev f89429b567cc881c5de58042c465fcd830415a04 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1467846842.734340-921813110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 18:37:02,954 truncating revision to first 12 chars 2016-07-06 18:37:02,954 Setting DEBUG logging. 2016-07-06 18:37:02,954 attempt 1/10 2016-07-06 18:37:02,954 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/f89429b567cc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 18:37:03,269 unpacking tar archive at: autoland-f89429b567cc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.655223 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 18:37:03.197185) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 18:37:03.197502) ========= script_repo_revision: f89429b567cc881c5de58042c465fcd830415a04 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 18:37:03.197918) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 18:37:03.198215) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 18:37:03.209394) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-06 18:37:03.209803) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-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=1f5564757af27664ca02d71f000001b0-1467846842.734340-921813110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:37:03 INFO - MultiFileLogger online at 20160706 18:37:03 in /builds/slave/test 18:37:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 18:37:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:37:03 INFO - {'append_to_log': False, 18:37:03 INFO - 'base_work_dir': '/builds/slave/test', 18:37:03 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 18:37:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:37:03 INFO - 'branch': 'Autoland-Non-PGO', 18:37:03 INFO - 'buildbot_json_path': 'buildprops.json', 18:37:03 INFO - 'config_files': ('talos/linux_config.py',), 18:37:03 INFO - 'default_actions': ('clobber', 18:37:03 INFO - 'read-buildbot-config', 18:37:03 INFO - 'download-and-extract', 18:37:03 INFO - 'populate-webroot', 18:37:03 INFO - 'create-virtualenv', 18:37:03 INFO - 'install', 18:37:03 INFO - 'run-tests'), 18:37:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:37:03 INFO - 'download_minidump_stackwalk': True, 18:37:03 INFO - 'download_symbols': 'ondemand', 18:37:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:37:03 INFO - 'tooltool.py': '/tools/tooltool.py', 18:37:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:37:03 INFO - '/tools/misc-python/virtualenv.py')}, 18:37:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:37:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:37:03 INFO - 'installer_path': 'installer.exe', 18:37:03 INFO - 'log_level': 'info', 18:37:03 INFO - 'log_name': 'talos', 18:37:03 INFO - 'log_to_console': True, 18:37:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:37:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:37:03 INFO - 'opt_config_files': (), 18:37:03 INFO - 'pip_index': False, 18:37:03 INFO - 'sps_profile': False, 18:37:03 INFO - 'sps_profile_interval': 0, 18:37:03 INFO - 'suite': 'dromaeojs-e10s', 18:37:03 INFO - 'system_bits': '32', 18:37:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:37:03 INFO - 'title': 'talos-linux64-ix-027', 18:37:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:37:03 INFO - 'use_talos_json': True, 18:37:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:37:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:37:03 INFO - 'work_dir': 'build'} 18:37:03 INFO - ##### 18:37:03 INFO - ##### Running clobber step. 18:37:03 INFO - ##### 18:37:03 INFO - Running pre-action listener: _resource_record_pre_action 18:37:03 INFO - Running main action method: clobber 18:37:03 INFO - rmtree: /builds/slave/test/build 18:37:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:37:04 INFO - Running post-action listener: _resource_record_post_action 18:37:04 INFO - ##### 18:37:04 INFO - ##### Finished clobber step (success) 18:37:04 INFO - ##### 18:37:04 INFO - ##### 18:37:04 INFO - ##### Running read-buildbot-config step. 18:37:04 INFO - ##### 18:37:04 INFO - Running pre-action listener: _resource_record_pre_action 18:37:04 INFO - Running main action method: read_buildbot_config 18:37:04 INFO - Using buildbot properties: 18:37:04 INFO - { 18:37:04 INFO - "project": "", 18:37:04 INFO - "product": "firefox", 18:37:04 INFO - "script_repo_revision": "production", 18:37:04 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 18:37:04 INFO - "repository": "", 18:37:04 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 18:37:04 INFO - "buildid": "20160706181823", 18:37:04 INFO - "pgo_build": "False", 18:37:04 INFO - "basedir": "/builds/slave/test", 18:37:04 INFO - "buildnumber": 63, 18:37:04 INFO - "slavename": "talos-linux64-ix-027", 18:37:04 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:37:04 INFO - "platform": "ubuntu64_hw", 18:37:04 INFO - "scheduler": "tests-autoland-linux64-talos", 18:37:04 INFO - "branch": "autoland", 18:37:04 INFO - "repo_path": "integration/autoland", 18:37:04 INFO - "revision": "f89429b567cc881c5de58042c465fcd830415a04", 18:37:04 INFO - "stage_platform": "linux64", 18:37:04 INFO - "builduid": "3193f8b721d9424aa4d34289ce8f58da", 18:37:04 INFO - "slavebuilddir": "test" 18:37:04 INFO - } 18:37:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/LZarEKfASaacdzZCeKmsLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 18:37:04 INFO - Running post-action listener: _resource_record_post_action 18:37:04 INFO - ##### 18:37:04 INFO - ##### Finished read-buildbot-config step (success) 18:37:04 INFO - ##### 18:37:04 INFO - ##### 18:37:04 INFO - ##### Running download-and-extract step. 18:37:04 INFO - ##### 18:37:04 INFO - Running pre-action listener: _resource_record_pre_action 18:37:04 INFO - Running main action method: download_and_extract 18:37:04 INFO - mkdir: /builds/slave/test/build/tests 18:37:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:37:04 INFO - https://queue.taskcluster.net/v1/task/LZarEKfASaacdzZCeKmsLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:37:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZarEKfASaacdzZCeKmsLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:37:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZarEKfASaacdzZCeKmsLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:37:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZarEKfASaacdzZCeKmsLg/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 18:37:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZarEKfASaacdzZCeKmsLg/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 18:37:05 INFO - Downloaded 1361 bytes. 18:37:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:37:05 INFO - Using the following test package requirements: 18:37:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:37:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:37:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:37:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:05 INFO - u'jsshell-linux-x86_64.zip'], 18:37:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:37:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:37:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:37:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:37:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:37:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:37:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:37:05 INFO - https://queue.taskcluster.net/v1/task/LZarEKfASaacdzZCeKmsLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:37:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZarEKfASaacdzZCeKmsLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:37:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZarEKfASaacdzZCeKmsLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:37:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZarEKfASaacdzZCeKmsLg/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 18:37:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZarEKfASaacdzZCeKmsLg/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 18:37:06 INFO - Downloaded 22733579 bytes. 18:37:06 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'] 18:37:06 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 18:37:08 INFO - Return code: 0 18:37:08 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 18:37: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')]} 18:37:08 INFO - https://queue.taskcluster.net/v1/task/LZarEKfASaacdzZCeKmsLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:37:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZarEKfASaacdzZCeKmsLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:37:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZarEKfASaacdzZCeKmsLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:37:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZarEKfASaacdzZCeKmsLg/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 18:37:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZarEKfASaacdzZCeKmsLg/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 18:37:10 INFO - Downloaded 22733579 bytes. 18:37:10 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'] 18:37:10 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 18:37:11 INFO - Return code: 0 18:37:11 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')]} 18:37:11 INFO - https://queue.taskcluster.net/v1/task/LZarEKfASaacdzZCeKmsLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:37:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZarEKfASaacdzZCeKmsLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:37:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZarEKfASaacdzZCeKmsLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:37:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZarEKfASaacdzZCeKmsLg/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 18:37:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZarEKfASaacdzZCeKmsLg/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 18:37:15 INFO - Downloaded 14403333 bytes. 18:37:15 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'] 18:37:15 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 18:37:15 INFO - Return code: 0 18:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:37:15 INFO - https://queue.taskcluster.net/v1/task/LZarEKfASaacdzZCeKmsLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:37:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZarEKfASaacdzZCeKmsLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:37:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZarEKfASaacdzZCeKmsLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:37:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZarEKfASaacdzZCeKmsLg/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 18:37:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZarEKfASaacdzZCeKmsLg/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 18:37:18 INFO - Downloaded 56583211 bytes. 18:37:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LZarEKfASaacdzZCeKmsLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:37:18 INFO - mkdir: /builds/slave/test/properties 18:37:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:37:18 INFO - Writing to file /builds/slave/test/properties/build_url 18:37:18 INFO - Contents: 18:37:18 INFO - build_url:https://queue.taskcluster.net/v1/task/LZarEKfASaacdzZCeKmsLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:37:19 INFO - Running post-action listener: _resource_record_post_action 18:37:19 INFO - Running post-action listener: set_extra_try_arguments 18:37:19 INFO - ##### 18:37:19 INFO - ##### Finished download-and-extract step (success) 18:37:19 INFO - ##### 18:37:19 INFO - ##### 18:37:19 INFO - ##### Running populate-webroot step. 18:37:19 INFO - ##### 18:37:19 INFO - Running pre-action listener: _resource_record_pre_action 18:37:19 INFO - Running main action method: populate_webroot 18:37:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:37:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:37:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:37:19 INFO - '--tppagecycles', 18:37:19 INFO - '7'], 18:37:19 INFO - 'tests': ['tsvgm']}}, 18:37:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:37:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:37:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:37:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:37:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:37:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:37:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:37:19 INFO - 'talos_options': ['--disable-e10s'], 18:37:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:37:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:37:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:37:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:37:19 INFO - 'talos_options': ['--disable-e10s'], 18:37:19 INFO - 'tests': ['damp', 'tps']}, 18:37:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:37:19 INFO - 'tests': ['damp', 'tps']}, 18:37:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:37:19 INFO - 'tests': ['dromaeo_dom']}, 18:37:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:37:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:37:19 INFO - 'tests': ['basic_compositor_video']}, 18:37:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:37:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:37:19 INFO - 'tests': ['a11yr', 18:37:19 INFO - 'ts_paint', 18:37:19 INFO - 'tpaint', 18:37:19 INFO - 'sessionrestore', 18:37:19 INFO - 'sessionrestore_no_auto_restore', 18:37:19 INFO - 'tabpaint']}, 18:37:19 INFO - 'other-e10s': {'tests': ['a11yr', 18:37:19 INFO - 'ts_paint', 18:37:19 INFO - 'tpaint', 18:37:19 INFO - 'sessionrestore', 18:37:19 INFO - 'sessionrestore_no_auto_restore', 18:37:19 INFO - 'tabpaint']}, 18:37:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:37:19 INFO - 'ts_paint', 18:37:19 INFO - 'tpaint', 18:37:19 INFO - 'sessionrestore', 18:37:19 INFO - 'sessionrestore_no_auto_restore', 18:37:19 INFO - 'tabpaint']}, 18:37:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:37:19 INFO - 'ts_paint', 18:37:19 INFO - 'tpaint', 18:37:19 INFO - 'sessionrestore', 18:37:19 INFO - 'sessionrestore_no_auto_restore', 18:37:19 INFO - 'tabpaint']}, 18:37:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:37:19 INFO - 'tests': ['a11yr', 18:37:19 INFO - 'ts_paint', 18:37:19 INFO - 'tpaint', 18:37:19 INFO - 'sessionrestore', 18:37:19 INFO - 'sessionrestore_no_auto_restore', 18:37:19 INFO - 'tabpaint']}, 18:37:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:37:19 INFO - 'tests': ['a11yr', 18:37:19 INFO - 'ts_paint', 18:37:19 INFO - 'tpaint', 18:37:19 INFO - 'sessionrestore', 18:37:19 INFO - 'sessionrestore_no_auto_restore', 18:37:19 INFO - 'tabpaint']}, 18:37:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:37:19 INFO - 'tests': ['tsvgx', 18:37:19 INFO - 'tsvgr_opacity', 18:37:19 INFO - 'tart', 18:37:19 INFO - 'tscrollx', 18:37:19 INFO - 'cart']}, 18:37:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:37:19 INFO - 'tsvgr_opacity', 18:37:19 INFO - 'tart', 18:37:19 INFO - 'tscrollx', 18:37:19 INFO - 'cart']}, 18:37:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:37:19 INFO - 'talos_options': ['--disable-e10s'], 18:37:19 INFO - 'tests': ['tp5o']}, 18:37:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:37:19 INFO - 'tests': ['tp5o']}, 18:37:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:37:19 INFO - 'talos_options': ['--disable-e10s', 18:37:19 INFO - '--xperf_path', 18:37:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:37:19 INFO - 'tests': ['tp5n']}, 18:37:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:37:19 INFO - 'talos_options': ['--xperf_path', 18:37:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:37:19 INFO - 'tests': ['tp5n']}}, 18:37:19 INFO - 'talos.zip': {'path': '', 18:37:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:37:19 INFO - Running post-action listener: _resource_record_post_action 18:37:19 INFO - ##### 18:37:19 INFO - ##### Finished populate-webroot step (success) 18:37:19 INFO - ##### 18:37:19 INFO - ##### 18:37:19 INFO - ##### Running create-virtualenv step. 18:37:19 INFO - ##### 18:37:19 INFO - Running pre-action listener: _resource_record_pre_action 18:37:19 INFO - Running main action method: create_virtualenv 18:37:19 INFO - Creating virtualenv /builds/slave/test/build/venv 18:37:19 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 18:37:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:37:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:37:19 INFO - Using real prefix '/usr' 18:37:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:37:20 INFO - Installing distribute.............................................................................................................................................................................................done. 18:37:22 INFO - Installing pip.................done. 18:37:22 INFO - Return code: 0 18:37:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:37:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:37:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:37:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:37:22 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 0x1ddc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209a570>, '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 0x209b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209b900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467846842.734340-921813110', '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 18:37:22 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 18:37:22 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 18:37:22 INFO - Using env: {'DISPLAY': ':0', 18:37:22 INFO - 'HOME': '/home/cltbld', 18:37:22 INFO - 'LANG': 'en_US.UTF-8', 18:37:22 INFO - 'LANGUAGE': 'en_US:en', 18:37:22 INFO - 'LOGNAME': 'cltbld', 18:37:22 INFO - 'MAIL': '/var/mail/cltbld', 18:37:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:22 INFO - 'MOZ_NO_REMOTE': '1', 18:37:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:22 INFO - 'NO_EM_RESTART': '1', 18:37:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:22 INFO - 'PWD': '/builds/slave/test', 18:37:22 INFO - 'SHELL': '/bin/bash', 18:37:22 INFO - 'SHLVL': '1', 18:37:22 INFO - 'TERM': 'linux', 18:37:22 INFO - 'TMOUT': '86400', 18:37:22 INFO - 'USER': 'cltbld', 18:37:22 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467846842.734340-921813110', 18:37:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:22 INFO - '_': '/tools/buildbot/bin/python'} 18:37:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:22 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 18:37:22 INFO - Cleaning up... 18:37:22 INFO - Return code: 0 18:37:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:37:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:37:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:37:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:37:22 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 0x1ddc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209a570>, '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 0x209b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209b900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467846842.734340-921813110', '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 18:37:22 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 18:37:22 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 18:37:22 INFO - Using env: {'DISPLAY': ':0', 18:37:22 INFO - 'HOME': '/home/cltbld', 18:37:22 INFO - 'LANG': 'en_US.UTF-8', 18:37:22 INFO - 'LANGUAGE': 'en_US:en', 18:37:22 INFO - 'LOGNAME': 'cltbld', 18:37:22 INFO - 'MAIL': '/var/mail/cltbld', 18:37:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:22 INFO - 'MOZ_NO_REMOTE': '1', 18:37:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:22 INFO - 'NO_EM_RESTART': '1', 18:37:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:22 INFO - 'PWD': '/builds/slave/test', 18:37:22 INFO - 'SHELL': '/bin/bash', 18:37:22 INFO - 'SHLVL': '1', 18:37:22 INFO - 'TERM': 'linux', 18:37:22 INFO - 'TMOUT': '86400', 18:37:22 INFO - 'USER': 'cltbld', 18:37:22 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467846842.734340-921813110', 18:37:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:22 INFO - '_': '/tools/buildbot/bin/python'} 18:37:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:22 INFO - Downloading/unpacking psutil>=3.1.1 18:37:22 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 18:37:22 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 18:37:22 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 18:37:22 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 18:37:22 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 18:37:22 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 18:37:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:37:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:37:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:37:24 INFO - Installing collected packages: psutil 18:37:24 INFO - Running setup.py install for psutil 18:37:24 INFO - building 'psutil._psutil_linux' extension 18:37:24 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 18:37:24 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 18:37:24 INFO - building 'psutil._psutil_posix' extension 18:37:24 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 18:37:24 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 18:37:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:37:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:37:25 INFO - Successfully installed psutil 18:37:25 INFO - Cleaning up... 18:37:25 INFO - Return code: 0 18:37:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:37: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')]} 18:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:37: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')]} 18:37:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:37:25 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 0x1ddc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209a570>, '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 0x209b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209b900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467846842.734340-921813110', '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 18:37:25 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 18:37:25 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 18:37:25 INFO - Using env: {'DISPLAY': ':0', 18:37:25 INFO - 'HOME': '/home/cltbld', 18:37:25 INFO - 'LANG': 'en_US.UTF-8', 18:37:25 INFO - 'LANGUAGE': 'en_US:en', 18:37:25 INFO - 'LOGNAME': 'cltbld', 18:37:25 INFO - 'MAIL': '/var/mail/cltbld', 18:37:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:25 INFO - 'MOZ_NO_REMOTE': '1', 18:37:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:25 INFO - 'NO_EM_RESTART': '1', 18:37:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:25 INFO - 'PWD': '/builds/slave/test', 18:37:25 INFO - 'SHELL': '/bin/bash', 18:37:25 INFO - 'SHLVL': '1', 18:37:25 INFO - 'TERM': 'linux', 18:37:25 INFO - 'TMOUT': '86400', 18:37:25 INFO - 'USER': 'cltbld', 18:37:25 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467846842.734340-921813110', 18:37:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:25 INFO - '_': '/tools/buildbot/bin/python'} 18:37:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:37:25 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 18:37:25 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 18:37:25 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 18:37:25 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 18:37:25 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 18:37:25 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 18:37:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:37:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:37:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:37:27 INFO - Installing collected packages: mozsystemmonitor 18:37:27 INFO - Running setup.py install for mozsystemmonitor 18:37:27 INFO - Successfully installed mozsystemmonitor 18:37:27 INFO - Cleaning up... 18:37:27 INFO - Return code: 0 18:37:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:37:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:37:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:37:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:37:27 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 0x1ddc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209a570>, '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 0x209b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209b900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467846842.734340-921813110', '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 18:37:27 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 18:37:27 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 18:37:27 INFO - Using env: {'DISPLAY': ':0', 18:37:27 INFO - 'HOME': '/home/cltbld', 18:37:27 INFO - 'LANG': 'en_US.UTF-8', 18:37:27 INFO - 'LANGUAGE': 'en_US:en', 18:37:27 INFO - 'LOGNAME': 'cltbld', 18:37:27 INFO - 'MAIL': '/var/mail/cltbld', 18:37:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:27 INFO - 'MOZ_NO_REMOTE': '1', 18:37:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:27 INFO - 'NO_EM_RESTART': '1', 18:37:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:27 INFO - 'PWD': '/builds/slave/test', 18:37:27 INFO - 'SHELL': '/bin/bash', 18:37:27 INFO - 'SHLVL': '1', 18:37:27 INFO - 'TERM': 'linux', 18:37:27 INFO - 'TMOUT': '86400', 18:37:27 INFO - 'USER': 'cltbld', 18:37:27 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467846842.734340-921813110', 18:37:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:27 INFO - '_': '/tools/buildbot/bin/python'} 18:37:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:27 INFO - Downloading/unpacking jsonschema==2.5.1 18:37:27 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 18:37:27 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 18:37:27 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 18:37:27 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 18:37:27 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 18:37:27 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 18:37:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:37:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:37:29 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 18:37:29 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 18:37:29 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 18:37:29 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 18:37:29 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 18:37:29 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 18:37:29 INFO - Downloading functools32-3.2.3-2.tar.gz 18:37:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:37:29 INFO - warning: no files found matching '*.txt' 18:37:29 INFO - no previously-included directories found matching 'build' 18:37:29 INFO - no previously-included directories found matching 'dist' 18:37:29 INFO - no previously-included directories found matching '.git*' 18:37:29 INFO - Installing collected packages: jsonschema, functools32 18:37:29 INFO - Running setup.py install for functools32 18:37:29 INFO - warning: no files found matching '*.txt' 18:37:29 INFO - no previously-included directories found matching 'build' 18:37:29 INFO - no previously-included directories found matching 'dist' 18:37:29 INFO - no previously-included directories found matching '.git*' 18:37:29 INFO - Successfully installed jsonschema functools32 18:37:29 INFO - Cleaning up... 18:37:30 INFO - Return code: 0 18:37:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:37:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:37:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:37:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:37:30 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 0x1ddc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209a570>, '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 0x209b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209b900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467846842.734340-921813110', '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 18:37:30 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 18:37:30 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 18:37:30 INFO - Using env: {'DISPLAY': ':0', 18:37:30 INFO - 'HOME': '/home/cltbld', 18:37:30 INFO - 'LANG': 'en_US.UTF-8', 18:37:30 INFO - 'LANGUAGE': 'en_US:en', 18:37:30 INFO - 'LOGNAME': 'cltbld', 18:37:30 INFO - 'MAIL': '/var/mail/cltbld', 18:37:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:30 INFO - 'MOZ_NO_REMOTE': '1', 18:37:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:30 INFO - 'NO_EM_RESTART': '1', 18:37:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:30 INFO - 'PWD': '/builds/slave/test', 18:37:30 INFO - 'SHELL': '/bin/bash', 18:37:30 INFO - 'SHLVL': '1', 18:37:30 INFO - 'TERM': 'linux', 18:37:30 INFO - 'TMOUT': '86400', 18:37:30 INFO - 'USER': 'cltbld', 18:37:30 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467846842.734340-921813110', 18:37:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:30 INFO - '_': '/tools/buildbot/bin/python'} 18:37:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:30 INFO - Downloading/unpacking blobuploader==1.2.4 18:37:30 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 18:37:30 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 18:37:30 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 18:37:30 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 18:37:30 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 18:37:30 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 18:37:32 INFO - Downloading blobuploader-1.2.4.tar.gz 18:37:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:37:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:37:32 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 18:37:32 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 18:37:32 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 18:37:32 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 18:37:32 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 18:37:32 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 18:37:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:37:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:37:32 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 18:37:32 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 18:37:32 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 18:37:32 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 18:37:32 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 18:37:32 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 18:37:32 INFO - Downloading docopt-0.6.1.tar.gz 18:37:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:37:32 INFO - Installing collected packages: blobuploader, requests, docopt 18:37:32 INFO - Running setup.py install for blobuploader 18:37:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:37:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:37:32 INFO - Running setup.py install for requests 18:37:33 INFO - Running setup.py install for docopt 18:37:33 INFO - Successfully installed blobuploader requests docopt 18:37:33 INFO - Cleaning up... 18:37:33 INFO - Return code: 0 18:37:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:37:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:37:33 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 0x1ddc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209a570>, '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 0x209b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209b900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467846842.734340-921813110', '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 18:37:33 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 18:37:33 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 18:37:33 INFO - Using env: {'DISPLAY': ':0', 18:37:33 INFO - 'HOME': '/home/cltbld', 18:37:33 INFO - 'LANG': 'en_US.UTF-8', 18:37:33 INFO - 'LANGUAGE': 'en_US:en', 18:37:33 INFO - 'LOGNAME': 'cltbld', 18:37:33 INFO - 'MAIL': '/var/mail/cltbld', 18:37:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:33 INFO - 'MOZ_NO_REMOTE': '1', 18:37:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:33 INFO - 'NO_EM_RESTART': '1', 18:37:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:33 INFO - 'PWD': '/builds/slave/test', 18:37:33 INFO - 'SHELL': '/bin/bash', 18:37:33 INFO - 'SHLVL': '1', 18:37:33 INFO - 'TERM': 'linux', 18:37:33 INFO - 'TMOUT': '86400', 18:37:33 INFO - 'USER': 'cltbld', 18:37:33 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467846842.734340-921813110', 18:37:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:33 INFO - '_': '/tools/buildbot/bin/python'} 18:37:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:37:33 INFO - Running setup.py (path:/tmp/pip-Ys564l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:37:33 INFO - Running setup.py (path:/tmp/pip-889M6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:37:33 INFO - Running setup.py (path:/tmp/pip-aF23Sf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:37:33 INFO - Running setup.py (path:/tmp/pip-hEP3oG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:37:33 INFO - Running setup.py (path:/tmp/pip-SsDhsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:37:34 INFO - Running setup.py (path:/tmp/pip-KRVogM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:37:34 INFO - Running setup.py (path:/tmp/pip-eQCUeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:37:34 INFO - Running setup.py (path:/tmp/pip-ZofZy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:37:34 INFO - Running setup.py (path:/tmp/pip-kudnro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:37:34 INFO - Running setup.py (path:/tmp/pip-X5SQyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:37:34 INFO - Running setup.py (path:/tmp/pip-N6quRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:37:34 INFO - Running setup.py (path:/tmp/pip-_HCbdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:37:34 INFO - Running setup.py (path:/tmp/pip-2IbKNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:37:34 INFO - Running setup.py (path:/tmp/pip-qgMqY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:37:34 INFO - Running setup.py (path:/tmp/pip-gtCRVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:37:34 INFO - Running setup.py (path:/tmp/pip-xO9mcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:37:34 INFO - Running setup.py (path:/tmp/pip-tfWD_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:37:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:37:34 INFO - Running setup.py install for manifestparser 18:37:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:37:35 INFO - Running setup.py install for mozcrash 18:37:35 INFO - Running setup.py install for mozdebug 18:37:35 INFO - Running setup.py install for mozdevice 18:37:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:37:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:37:35 INFO - Running setup.py install for mozfile 18:37:35 INFO - Running setup.py install for mozhttpd 18:37:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:37:35 INFO - Running setup.py install for mozinfo 18:37:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:37:35 INFO - Running setup.py install for mozInstall 18:37:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:37:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:37:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:37:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:37:35 INFO - Running setup.py install for mozleak 18:37:35 INFO - Running setup.py install for mozlog 18:37:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:37:35 INFO - Running setup.py install for moznetwork 18:37:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:37:36 INFO - Running setup.py install for mozprocess 18:37:36 INFO - Running setup.py install for mozprofile 18:37:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:37:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:37:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:37:36 INFO - Running setup.py install for mozrunner 18:37:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:37:36 INFO - Running setup.py install for mozscreenshot 18:37:36 INFO - Running setup.py install for moztest 18:37:36 INFO - Running setup.py install for mozversion 18:37:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:37:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:37:36 INFO - Cleaning up... 18:37:36 INFO - Return code: 0 18:37:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:37: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')]} 18:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:37: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')]} 18:37:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:37:36 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 0x1ddc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209a570>, '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 0x209b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209b900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467846842.734340-921813110', '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 18:37:36 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 18:37:36 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 18:37:36 INFO - Using env: {'DISPLAY': ':0', 18:37:36 INFO - 'HOME': '/home/cltbld', 18:37:36 INFO - 'LANG': 'en_US.UTF-8', 18:37:36 INFO - 'LANGUAGE': 'en_US:en', 18:37:36 INFO - 'LOGNAME': 'cltbld', 18:37:36 INFO - 'MAIL': '/var/mail/cltbld', 18:37:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:36 INFO - 'MOZ_NO_REMOTE': '1', 18:37:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:36 INFO - 'NO_EM_RESTART': '1', 18:37:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:36 INFO - 'PWD': '/builds/slave/test', 18:37:36 INFO - 'SHELL': '/bin/bash', 18:37:36 INFO - 'SHLVL': '1', 18:37:36 INFO - 'TERM': 'linux', 18:37:36 INFO - 'TMOUT': '86400', 18:37:36 INFO - 'USER': 'cltbld', 18:37:36 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467846842.734340-921813110', 18:37:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:36 INFO - '_': '/tools/buildbot/bin/python'} 18:37:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:37:36 INFO - Running setup.py (path:/tmp/pip-ffEi3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:37:37 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)) 18:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:37:37 INFO - Running setup.py (path:/tmp/pip-fABvfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:37:37 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)) 18:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:37:37 INFO - Running setup.py (path:/tmp/pip-Z6wfI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:37:37 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)) 18:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:37:37 INFO - Running setup.py (path:/tmp/pip-n3tjHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:37:37 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)) 18:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:37:37 INFO - Running setup.py (path:/tmp/pip-A_br6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:37:37 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)) 18:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:37:37 INFO - Running setup.py (path:/tmp/pip-vFiVT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:37:37 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)) 18:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:37:37 INFO - Running setup.py (path:/tmp/pip-vsMEPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:37:37 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)) 18:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:37:37 INFO - Running setup.py (path:/tmp/pip-W5E2UV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:37:37 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)) 18:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:37:37 INFO - Running setup.py (path:/tmp/pip-IQnO9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:37:37 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)) 18:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:37:37 INFO - Running setup.py (path:/tmp/pip-MHd0B0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:37:37 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)) 18:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:37:37 INFO - Running setup.py (path:/tmp/pip-vGZ0ZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:37:37 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)) 18:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:37:37 INFO - Running setup.py (path:/tmp/pip-w0M3Kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:37:37 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)) 18:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:37:37 INFO - Running setup.py (path:/tmp/pip-jMI1Ny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:37:37 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)) 18:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:37:37 INFO - Running setup.py (path:/tmp/pip-_q1q0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:37:37 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)) 18:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:37:37 INFO - Running setup.py (path:/tmp/pip-ddAnut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:37:38 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)) 18:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:37:38 INFO - Running setup.py (path:/tmp/pip-ValvsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:37:38 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)) 18:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:37:38 INFO - Running setup.py (path:/tmp/pip-zmfHWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:37:38 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)) 18:37:38 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)) 18:37:38 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)) 18:37:38 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)) 18:37:38 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)) 18:37:38 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)) 18:37:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:37:38 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 18:37:38 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 18:37:38 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 18:37:38 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 18:37:38 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 18:37:38 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 18:37:40 INFO - Downloading blessings-1.6.tar.gz 18:37:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:37:40 INFO - Installing collected packages: blessings 18:37:40 INFO - Running setup.py install for blessings 18:37:40 INFO - Successfully installed blessings 18:37:40 INFO - Cleaning up... 18:37:40 INFO - Return code: 0 18:37:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:37:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:37:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:37:40 INFO - Reading from file tmpfile_stdout 18:37:40 INFO - Current package versions: 18:37:40 INFO - argparse == 1.2.1 18:37:40 INFO - blessings == 1.6 18:37:40 INFO - blobuploader == 1.2.4 18:37:40 INFO - docopt == 0.6.1 18:37:40 INFO - functools32 == 3.2.3-2 18:37:40 INFO - jsonschema == 2.5.1 18:37:40 INFO - manifestparser == 1.1 18:37:40 INFO - mozInstall == 1.12 18:37:40 INFO - mozcrash == 0.17 18:37:40 INFO - mozdebug == 0.1 18:37:40 INFO - mozdevice == 0.48 18:37:40 INFO - mozfile == 1.2 18:37:40 INFO - mozhttpd == 0.7 18:37:40 INFO - mozinfo == 0.9 18:37:40 INFO - mozleak == 0.1 18:37:40 INFO - mozlog == 3.2 18:37:40 INFO - moznetwork == 0.27 18:37:40 INFO - mozprocess == 0.23 18:37:40 INFO - mozprofile == 0.28 18:37:40 INFO - mozrunner == 6.12 18:37:40 INFO - mozscreenshot == 0.1 18:37:40 INFO - mozsystemmonitor == 0.3 18:37:40 INFO - moztest == 0.7 18:37:40 INFO - mozversion == 1.4 18:37:40 INFO - psutil == 3.1.1 18:37:40 INFO - requests == 1.2.3 18:37:40 INFO - wsgiref == 0.1.2 18:37:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:37:40 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 0x1ddc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209a570>, '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 0x209b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209b900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467846842.734340-921813110', '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 18:37:40 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 18:37:40 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 18:37:40 INFO - Using env: {'DISPLAY': ':0', 18:37:40 INFO - 'HOME': '/home/cltbld', 18:37:40 INFO - 'LANG': 'en_US.UTF-8', 18:37:40 INFO - 'LANGUAGE': 'en_US:en', 18:37:40 INFO - 'LOGNAME': 'cltbld', 18:37:40 INFO - 'MAIL': '/var/mail/cltbld', 18:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:40 INFO - 'MOZ_NO_REMOTE': '1', 18:37:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:40 INFO - 'NO_EM_RESTART': '1', 18:37:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:40 INFO - 'PWD': '/builds/slave/test', 18:37:40 INFO - 'SHELL': '/bin/bash', 18:37:40 INFO - 'SHLVL': '1', 18:37:40 INFO - 'TERM': 'linux', 18:37:40 INFO - 'TMOUT': '86400', 18:37:40 INFO - 'USER': 'cltbld', 18:37:40 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467846842.734340-921813110', 18:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:40 INFO - '_': '/tools/buildbot/bin/python'} 18:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:40 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)) 18:37:40 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)) 18:37:40 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)) 18:37:40 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)) 18:37:40 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)) 18:37:40 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)) 18:37:40 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)) 18:37:40 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)) 18:37:40 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)) 18:37:40 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)) 18:37:40 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)) 18:37:40 INFO - Cleaning up... 18:37:40 INFO - Return code: 0 18:37:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:37:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209a570>, '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 0x209b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209b900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467846842.734340-921813110', '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 18:37:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:37:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:37:40 INFO - Using env: {'DISPLAY': ':0', 18:37:40 INFO - 'HOME': '/home/cltbld', 18:37:40 INFO - 'LANG': 'en_US.UTF-8', 18:37:40 INFO - 'LANGUAGE': 'en_US:en', 18:37:40 INFO - 'LOGNAME': 'cltbld', 18:37:40 INFO - 'MAIL': '/var/mail/cltbld', 18:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:40 INFO - 'MOZ_NO_REMOTE': '1', 18:37:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:40 INFO - 'NO_EM_RESTART': '1', 18:37:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:40 INFO - 'PWD': '/builds/slave/test', 18:37:40 INFO - 'SHELL': '/bin/bash', 18:37:40 INFO - 'SHLVL': '1', 18:37:40 INFO - 'TERM': 'linux', 18:37:40 INFO - 'TMOUT': '86400', 18:37:40 INFO - 'USER': 'cltbld', 18:37:40 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467846842.734340-921813110', 18:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:40 INFO - '_': '/tools/buildbot/bin/python'} 18:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:37:40 INFO - Cleaning up... 18:37:40 INFO - Return code: 0 18:37:40 INFO - Running post-action listener: _resource_record_post_action 18:37:40 INFO - Running post-action listener: _start_resource_monitoring 18:37:41 INFO - Starting resource monitoring. 18:37:41 INFO - ##### 18:37:41 INFO - ##### Finished create-virtualenv step (success) 18:37:41 INFO - ##### 18:37:41 INFO - ##### 18:37:41 INFO - ##### Running install step. 18:37:41 INFO - ##### 18:37:41 INFO - Running pre-action listener: _resource_record_pre_action 18:37:41 INFO - Running main action method: install 18:37:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:37:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:37:41 INFO - Reading from file tmpfile_stdout 18:37:41 INFO - Detecting whether we're running mozinstall >=1.0... 18:37:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:37:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:37:41 INFO - Reading from file tmpfile_stdout 18:37:41 INFO - Output received: 18:37:41 INFO - Usage: mozinstall [options] installer 18:37:41 INFO - Options: 18:37:41 INFO - -h, --help show this help message and exit 18:37:41 INFO - -d DEST, --destination=DEST 18:37:41 INFO - Directory to install application into. [default: 18:37:41 INFO - "/builds/slave/test"] 18:37:41 INFO - --app=APP Application being installed. [default: firefox] 18:37:41 INFO - mkdir: /builds/slave/test/build/application 18:37:41 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'] 18:37:41 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 18:37:57 INFO - Reading from file tmpfile_stdout 18:37:57 INFO - Output received: 18:37:57 INFO - /builds/slave/test/build/application/firefox/firefox 18:37:57 INFO - Running post-action listener: _resource_record_post_action 18:37:57 INFO - ##### 18:37:57 INFO - ##### Finished install step (success) 18:37:57 INFO - ##### 18:37:57 INFO - ##### 18:37:57 INFO - ##### Running run-tests step. 18:37:57 INFO - ##### 18:37:57 INFO - Running pre-action listener: _resource_record_pre_action 18:37:57 INFO - Running main action method: run_tests 18:37:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:37:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:37:57 INFO - Python 2.7.3 18:37:57 INFO - Return code: 0 18:37:57 INFO - grabbing minidump binary from tooltool 18:37:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:37:57 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 0x209a570>, '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 0x209b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209b900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:37:57 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 18:37:57 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 18:37:57 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 18:37:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:37:57 INFO - Return code: 0 18:37:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:37:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:37:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:37:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:37:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:37:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LZarEKfASaacdzZCeKmsLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:37:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LZarEKfASaacdzZCeKmsLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:37:57 INFO - Using env: {'DISPLAY': ':0', 18:37:57 INFO - 'HOME': '/home/cltbld', 18:37:57 INFO - 'LANG': 'en_US.UTF-8', 18:37:57 INFO - 'LANGUAGE': 'en_US:en', 18:37:57 INFO - 'LOGNAME': 'cltbld', 18:37:57 INFO - 'MAIL': '/var/mail/cltbld', 18:37:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:37:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:57 INFO - 'MOZ_NO_REMOTE': '1', 18:37:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:37:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:57 INFO - 'NO_EM_RESTART': '1', 18:37:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:57 INFO - 'PWD': '/builds/slave/test', 18:37:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:37:57 INFO - 'SHELL': '/bin/bash', 18:37:57 INFO - 'SHLVL': '1', 18:37:57 INFO - 'TERM': 'linux', 18:37:57 INFO - 'TMOUT': '86400', 18:37:57 INFO - 'USER': 'cltbld', 18:37:57 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467846842.734340-921813110', 18:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:57 INFO - '_': '/tools/buildbot/bin/python'} 18:37:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LZarEKfASaacdzZCeKmsLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:37:57 INFO - mozversion application_buildid: 20160706181823 18:37:57 INFO - mozversion application_changeset: f89429b567cc881c5de58042c465fcd830415a04 18:37:57 INFO - mozversion application_display_name: Nightly 18:37:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:37:57 INFO - mozversion application_name: Firefox 18:37:57 INFO - mozversion application_remotingname: firefox 18:37:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 18:37:57 INFO - mozversion application_vendor: Mozilla 18:37:57 INFO - mozversion application_version: 50.0a1 18:37:57 INFO - mozversion platform_buildid: 20160706181823 18:37:57 INFO - mozversion platform_changeset: f89429b567cc881c5de58042c465fcd830415a04 18:37:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 18:37:57 INFO - mozversion platform_version: 50.0a1 18:37:57 INFO - using testdate: 1467855477 18:37:57 INFO - actual date: 1467855477 18:37:57 INFO - starting webserver on 'localhost:37496' 18:37:57 INFO - SUITE-START | Running 2 tests 18:37:57 INFO - TEST-START | dromaeo_css 18:37:57 INFO - operating with platform_type : linux_ 18:37:57 INFO - Initialising browser for dromaeo_css test... 18:37:57 INFO - TEST-INFO | started process 9271 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXhFT7h/profile http://localhost:37496/getInfo.html) 18:38:02 INFO - PROCESS | 9271 | __metrics Screen width/height:1600/1200 18:38:02 INFO - PROCESS | 9271 | colorDepth:24 18:38:02 INFO - PROCESS | 9271 | Browser inner width/height: 1024/697 18:38:02 INFO - PROCESS | 9271 | __metrics 18:38:03 ERROR - PROCESS | 9271 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 18:38:04 INFO - TEST-INFO | 9271: exit 0 18:38:04 INFO - Browser initialized. 18:38:04 INFO - Running cycle 1/1 for dromaeo_css test... 18:38:04 INFO - TEST-INFO | started process 9392 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXhFT7h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:38:16 INFO - PROCESS | 9392 | RSS: Main: 169127936 18:38:16 INFO - PROCESS | 9392 | 18:39:05 INFO - PROCESS | 9392 | 1467855545782 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] 18:41:18 INFO - PROCESS | 9392 | Cycle 1(1): loaded http://localhost:37496/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37496/tests/dromaeo/cssquery-ext.html) 18:41:19 INFO - PROCESS | 9392 | RSS: Main: 171712512 18:41:19 INFO - PROCESS | 9392 | 18:44:22 INFO - PROCESS | 9392 | Cycle 1(1): loaded http://localhost:37496/tests/dromaeo/cssquery-ext.html (next: http://localhost:37496/tests/dromaeo/cssquery-jquery.html) 18:44:22 INFO - PROCESS | 9392 | RSS: Main: 168505344 18:44:22 INFO - PROCESS | 9392 | 18:47:24 INFO - PROCESS | 9392 | Cycle 1(1): loaded http://localhost:37496/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37496/tests/dromaeo/cssquery-mootools.html) 18:47:25 INFO - PROCESS | 9392 | RSS: Main: 171835392 18:47:25 INFO - PROCESS | 9392 | 18:50:27 INFO - PROCESS | 9392 | Cycle 1(1): loaded http://localhost:37496/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37496/tests/dromaeo/cssquery-prototype.html) 18:50:27 INFO - PROCESS | 9392 | RSS: Main: 167206912 18:50:27 INFO - PROCESS | 9392 | 18:53:30 INFO - PROCESS | 9392 | Cycle 1(1): loaded http://localhost:37496/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37496/tests/dromaeo/cssquery-yui.html) 18:53:31 INFO - PROCESS | 9392 | RSS: Main: 169127936 18:53:31 INFO - PROCESS | 9392 | 18:56:33 INFO - PROCESS | 9392 | Cycle 1(1): loaded http://localhost:37496/tests/dromaeo/cssquery-yui.html (next: http://localhost:37496/tests/dromaeo/cssquery-dojo.html) 18:56:34 INFO - PROCESS | 9392 | RSS: Main: 170172416 18:56:34 INFO - PROCESS | 9392 | 18:56:34 INFO - PROCESS | 9392 | __start_tp_report 18:56:34 INFO - PROCESS | 9392 | _x_x_mozilla_page_load 18:56:34 INFO - PROCESS | 9392 | _x_x_mozilla_page_load_details 18:56:34 INFO - PROCESS | 9392 | |i|pagename|runs| 18:56:34 INFO - PROCESS | 9392 | |0;dojo.html;2698.2714667039904;2700.8379497230167;2728.208819442362;2735.0700761741004;2737.4525094981004;4892;4940.555350018498;4952.257161425783;4972.279019542164;4980.203167493201;4809.4469136049365;4910.386201724785;4946.530079642428;4958.15711329074;4973.950260497394;4494.033782736711;4525.162844873693;4648.442186937556;4653.790579423917;4656.557627025427;204.54129616860587;4438.356438316442;4505.234110201257;4505.414296141497;4534.9773251133865;4529.048899731044;4538.568835960578;4565.360849481075;4567.680262381635;4608;4565.08698260346;4580.9541904580865;4582.587567118942;4592.402987611623;4617.8383756568355;4439.289713645801;4491.056878055612;4529.773511324421;4534.13851368239;4557.407537020199;4902.338184345103;4937;4945.381827271591;4959;5026.723530205837;5111.539961403454;5289.523942845124;5332.306800115999;5334.626576139672;5368.516833485005;5273.288106105703;5317.973410132963;5332.706701131437;5348.491893270133;5368.516833484966;4969.875753106165;4970.304157417964;4980.601551875841;4983.177775667011;5036.345275114285;5267.762950667229;5320.334958130234;5430.42980487051;5473.972630136824;5475.233467314579;5159.432462429129;5189.481051894781;5191.32512773337;5227.059129356676;5246.947530524646;5278.630495865253;5280.683159010472;5292.100342941632;5296.3379577552805;5334.119870221448;5121.257417674491;5239.794847185092;5261.657992230493;5292.994331077083;5337.466253374631;5139.563137133311;5190.792368305301;5204.609654275944;5263.6578622389425;5279.498447647467;4532.9546704533195;4547.681662283609;4554;4587.518310577341;4599.471060827981;3815.122521819997;3891.5135608048995;3923.6861051115843;3927.9803600981813;3959.7822119783687;4409.581089796464;4484.932726009112;4512.849223448;4557.475890272594;4598.850287428143;5309.734513274321;5330.280412144389;5358.46415358461;5359.196120581866;5363.946360536423;4451.354553589711;4454.242778727624;4482.417285752831;4526.343680166423;4574.4739354973935;4784.186688263004;4818.590419814355;4828.7102773833685;4857.635677324215;4871.464138944713;4993.650444468853;4993.950060499348;5002.724850133278;5006.924896126561;5012;5133.537981581676;5203.959208158459;5215.869603259949;5256.290400795843;5410.945890541044;4900.068986892479;4900.607951363811;4909.877253068559;4911.50884911506;4914.041761856547;5191.558717509054;5232.686038837682;5247.475252474722;5295.814646487354;5358.437364076716;5328.147496400557;5332.866678333073;5368.758405871667;5385.757640906247;5419.512243898068;5203.401608815035;5207.81772637971;5208.296879921314;5220.1647736362;5226.764795584132;5067.847964561069;5071.644984851173;5104.2088476286235;5135;5202.24567437727;4969.875753106201;5006.524380183877;5017.949820501748;5025.547700706954;5048.192289233705;5131.8196814733565;5140.203268493389;5158.793648254028;5165.870853228699;5183.688978661142;4920.065187614342;5024.120778863758;5087.440381557952;5115.9232611510115;5121.718305493234 18:56:34 INFO - PROCESS | 9392 | |1;ext.html;567.8012695556553;579.3106203617695;589.7935722497126;594.6224147666234;613.1140501974648;36369.09077273066;41023.38464923021;41076.79461602691;41242.58757412425;41345.37981930273;39655.60344396562;40366.59633403665;40471.59528404715;40503.189936201255;40570.97145142746;7671.117821450535;7829.334506566948;7843.607819608997;7858.607069646523;7880.881786773174;7783.883241751379;7812.453128281023;7842;7853.607319634024;7878.921210787905;7752.186020467854;7823.726169584065;7833.334166595846;7835.294823465887;7859.056913170428;7849.5682737449415;7861;7866.292033716935;7909.683612655487;7921.762347129596;7812.648430820626;7866.72466463671;7884.684612615489;7886.408519361071;7896.644650990719;37828.43257351142;37962.430563541566;38183;38303.616963830566;38471.61528384708;2869.253993961564;3034.3779525197283;3075.2773098321877;3120.0327898351356;3428.7599868009247;29561.852190738908;29959.850200748857;30050.699493005228;30221.848890755624;30492.695073049206;3502.6322236165347;3567.1438854674693;3592.191756854713;3602;3639.253952939641;251815;254161;255965;256069;257797;52955.735221323645;53893;54150;54189.45810541923;54241;33228.83385583105;34330.05204401476;34421.139471513416;36140;36150.096247593494;14435.783463248059;14468.421263149356;14541.927290363481;14546.4908728194;14656.974011819284;10941.726456838484;11032.944835275934;11034.613788517523;11118.666440006813;11152.386618735885;18763.437096887115;18807.717884231748;18830.90584547096;18941.81058189428;18965.810341896682;7084.645767711594;7088.893666595005;7125.928740712527;7163;7219.711211551479;816.8897198878076;873.733511279066;924.4684306523776;932.9253659707207;938.6490229879265;28785.28036799055;29046;29098.563521547192;29403.411931761246;29459.85270073679;935.4808081514825;950.1733491862125;981.5190556627201;983.0906411569413;1068.6954218047974;14899;14948.40206391754;15142.318595663222;15205.847941520664;15362.539123826304;399840;401216;403524;405089;405500;50565.94340565914;50572;50780.23829642558;50893.74553127285;51027.74486127545;1138.6299452677913;1153.7519433321877;1203.560700344368;1211.3156066822041;1219.914605977573;26732.599011015238;28451.573226401208;28700.13899583016;29007.709922901344;30335.544966825073;47666;47698.28452573145;49251.26123108085;49351.50648493613;53864.730676346364;383078;383473;384029;386537;387054;39210.411843822934;39424.605753942094;39510;39624;39749.602503975744;43611.56388436075;43688.56311436845;43703.78148109239;44091;44517;37505.2498950025;37556.2488750218;38670.2265954685;38859;39032.41451378288;37605.623943761304;38100.237995240495;38258;38378.61621383751;39033.41449878311;36843.447348290334;37204;37403.43894841525;37751.2449750998;38095.619043810315;32302;34366;34385.14037149091;34701.47947780836;34713.30573388468;26011.349716257246;26100.8694956524;26167.214983550522;26555.468890622466;26698.332541686614 18:56:34 INFO - PROCESS | 9392 | |2;jquery.html;355.9911002224944;359.4123607901081;362.8893187577789;364.70823341326934;385.5027015150456;16041.759373609391;16540.503784886456;17790.288388464447;17801.7329740054;17806.287748490045;16844.157792110374;17303;18007.63984720308;18023.36918207863;18045.187966541504;5168.560672342846;5303.628745987782;5315.840524784263;5341.893162136755;5348;5193.922091168635;5237.3715154181555;5251.816186433475;5266.183741520071;5288.92066619001;4945.134601444751;5055.191169412895;5082.771275292602;5165.8450246492475;5201.803585175412;5125.615578831584;5135.4094279158;5145.0481660892665;5174.223866420049;5193.63644544882;4572;4589.35748995141;4609.861704148881;4616.5152658970665;4637.420322459692;20582.691259631116;20648.58702825935;21119.260825871173;21463.570728585342;21647.134114635395;1909.9236030558761;1914.626647803679;1930.671785796418;1966.7246585478044;2004.4187185716125;13659.590212293648;13783.931080344635;13904.791428128587;13942.23317717525;14182.645433864132;1800.3968670495399;1802.8828126171888;1802.9723057857027;1865.8787178833331;1874.4095609882843;50364;70697.64651176763;72513.63743181303;72789.27210727878;73251.63374183148;9072.501012444247;9196.172344489029;9431.952840235892;9533.52332383378;9580.425174489554;12451.25292482454;12488.500459981498;12501.624951251477;12580.748385032248;12601.369931503388;7314.122305323395;7330.633468326562;7457.664405101675;7533.962330188424;7593.6582853771715;7517.436192285601;7535.208803075708;7589.962050189713;7646.464747467624;7686.269804368576;6026.126211699367;6074.453299203093;6142.447179753844;6164.3835616438;6194.34959329273;1774.946751597454;1783.1440908363797;1815.192239453457;1816.7093265077524;1823.972640410395;847.5211505499373;897;914.8444764390069;916.1983264643437;948.0661548374983;16973.745393819103;18064.81935180658;18410.35563755289;18454.81545184531;18674.626507469773;859.3297228162044;911.9361644684941;922.6770630279483;929.3540989012706;956.933014688965;10116.241281903887;10303.845442318372;10331.690049298533;10338.224633152544;10599.311044782064;365758;366149;383246;400515;401414;50826.49173508218;64688.67655661691;65323;71534.64232678803;74382;929.8977112517617;943.2783920300839;957.9377340472847;960.1502670136839;971.6890595009529;13395.598132056053;15550;16434.01395916249;16515.83484165191;16663.166841658112;24847.875760621082;32739.836300818344;34644.13389665178;37144.6285537152;37188.81405592955;49250;49445.752771235915;49732;49999.50000500094;52301.7384913073;4536.6143877770755;4725.078609671081;6729.5625784323865;7580.582755439141;7624.237576242332;11647.88352116468;12078.03375729957;12218.20581662189;12612.810807838074;12760.617181484571;10655;10742.73143171427;10899.400532970763;11094.5562177512;11191.44042797873;10542.683719488428;10771.19216058783;11058.502367393326;11078.944605276922;11079.5568177272;11108.777824443305;11121.777564448505;11218.2147249695;11220.66338009861;11364.374959377314;7737.690492380467;7867.7639670807675;7972.123066462568;8020.117787043304;8106.108328083788;7853.293203611703;9846.704598862045;10176.18590512772;10368.948155259175;10800.621978230723 18:56:34 INFO - PROCESS | 9392 | |3;mootools.html;1433.3836450326355;1435.5549779568332;1556.2063347692674;1736.3922627080515;1753.4388995521422;7084.716611335541;7723.189065148163;7786.260305270997;8353;8374.246317831394;7789.92210077899;7972.760817175494;8092.312153466948;8113.5131892086365;8126.309263712592;2242.910283588659;2279.5668822923676;2292.495650956787;2293.094227780026;2300.229423143249;2238.563480121377;2291.8395712300144;2292.793648571628;2301.5051763870765;2301.746807851135;2245.9438514037197;2259.243153543565;2261.8416710830247;2278.692376529164;2294.27730264966;2210.80102790748;2213.147938043857;2229.9665505017438;2231.0852550454238;2232.866028038323;2165.350394881529;2180;2192.78072192781;2193.802557769792;2203.9779602204094;8013.7195198168365;8119.75640730779;8163.387745919021;8174.26431621151;8179.79550511236;4718.8584342469785;4836.782344794493;4860.489648586883;4871.391076115486;4873.122837889178;2883.7548808351107;3005.6242969628797;3020.6828283030404;3025.7730670199603;3053.8931137410304;923.9769005774842;924.3437159616681;946.5598496699068;949.050949050949;961.1205746741723;11195.776084478264;11200.66398008053;11208.551657933673;11215;11246.044086252678;4135.234981528367;4209.6000879916355;4427.358033085249;4431.4903786065015;4433;9401.10689484498;9437.858432123523;9462.621495140118;9499.810003799885;9522.571484283224;4825.806967721252;4828.155072862235;4853.587445067138;4856.95143048565;4867.756612169377;3881.514810648669;4276.401303817468;4435.356873253425;4458.420405347284;4459.777011149429;3751.868684596026;3799.1072098056934;3814.9427758583643;3865.4781604483596;3879.1853710721066;1181.2203945395997;1208.353530860985;1217.3487184356504;1218.0499210615733;1218.1899037140379;734.6547122852251;809.3727361294925;843.8818565400849;848.1687945813014;853.5305581929914;5443.42844001382;5443.673379597237;5452.100403433468;5531.889362212733;5761.827145185651;843.6288033265344;851.7231899632644;895.1317222294364;909.0909090909091;909.777104609375;3696.4085746281003;3733.2747094621077;3893.240818040455;3947.980260098681;3950.7827069510877;9910.35582687123;10219.846702299472;10290.228232882564;10292.691219263434;10306.433146177033;9897.703068907944;10116.241281903887;10211.540480678388;10242.743931401774;10279.331843430302;7693.884591731128;7700.075990881242;7713.884291735629;7778.494397864234;7798.961005194938;5349.812756553502;5376.247325374529;5390.029794637003;5483.7258137092185;5484.588655850907;8906.86639700392;9268.119528644767;9282.535873206178;9526.714198574055;9540.284478663989;9306.767330816783;9599.376040557341;9676.9032309676;9712.271579631415;9790.118889299998;6771.93228067713;6982.860342793014;7031.296870312928;7043.542169758949;7079.221285658677;7919.643616037408;7949.8807517886125;7958.442908996315;8001.119876813662;8015.599220038858;7037.120359955005;7062.71749130029;7190.4607154464675;7213.242609526134;7408.222136675571;6784.76253331131;6834.248232694499;6898.793036208922;7039.929600704132;7125.786226413008;6405.807825765234;6602.1747281589805;6604.0754294399785;6634.4029037384935;6647.734090636321;4516.299973504112;4605.078984203105;4746.098241334135;4814.229723244264;4893.755312234445;4713.457952335525;4752.596029337545;4755.619550436026;4773.474917759113;4898.975505122452 18:56:34 INFO - PROCESS | 9392 | |4;prototype.html;293.79581191072185;301.58532018474597;307.19821266494455;307.87531049924786;309.6980444067036;5030.245463180525;5047.394312682474;5213.452587478317;5239.345081864767;5266.657667251636;5110.565601923841;5140.177571588547;5153.896922061556;5158.174692049273;5168.664036837603;4040.090979529597;4058.1883623275316;4058.8782336529875;4081.693872959525;4089.386592011207;3929.7031979446715;4034.6800589660916;4051.270771261172;4089.427480152781;4096.815643296059;3996.920061598766;4030.9596904031023;4031.4759081319535;4035.8183881725245;4042.939355909664;3965.147493288957;3999.8400063997406;4021.3163762160502;4032.1129351542613;4039.717219794601;3573.6605022522817;3582.301451217014;3590.5870824855215;3595.7662751921043;3602.2075143468396;4914.4839791821705;5067.619928505377;5071.695698258116;5080.720560369178;5155.432902380735;4623.398958135454;4631.675782695213;4642.814287428532;4659.114768194032;4661.300804879262;5371.785128594852;5378.892422151535;5386.165144402624;5387.78448862045;5402.37872644647;3719.330520506308;3830.3488406970882;3835.53973523179;3890.9221815563815;3902.609739026103;5597.648987425291;5649.774009039634;5658.886822263573;5682.971585142048;5700.5724570657785;3968.444417781513;3995.780232087263;4000.3199456092534;4007.2786898358577;4010.6189911958318;3968.6647687682516;4009.8195581198916;4028.254772867029;4065.0853557949818;4071.1654110907193;4516.932246016312;4529.297958816389;4542.500324964251;4545.204589196877;4610.654200934943;5407.864803379868;5450.700211488327;5458.918116228259;5459.781608735686;5459.918101228484;1322.907396482237;1348.2517202952456;1392.5752645443238;1393.9684633371232;1398.9160650361011;946.0492205333733;946.8011717539256;959.9856002159974;969.5007071358256;972.1105188752213;4634.930476042862;4652.395188625457;4655.697379670379;4657.5575320344515;4669.272369223409;5473.8357849264585;5502.477264659851;5525.309336332958;5528.226048353234;5545.77816887328;4485.484169320504;4662.7202367858035;4680.953190468052;4688;4690.273007683746;2933.574631678395;2965.8072225305286;2993.6407631083976;2999.2801727585224;3002.573777455691;5146.433892271847;5162.793488260428;5196.428392876781;5248.527632513092;5254.238135470336;5412.702301373462;5710.314762228559;5745;5769.451902069297;5779.739911703983;5209.609279304067;5246.737663116829;5267.473252674702;5274.709890955957;5275.340582427197;5557.694326812064;5563.276774019351;5571;5597.468240517144;5631.3242410909315;5247.4227834937365;5472.728817540835;5497.45025497447;5532.2254884315425;5536.501714845684;5205.219217117463;5238.873642166953;5251.816186433456;5257.5005374489365;5267.815626453055;3848.7113466489564;3856.652901238902;3874.302625527432;3916.9020774479727;3931.3906344516645;5295.9470405297;5578.497935185853;5602.719864006702;5618.971905140612;5624.247510853323;5222.451642577475;5367.677939323653;5388.141091323487;5390.029794637003;5399.325084364455;5369.865753356197;5379.838604841861;5385.653586603349;5410.594205434687;5419.972900135632;5234.842954711365;5298.258243845942;5334.279872217357;5341.78632854697;5366.745966694076;5418.458154184707;5429.972850135724;5440.300595595033;5449.754761035842;5464.890702186013;5266.526012658879;5305.787768489372;5330.747274390593;5333.813316534058;5374.4088150304215 18:56:34 INFO - PROCESS | 9392 | |5;yui.html;647.7765171016001;657.9965552532387;717.411722387642;723.5152447859937;785.3520845302627;13006.284654344006;14037.649058773535;14047.22740249286;14051.156930584171;14065.859341406596;13308.255337781671;13328.800067998964;13331.93334033331;13771.931140344284;13829.239391833446;616.910547970544;759.5860256160378;761.5887420792765;780.2002946979363;783.1854870934221;776.0377132355866;788.6766425765437;790.182161462886;790.7706765038132;791.9722809701661;839.1817977471977;839.6389552492426;841.3437518735396;841.3479553346175;842.6039761312204;831.8918540589746;833.2167762303445;833.4665813879092;834.4034015678819;836.5482639374791;611.9418655227746;612.3876123876124;613.0467123622765;613.7790395457631;614.7448808744366;14300.356483958143;14321.14073155614;14417.639559011004;14435.350409231505;14455.638609034753;13927.930360348235;14050.086744361686;14119.929400353036;14254;14309.427622895177;10876.09668308043;10968.890311096866;11068.612598559092;11095.945885140898;11118.666440006813;3305.5537502437105;3309.4373956427225;3382.2728113455723;3385.5260263563123;3454.6199918008997;68723.31276687219;69347.65326173387;69356.65321673409;69816.30183698148;70037;9733.56198971048;9760.072793084646;9796.363236389612;11461.656150315504;11469.713257168638;18909.621807563773;19176;19216.61566768657;19226.903865480584;19237.807621923883;6751.392374686302;6809.5233333666165;6876.587404755731;6909.136357955255;7029.26192749754;3747.6252374762853;3836.827342769582;3881.165549406891;3909.237698648793;3913.5499417566775;3433.210361616842;3655.8484077515495;3656.03115174479;3662.963370366262;3665.340238756996;587.1632923084672;590.0618017352344;592.7006861534898;594.4679511836882;602.5119653081018;524.9527542521115;556.3324011186593;575.9049756790166;584.9908907135158;616.5468380740152;8459.096703241721;8796.196779660155;8903.421277616933;8967.282617390592;8967.417117887317;571.4456976732563;595.2737660054727;602.5932495565476;602.7920367473215;616.7687117331001;4045.19096180765;4089.7955102245364;4109.938350924738;4118.402831589403;4219.092895027584;56953.145702814494;57236;80119.59940200378;97988;100136;83751.16248837434;84565;84873;85669.57165214134;86883.56558217168;74289.62855185689;77215.61392193002;78769.60615196887;78911.60544197242;79068.60465697749;8266.173382661686;8476.745697629081;8583.65665373378;8933.687320943996;9108.362414631178;43584.56415435805;44122.77938610286;45539.772301138284;45923.311150332105;47035.294470583656;57289.42710573008;66651.33348666452;67260.66369668121;67513.3248667507;69244;11551.075913926697;11652;11726.413679315829;11894.524219031488;12024;12465.266365891099;13093.73812523725;13179.736405272033;13450.46198152063;13486.527971520949;12289.508419663114;12376.566820161252;12622.179558328678;12878.742425151631;13317.334133293103;12750.936245318713;12814.487420503076;13157;13266.336683165997;13646;12204.572839950559;12332.136750427742;12409.689757756129;12412.069094817743;12472.501099956264;9684.95157524208;10196.72016643636;10200;10219.540120694437;10432.530536125741;9856.852147217654;9958.50207489637;9975.551100200364;10015.799684006133;10062.69811905644 18:56:34 INFO - PROCESS | 9392 | __end_tp_report 18:56:34 INFO - PROCESS | 9392 | __start_cc_report 18:56:34 INFO - PROCESS | 9392 | _x_x_mozilla_cycle_collect,386 18:56:34 INFO - PROCESS | 9392 | __end_cc_report 18:56:34 INFO - PROCESS | 9392 | __startTimestamp1467856594094__endTimestamp 18:56:34 INFO - PROCESS | 9392 | 18:56:34 INFO - PROCESS | 9392 | ------- Summary: start ------- 18:56:34 INFO - PROCESS | 9392 | Number of tests: 6 18:56:34 INFO - PROCESS | 9392 | 18:56:34 INFO - PROCESS | 9392 | [#0] dojo.html Cycles:165 Average:4860.31 Median:5002.72 stddev:633.90 (12.7%) stddev-sans-first:612.73 18:56:34 INFO - PROCESS | 9392 | Values: 2698.3 2700.8 2728.2 2735.1 2737.5 4892.0 4940.6 4952.3 4972.3 4980.2 4809.4 4910.4 4946.5 4958.2 4974.0 4494.0 4525.2 4648.4 4653.8 4656.6 204.5 4438.4 4505.2 4505.4 4535.0 4529.0 4538.6 4565.4 4567.7 4608.0 4565.1 4581.0 4582.6 4592.4 4617.8 4439.3 4491.1 4529.8 4534.1 4557.4 4902.3 4937.0 4945.4 4959.0 5026.7 5111.5 5289.5 5332.3 5334.6 5368.5 5273.3 5318.0 5332.7 5348.5 5368.5 4969.9 4970.3 4980.6 4983.2 5036.3 5267.8 5320.3 5430.4 5474.0 5475.2 5159.4 5189.5 5191.3 5227.1 5246.9 5278.6 5280.7 5292.1 5296.3 5334.1 5121.3 5239.8 5261.7 5293.0 5337.5 5139.6 5190.8 5204.6 5263.7 5279.5 4533.0 4547.7 4554.0 4587.5 4599.5 3815.1 3891.5 3923.7 3928.0 3959.8 4409.6 4484.9 4512.8 4557.5 4598.9 5309.7 5330.3 5358.5 5359.2 5363.9 4451.4 4454.2 4482.4 4526.3 4574.5 4784.2 4818.6 4828.7 4857.6 4871.5 4993.7 4994.0 5002.7 5006.9 5012.0 5133.5 5204.0 5215.9 5256.3 5410.9 4900.1 4900.6 4909.9 4911.5 4914.0 5191.6 5232.7 5247.5 5295.8 5358.4 5328.1 5332.9 5368.8 5385.8 5419.5 5203.4 5207.8 5208.3 5220.2 5226.8 5067.8 5071.6 5104.2 5135.0 5202.2 4969.9 5006.5 5017.9 5025.5 5048.2 5131.8 5140.2 5158.8 5165.9 5183.7 4920.1 5024.1 5087.4 5115.9 5121.7 18:56:34 INFO - PROCESS | 9392 | 18:56:34 INFO - PROCESS | 9392 | [#1] ext.html Cycles:180 Average:50355.17 Median:212504.31 stddev:93323.36 (43.9%) stddev-sans-first:93510.29 18:56:34 INFO - PROCESS | 9392 | Values: 567.8 579.3 589.8 594.6 613.1 36369.1 41023.4 41076.8 41242.6 41345.4 39655.6 40366.6 40471.6 40503.2 40571.0 7671.1 7829.3 7843.6 7858.6 7880.9 7783.9 7812.5 7842.0 7853.6 7878.9 7752.2 7823.7 7833.3 7835.3 7859.1 7849.6 7861.0 7866.3 7909.7 7921.8 7812.6 7866.7 7884.7 7886.4 7896.6 37828.4 37962.4 38183.0 38303.6 38471.6 2869.3 3034.4 3075.3 3120.0 3428.8 29561.9 29959.9 30050.7 30221.8 30492.7 3502.6 3567.1 3592.2 3602.0 3639.3 251815.0 254161.0 255965.0 256069.0 257797.0 52955.7 53893.0 54150.0 54189.5 54241.0 33228.8 34330.1 34421.1 36140.0 36150.1 14435.8 14468.4 14541.9 14546.5 14657.0 10941.7 11032.9 11034.6 11118.7 11152.4 18763.4 18807.7 18830.9 18941.8 18965.8 7084.6 7088.9 7125.9 7163.0 7219.7 816.9 873.7 924.5 932.9 938.6 28785.3 29046.0 29098.6 29403.4 29459.9 935.5 950.2 981.5 983.1 1068.7 14899.0 14948.4 15142.3 15205.8 15362.5 399840.0 401216.0 403524.0 405089.0 405500.0 50565.9 50572.0 50780.2 50893.7 51027.7 1138.6 1153.8 1203.6 1211.3 1219.9 26732.6 28451.6 28700.1 29007.7 30335.5 47666.0 47698.3 49251.3 49351.5 53864.7 383078.0 383473.0 384029.0 386537.0 387054.0 39210.4 39424.6 39510.0 39624.0 39749.6 43611.6 43688.6 43703.8 44091.0 44517.0 37505.2 37556.2 38670.2 38859.0 39032.4 37605.6 38100.2 38258.0 38378.6 39033.4 36843.4 37204.0 37403.4 37751.2 38095.6 32302.0 34366.0 34385.1 34701.5 34713.3 26011.3 26100.9 26167.2 26555.5 26698.3 18:56:34 INFO - PROCESS | 9392 | 18:56:34 INFO - PROCESS | 9392 | [#2] jquery.html Cycles:180 Average:23905.09 Median:200450.25 stddev:63099.31 (31.5%) stddev-sans-first:63251.55 18:56:34 INFO - PROCESS | 9392 | Values: 356.0 359.4 362.9 364.7 385.5 16041.8 16540.5 17790.3 17801.7 17806.3 16844.2 17303.0 18007.6 18023.4 18045.2 5168.6 5303.6 5315.8 5341.9 5348.0 5193.9 5237.4 5251.8 5266.2 5288.9 4945.1 5055.2 5082.8 5165.8 5201.8 5125.6 5135.4 5145.0 5174.2 5193.6 4572.0 4589.4 4609.9 4616.5 4637.4 20582.7 20648.6 21119.3 21463.6 21647.1 1909.9 1914.6 1930.7 1966.7 2004.4 13659.6 13783.9 13904.8 13942.2 14182.6 1800.4 1802.9 1803.0 1865.9 1874.4 50364.0 70697.6 72513.6 72789.3 73251.6 9072.5 9196.2 9432.0 9533.5 9580.4 12451.3 12488.5 12501.6 12580.7 12601.4 7314.1 7330.6 7457.7 7534.0 7593.7 7517.4 7535.2 7590.0 7646.5 7686.3 6026.1 6074.5 6142.4 6164.4 6194.3 1774.9 1783.1 1815.2 1816.7 1824.0 847.5 897.0 914.8 916.2 948.1 16973.7 18064.8 18410.4 18454.8 18674.6 859.3 911.9 922.7 929.4 956.9 10116.2 10303.8 10331.7 10338.2 10599.3 365758.0 366149.0 383246.0 400515.0 401414.0 50826.5 64688.7 65323.0 71534.6 74382.0 929.9 943.3 957.9 960.2 971.7 13395.6 15550.0 16434.0 16515.8 16663.2 24847.9 32739.8 34644.1 37144.6 37188.8 49250.0 49445.8 49732.0 49999.5 52301.7 4536.6 4725.1 6729.6 7580.6 7624.2 11647.9 12078.0 12218.2 12612.8 12760.6 10655.0 10742.7 10899.4 11094.6 11191.4 10542.7 10771.2 11058.5 11078.9 11079.6 11108.8 11121.8 11218.2 11220.7 11364.4 7737.7 7867.8 7972.1 8020.1 8106.1 7853.3 9846.7 10176.2 10368.9 10800.6 18:56:34 INFO - PROCESS | 9392 | 18:56:34 INFO - PROCESS | 9392 | [#3] mootools.html Cycles:180 Average:5373.35 Median:4883.44 stddev:3031.60 (62.1%) stddev-sans-first:3025.65 18:56:34 INFO - PROCESS | 9392 | Values: 1433.4 1435.6 1556.2 1736.4 1753.4 7084.7 7723.2 7786.3 8353.0 8374.2 7789.9 7972.8 8092.3 8113.5 8126.3 2242.9 2279.6 2292.5 2293.1 2300.2 2238.6 2291.8 2292.8 2301.5 2301.7 2245.9 2259.2 2261.8 2278.7 2294.3 2210.8 2213.1 2230.0 2231.1 2232.9 2165.4 2180.0 2192.8 2193.8 2204.0 8013.7 8119.8 8163.4 8174.3 8179.8 4718.9 4836.8 4860.5 4871.4 4873.1 2883.8 3005.6 3020.7 3025.8 3053.9 924.0 924.3 946.6 949.1 961.1 11195.8 11200.7 11208.6 11215.0 11246.0 4135.2 4209.6 4427.4 4431.5 4433.0 9401.1 9437.9 9462.6 9499.8 9522.6 4825.8 4828.2 4853.6 4857.0 4867.8 3881.5 4276.4 4435.4 4458.4 4459.8 3751.9 3799.1 3814.9 3865.5 3879.2 1181.2 1208.4 1217.3 1218.0 1218.2 734.7 809.4 843.9 848.2 853.5 5443.4 5443.7 5452.1 5531.9 5761.8 843.6 851.7 895.1 909.1 909.8 3696.4 3733.3 3893.2 3948.0 3950.8 9910.4 10219.8 10290.2 10292.7 10306.4 9897.7 10116.2 10211.5 10242.7 10279.3 7693.9 7700.1 7713.9 7778.5 7799.0 5349.8 5376.2 5390.0 5483.7 5484.6 8906.9 9268.1 9282.5 9526.7 9540.3 9306.8 9599.4 9676.9 9712.3 9790.1 6771.9 6982.9 7031.3 7043.5 7079.2 7919.6 7949.9 7958.4 8001.1 8015.6 7037.1 7062.7 7190.5 7213.2 7408.2 6784.8 6834.2 6898.8 7039.9 7125.8 6405.8 6602.2 6604.1 6634.4 6647.7 4516.3 4605.1 4746.1 4814.2 4893.8 4713.5 4752.6 4755.6 4773.5 4899.0 18:56:34 INFO - PROCESS | 9392 | 18:56:34 INFO - PROCESS | 9392 | [#4] prototype.html Cycles:180 Average:4492.94 Median:5156.80 stddev:1300.67 (25.2%) stddev-sans-first:1265.55 18:56:34 INFO - PROCESS | 9392 | Values: 293.8 301.6 307.2 307.9 309.7 5030.2 5047.4 5213.5 5239.3 5266.7 5110.6 5140.2 5153.9 5158.2 5168.7 4040.1 4058.2 4058.9 4081.7 4089.4 3929.7 4034.7 4051.3 4089.4 4096.8 3996.9 4031.0 4031.5 4035.8 4042.9 3965.1 3999.8 4021.3 4032.1 4039.7 3573.7 3582.3 3590.6 3595.8 3602.2 4914.5 5067.6 5071.7 5080.7 5155.4 4623.4 4631.7 4642.8 4659.1 4661.3 5371.8 5378.9 5386.2 5387.8 5402.4 3719.3 3830.3 3835.5 3890.9 3902.6 5597.6 5649.8 5658.9 5683.0 5700.6 3968.4 3995.8 4000.3 4007.3 4010.6 3968.7 4009.8 4028.3 4065.1 4071.2 4516.9 4529.3 4542.5 4545.2 4610.7 5407.9 5450.7 5458.9 5459.8 5459.9 1322.9 1348.3 1392.6 1394.0 1398.9 946.0 946.8 960.0 969.5 972.1 4634.9 4652.4 4655.7 4657.6 4669.3 5473.8 5502.5 5525.3 5528.2 5545.8 4485.5 4662.7 4681.0 4688.0 4690.3 2933.6 2965.8 2993.6 2999.3 3002.6 5146.4 5162.8 5196.4 5248.5 5254.2 5412.7 5710.3 5745.0 5769.5 5779.7 5209.6 5246.7 5267.5 5274.7 5275.3 5557.7 5563.3 5571.0 5597.5 5631.3 5247.4 5472.7 5497.5 5532.2 5536.5 5205.2 5238.9 5251.8 5257.5 5267.8 3848.7 3856.7 3874.3 3916.9 3931.4 5295.9 5578.5 5602.7 5619.0 5624.2 5222.5 5367.7 5388.1 5390.0 5399.3 5369.9 5379.8 5385.7 5410.6 5420.0 5234.8 5298.3 5334.3 5341.8 5366.7 5418.5 5430.0 5440.3 5449.8 5464.9 5266.5 5305.8 5330.7 5333.8 5374.4 18:56:34 INFO - PROCESS | 9392 | 18:56:34 INFO - PROCESS | 9392 | [#5] yui.html Cycles:180 Average:17969.35 Median:28754.74 stddev:24793.80 (86.2%) stddev-sans-first:24829.24 18:56:34 INFO - PROCESS | 9392 | Values: 647.8 658.0 717.4 723.5 785.4 13006.3 14037.6 14047.2 14051.2 14065.9 13308.3 13328.8 13331.9 13771.9 13829.2 616.9 759.6 761.6 780.2 783.2 776.0 788.7 790.2 790.8 792.0 839.2 839.6 841.3 841.3 842.6 831.9 833.2 833.5 834.4 836.5 611.9 612.4 613.0 613.8 614.7 14300.4 14321.1 14417.6 14435.4 14455.6 13927.9 14050.1 14119.9 14254.0 14309.4 10876.1 10968.9 11068.6 11095.9 11118.7 3305.6 3309.4 3382.3 3385.5 3454.6 68723.3 69347.7 69356.7 69816.3 70037.0 9733.6 9760.1 9796.4 11461.7 11469.7 18909.6 19176.0 19216.6 19226.9 19237.8 6751.4 6809.5 6876.6 6909.1 7029.3 3747.6 3836.8 3881.2 3909.2 3913.5 3433.2 3655.8 3656.0 3663.0 3665.3 587.2 590.1 592.7 594.5 602.5 525.0 556.3 575.9 585.0 616.5 8459.1 8796.2 8903.4 8967.3 8967.4 571.4 595.3 602.6 602.8 616.8 4045.2 4089.8 4109.9 4118.4 4219.1 56953.1 57236.0 80119.6 97988.0 100136.0 83751.2 84565.0 84873.0 85669.6 86883.6 74289.6 77215.6 78769.6 78911.6 79068.6 8266.2 8476.7 8583.7 8933.7 9108.4 43584.6 44122.8 45539.8 45923.3 47035.3 57289.4 66651.3 67260.7 67513.3 69244.0 11551.1 11652.0 11726.4 11894.5 12024.0 12465.3 13093.7 13179.7 13450.5 13486.5 12289.5 12376.6 12622.2 12878.7 13317.3 12750.9 12814.5 13157.0 13266.3 13646.0 12204.6 12332.1 12409.7 12412.1 12472.5 9685.0 10196.7 10200.0 10219.5 10432.5 9856.9 9958.5 9975.6 10015.8 10062.7 18:56:34 INFO - PROCESS | 9392 | -------- Summary: end -------- 18:56:34 INFO - PROCESS | 9392 | 18:56:34 INFO - TEST-INFO | 9392: exit 0 18:56:34 INFO - TEST-OK | dromaeo_css | took 1117004ms 18:56:34 INFO - TEST-START | kraken 18:56:34 INFO - operating with platform_type : linux_ 18:56:34 INFO - Initialising browser for kraken test... 18:56:34 INFO - TEST-INFO | started process 9637 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAcA1Bu/profile http://localhost:37496/getInfo.html) 18:56:39 INFO - PROCESS | 9637 | __metrics Screen width/height:1600/1200 18:56:39 INFO - PROCESS | 9637 | colorDepth:24 18:56:39 INFO - PROCESS | 9637 | Browser inner width/height: 1024/697 18:56:39 INFO - PROCESS | 9637 | __metrics 18:56:40 ERROR - PROCESS | 9637 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 18:56:40 INFO - TEST-INFO | 9637: exit 0 18:56:40 INFO - Browser initialized. 18:56:40 INFO - Running cycle 1/1 for kraken test... 18:56:40 INFO - TEST-INFO | started process 9756 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAcA1Bu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:56:52 INFO - PROCESS | 9756 | RSS: Main: 169177088 18:56:52 INFO - PROCESS | 9756 | 18:56:55 INFO - PROCESS | 9756 | Cycle 1(1): loaded http://localhost:37496/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37496/tests/kraken/driver.html?testName=audio-beat-detection) 18:56:56 INFO - PROCESS | 9756 | RSS: Main: 174055424 18:56:56 INFO - PROCESS | 9756 | 18:56:59 INFO - PROCESS | 9756 | Cycle 1(1): loaded http://localhost:37496/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37496/tests/kraken/driver.html?testName=audio-dft) 18:56:59 INFO - PROCESS | 9756 | RSS: Main: 174096384 18:56:59 INFO - PROCESS | 9756 | 18:57:02 INFO - PROCESS | 9756 | Cycle 1(1): loaded http://localhost:37496/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37496/tests/kraken/driver.html?testName=audio-fft) 18:57:03 INFO - PROCESS | 9756 | RSS: Main: 168792064 18:57:03 INFO - PROCESS | 9756 | 18:57:05 INFO - PROCESS | 9756 | Cycle 1(1): loaded http://localhost:37496/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37496/tests/kraken/driver.html?testName=audio-oscillator) 18:57:06 INFO - PROCESS | 9756 | RSS: Main: 168919040 18:57:06 INFO - PROCESS | 9756 | 18:57:08 INFO - PROCESS | 9756 | Cycle 1(1): loaded http://localhost:37496/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37496/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:57:09 INFO - PROCESS | 9756 | RSS: Main: 169873408 18:57:09 INFO - PROCESS | 9756 | 18:57:12 INFO - PROCESS | 9756 | Cycle 1(1): loaded http://localhost:37496/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37496/tests/kraken/driver.html?testName=imaging-darkroom) 18:57:13 INFO - PROCESS | 9756 | RSS: Main: 170479616 18:57:13 INFO - PROCESS | 9756 | 18:57:16 INFO - PROCESS | 9756 | Cycle 1(1): loaded http://localhost:37496/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37496/tests/kraken/driver.html?testName=imaging-desaturate) 18:57:17 INFO - PROCESS | 9756 | RSS: Main: 167763968 18:57:17 INFO - PROCESS | 9756 | 18:57:20 INFO - PROCESS | 9756 | Cycle 1(1): loaded http://localhost:37496/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37496/tests/kraken/driver.html?testName=json-parse-financial) 18:57:20 INFO - PROCESS | 9756 | RSS: Main: 169103360 18:57:20 INFO - PROCESS | 9756 | 18:57:22 INFO - PROCESS | 9756 | Cycle 1(1): loaded http://localhost:37496/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37496/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:57:23 INFO - PROCESS | 9756 | RSS: Main: 169287680 18:57:23 INFO - PROCESS | 9756 | 18:57:25 INFO - PROCESS | 9756 | Cycle 1(1): loaded http://localhost:37496/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37496/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:57:25 INFO - PROCESS | 9756 | RSS: Main: 169660416 18:57:25 INFO - PROCESS | 9756 | 18:57:27 INFO - PROCESS | 9756 | Cycle 1(1): loaded http://localhost:37496/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37496/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:57:28 INFO - PROCESS | 9756 | RSS: Main: 170078208 18:57:28 INFO - PROCESS | 9756 | 18:57:31 INFO - PROCESS | 9756 | Cycle 1(1): loaded http://localhost:37496/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37496/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:57:32 INFO - PROCESS | 9756 | RSS: Main: 170020864 18:57:32 INFO - PROCESS | 9756 | 18:57:34 INFO - PROCESS | 9756 | Cycle 1(1): loaded http://localhost:37496/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37496/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:57:35 INFO - PROCESS | 9756 | RSS: Main: 169897984 18:57:35 INFO - PROCESS | 9756 | 18:57:37 INFO - PROCESS | 9756 | Cycle 1(1): loaded http://localhost:37496/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37496/tests/kraken/driver.html?testName=ai-astar) 18:57:37 INFO - PROCESS | 9756 | RSS: Main: 170491904 18:57:37 INFO - PROCESS | 9756 | 18:57:37 INFO - PROCESS | 9756 | __start_tp_report 18:57:37 INFO - PROCESS | 9756 | _x_x_mozilla_page_load 18:57:37 INFO - PROCESS | 9756 | _x_x_mozilla_page_load_details 18:57:37 INFO - PROCESS | 9756 | |i|pagename|runs| 18:57:37 INFO - PROCESS | 9756 | |0;ai-astar;105;113;109;115;113;113;115;115;114;115 18:57:37 INFO - PROCESS | 9756 | |1;audio-beat-detection;157;126;144;177;126;147;155;129;187;122 18:57:37 INFO - PROCESS | 9756 | |2;audio-dft;163;162;164;181;163;163;162;162;163;163 18:57:37 INFO - PROCESS | 9756 | |3;audio-fft;76;76;78;166;77;78;76;77;160;77 18:57:37 INFO - PROCESS | 9756 | |4;audio-oscillator;87;89;150;85;85;86;137;84;86;133 18:57:37 INFO - PROCESS | 9756 | |5;imaging-gaussian-blur;118;118;118;118;118;117;117;118;119;117 18:57:37 INFO - PROCESS | 9756 | |6;imaging-darkroom;148;149;148;149;147;150;147;148;147;147 18:57:37 INFO - PROCESS | 9756 | |7;imaging-desaturate;96;96;96;95;101;100;96;95;96;96 18:57:37 INFO - PROCESS | 9756 | |8;json-parse-financial;65;65;64;64;69;65;65;64;65;65 18:57:37 INFO - PROCESS | 9756 | |9;json-stringify-tinderbox;64;65;65;71;65;65;64;65;65;65 18:57:37 INFO - PROCESS | 9756 | |10;stanford-crypto-aes;86;78;79;80;81;80;81;79;79;78 18:57:37 INFO - PROCESS | 9756 | |11;stanford-crypto-ccm;144;146;146;129;134;133;131;134;174;133 18:57:37 INFO - PROCESS | 9756 | |12;stanford-crypto-pbkdf2;168;167;170;164;167;172;166;167;170;166 18:57:37 INFO - PROCESS | 9756 | |13;stanford-crypto-sha256-iterative;67;69;68;65;69;68;69;68;70;66 18:57:37 INFO - PROCESS | 9756 | __end_tp_report 18:57:37 INFO - PROCESS | 9756 | __start_cc_report 18:57:37 INFO - PROCESS | 9756 | _x_x_mozilla_cycle_collect,998 18:57:37 INFO - PROCESS | 9756 | __end_cc_report 18:57:37 INFO - PROCESS | 9756 | __startTimestamp1467856657574__endTimestamp 18:57:37 INFO - PROCESS | 9756 | 18:57:37 INFO - PROCESS | 9756 | ------- Summary: start ------- 18:57:37 INFO - PROCESS | 9756 | Number of tests: 14 18:57:37 INFO - PROCESS | 9756 | 18:57:37 INFO - PROCESS | 9756 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.50 stddev:3.27 (2.9%) stddev-sans-first:1.94 18:57:37 INFO - PROCESS | 9756 | Values: 105.0 113.0 109.0 115.0 113.0 113.0 115.0 115.0 114.0 115.0 18:57:37 INFO - PROCESS | 9756 | 18:57:37 INFO - PROCESS | 9756 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:151.00 stddev:22.37 (14.8%) stddev-sans-first:23.43 18:57:37 INFO - PROCESS | 9756 | Values: 157.0 126.0 144.0 177.0 126.0 147.0 155.0 129.0 187.0 122.0 18:57:37 INFO - PROCESS | 9756 | 18:57:37 INFO - PROCESS | 9756 | [#2] audio-dft Cycles:10 Average:164.60 Median:163.00 stddev:5.80 (3.6%) stddev-sans-first:6.12 18:57:37 INFO - PROCESS | 9756 | Values: 163.0 162.0 164.0 181.0 163.0 163.0 162.0 162.0 163.0 163.0 18:57:37 INFO - PROCESS | 9756 | 18:57:37 INFO - PROCESS | 9756 | [#3] audio-fft Cycles:10 Average:94.10 Median:77.00 stddev:36.35 (47.2%) stddev-sans-first:37.96 18:57:37 INFO - PROCESS | 9756 | Values: 76.0 76.0 78.0 166.0 77.0 78.0 76.0 77.0 160.0 77.0 18:57:37 INFO - PROCESS | 9756 | 18:57:37 INFO - PROCESS | 9756 | [#4] audio-oscillator Cycles:10 Average:102.20 Median:85.50 stddev:26.45 (30.9%) stddev-sans-first:27.48 18:57:37 INFO - PROCESS | 9756 | Values: 87.0 89.0 150.0 85.0 85.0 86.0 137.0 84.0 86.0 133.0 18:57:37 INFO - PROCESS | 9756 | 18:57:37 INFO - PROCESS | 9756 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 18:57:37 INFO - PROCESS | 9756 | Values: 118.0 118.0 118.0 118.0 118.0 117.0 117.0 118.0 119.0 117.0 18:57:37 INFO - PROCESS | 9756 | 18:57:37 INFO - PROCESS | 9756 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.05 (0.7%) stddev-sans-first:1.12 18:57:37 INFO - PROCESS | 9756 | Values: 148.0 149.0 148.0 149.0 147.0 150.0 147.0 148.0 147.0 147.0 18:57:37 INFO - PROCESS | 9756 | 18:57:37 INFO - PROCESS | 9756 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.00 stddev:2.06 (2.1%) stddev-sans-first:2.17 18:57:37 INFO - PROCESS | 9756 | Values: 96.0 96.0 96.0 95.0 101.0 100.0 96.0 95.0 96.0 96.0 18:57:37 INFO - PROCESS | 9756 | 18:57:37 INFO - PROCESS | 9756 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:65.00 stddev:1.45 (2.2%) stddev-sans-first:1.54 18:57:37 INFO - PROCESS | 9756 | Values: 65.0 65.0 64.0 64.0 69.0 65.0 65.0 64.0 65.0 65.0 18:57:37 INFO - PROCESS | 9756 | 18:57:37 INFO - PROCESS | 9756 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.00 stddev:2.01 (3.1%) stddev-sans-first:2.07 18:57:37 INFO - PROCESS | 9756 | Values: 64.0 65.0 65.0 71.0 65.0 65.0 64.0 65.0 65.0 65.0 18:57:37 INFO - PROCESS | 9756 | 18:57:37 INFO - PROCESS | 9756 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:80.00 stddev:2.33 (2.9%) stddev-sans-first:1.13 18:57:37 INFO - PROCESS | 9756 | Values: 86.0 78.0 79.0 80.0 81.0 80.0 81.0 79.0 79.0 78.0 18:57:37 INFO - PROCESS | 9756 | 18:57:37 INFO - PROCESS | 9756 | [#11] stanford-crypto-ccm Cycles:10 Average:140.40 Median:139.00 stddev:13.39 (9.6%) stddev-sans-first:14.14 18:57:37 INFO - PROCESS | 9756 | Values: 144.0 146.0 146.0 129.0 134.0 133.0 131.0 134.0 174.0 133.0 18:57:37 INFO - PROCESS | 9756 | 18:57:37 INFO - PROCESS | 9756 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.70 Median:167.50 stddev:2.36 (1.4%) stddev-sans-first:2.50 18:57:37 INFO - PROCESS | 9756 | Values: 168.0 167.0 170.0 164.0 167.0 172.0 166.0 167.0 170.0 166.0 18:57:37 INFO - PROCESS | 9756 | 18:57:37 INFO - PROCESS | 9756 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.50 stddev:1.52 (2.2%) stddev-sans-first:1.58 18:57:37 INFO - PROCESS | 9756 | Values: 67.0 69.0 68.0 65.0 69.0 68.0 69.0 68.0 70.0 66.0 18:57:37 INFO - PROCESS | 9756 | -------- Summary: end -------- 18:57:37 INFO - PROCESS | 9756 | 18:57:38 INFO - TEST-INFO | 9756: exit 0 18:57:38 INFO - TEST-OK | kraken | took 63766ms 18:57:38 INFO - SUITE-END | took 1180s 18:57:38 INFO - Completed test suite (00:19:40) 18:57:38 INFO - javascript benchmark 18:57:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6657.26522119297, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2698.2714667039904, 2700.8379497230167, 2728.208819442362, 2735.0700761741004, 2737.4525094981004, 4892.0, 4940.555350018498, 4952.257161425783, 4972.279019542164, 4980.203167493201, 4809.4469136049365, 4910.386201724785, 4946.530079642428, 4958.15711329074, 4973.950260497394, 4494.033782736711, 4525.162844873693, 4648.442186937556, 4653.790579423917, 4656.557627025427, 204.54129616860587, 4438.356438316442, 4505.234110201257, 4505.414296141497, 4534.9773251133865, 4529.048899731044, 4538.568835960578, 4565.360849481075, 4567.680262381635, 4608.0, 4565.08698260346, 4580.9541904580865, 4582.587567118942, 4592.402987611623, 4617.8383756568355, 4439.289713645801, 4491.056878055612, 4529.773511324421, 4534.13851368239, 4557.407537020199, 4902.338184345103, 4937.0, 4945.381827271591, 4959.0, 5026.723530205837, 5111.539961403454, 5289.523942845124, 5332.306800115999, 5334.626576139672, 5368.516833485005, 5273.288106105703, 5317.973410132963, 5332.706701131437, 5348.491893270133, 5368.516833484966, 4969.875753106165, 4970.304157417964, 4980.601551875841, 4983.177775667011, 5036.345275114285, 5267.762950667229, 5320.334958130234, 5430.42980487051, 5473.972630136824, 5475.233467314579, 5159.432462429129, 5189.481051894781, 5191.32512773337, 5227.059129356676, 5246.947530524646, 5278.630495865253, 5280.683159010472, 5292.100342941632, 5296.3379577552805, 5334.119870221448, 5121.257417674491, 5239.794847185092, 5261.657992230493, 5292.994331077083, 5337.466253374631, 5139.563137133311, 5190.792368305301, 5204.609654275944, 5263.6578622389425, 5279.498447647467, 4532.9546704533195, 4547.681662283609, 4554.0, 4587.518310577341, 4599.471060827981, 3815.122521819997, 3891.5135608048995, 3923.6861051115843, 3927.9803600981813, 3959.7822119783687, 4409.581089796464, 4484.932726009112, 4512.849223448, 4557.475890272594, 4598.850287428143, 5309.734513274321, 5330.280412144389, 5358.46415358461, 5359.196120581866, 5363.946360536423, 4451.354553589711, 4454.242778727624, 4482.417285752831, 4526.343680166423, 4574.4739354973935, 4784.186688263004, 4818.590419814355, 4828.7102773833685, 4857.635677324215, 4871.464138944713, 4993.650444468853, 4993.950060499348, 5002.724850133278, 5006.924896126561, 5012.0, 5133.537981581676, 5203.959208158459, 5215.869603259949, 5256.290400795843, 5410.945890541044, 4900.068986892479, 4900.607951363811, 4909.877253068559, 4911.50884911506, 4914.041761856547, 5191.558717509054, 5232.686038837682, 5247.475252474722, 5295.814646487354, 5358.437364076716, 5328.147496400557, 5332.866678333073, 5368.758405871667, 5385.757640906247, 5419.512243898068, 5203.401608815035, 5207.81772637971, 5208.296879921314, 5220.1647736362, 5226.764795584132, 5067.847964561069, 5071.644984851173, 5104.2088476286235, 5135.0, 5202.24567437727, 4969.875753106201, 5006.524380183877, 5017.949820501748, 5025.547700706954, 5048.192289233705, 5131.8196814733565, 5140.203268493389, 5158.793648254028, 5165.870853228699, 5183.688978661142, 4920.065187614342, 5024.120778863758, 5087.440381557952, 5115.9232611510115, 5121.718305493234], "value": 4821.359801499025, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.8012695556553, 579.3106203617695, 589.7935722497126, 594.6224147666234, 613.1140501974648, 36369.09077273066, 41023.38464923021, 41076.79461602691, 41242.58757412425, 41345.37981930273, 39655.60344396562, 40366.59633403665, 40471.59528404715, 40503.189936201255, 40570.97145142746, 7671.117821450535, 7829.334506566948, 7843.607819608997, 7858.607069646523, 7880.881786773174, 7783.883241751379, 7812.453128281023, 7842.0, 7853.607319634024, 7878.921210787905, 7752.186020467854, 7823.726169584065, 7833.334166595846, 7835.294823465887, 7859.056913170428, 7849.5682737449415, 7861.0, 7866.292033716935, 7909.683612655487, 7921.762347129596, 7812.648430820626, 7866.72466463671, 7884.684612615489, 7886.408519361071, 7896.644650990719, 37828.43257351142, 37962.430563541566, 38183.0, 38303.616963830566, 38471.61528384708, 2869.253993961564, 3034.3779525197283, 3075.2773098321877, 3120.0327898351356, 3428.7599868009247, 29561.852190738908, 29959.850200748857, 30050.699493005228, 30221.848890755624, 30492.695073049206, 3502.6322236165347, 3567.1438854674693, 3592.191756854713, 3602.0, 3639.253952939641, 251815.0, 254161.0, 255965.0, 256069.0, 257797.0, 52955.735221323645, 53893.0, 54150.0, 54189.45810541923, 54241.0, 33228.83385583105, 34330.05204401476, 34421.139471513416, 36140.0, 36150.096247593494, 14435.783463248059, 14468.421263149356, 14541.927290363481, 14546.4908728194, 14656.974011819284, 10941.726456838484, 11032.944835275934, 11034.613788517523, 11118.666440006813, 11152.386618735885, 18763.437096887115, 18807.717884231748, 18830.90584547096, 18941.81058189428, 18965.810341896682, 7084.645767711594, 7088.893666595005, 7125.928740712527, 7163.0, 7219.711211551479, 816.8897198878076, 873.733511279066, 924.4684306523776, 932.9253659707207, 938.6490229879265, 28785.28036799055, 29046.0, 29098.563521547192, 29403.411931761246, 29459.85270073679, 935.4808081514825, 950.1733491862125, 981.5190556627201, 983.0906411569413, 1068.6954218047974, 14899.0, 14948.40206391754, 15142.318595663222, 15205.847941520664, 15362.539123826304, 399840.0, 401216.0, 403524.0, 405089.0, 405500.0, 50565.94340565914, 50572.0, 50780.23829642558, 50893.74553127285, 51027.74486127545, 1138.6299452677913, 1153.7519433321877, 1203.560700344368, 1211.3156066822041, 1219.914605977573, 26732.599011015238, 28451.573226401208, 28700.13899583016, 29007.709922901344, 30335.544966825073, 47666.0, 47698.28452573145, 49251.26123108085, 49351.50648493613, 53864.730676346364, 383078.0, 383473.0, 384029.0, 386537.0, 387054.0, 39210.411843822934, 39424.605753942094, 39510.0, 39624.0, 39749.602503975744, 43611.56388436075, 43688.56311436845, 43703.78148109239, 44091.0, 44517.0, 37505.2498950025, 37556.2488750218, 38670.2265954685, 38859.0, 39032.41451378288, 37605.623943761304, 38100.237995240495, 38258.0, 38378.61621383751, 39033.41449878311, 36843.447348290334, 37204.0, 37403.43894841525, 37751.2449750998, 38095.619043810315, 32302.0, 34366.0, 34385.14037149091, 34701.47947780836, 34713.30573388468, 26011.349716257246, 26100.8694956524, 26167.214983550522, 26555.468890622466, 26698.332541686614], "value": 18034.870889498703, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.9911002224944, 359.4123607901081, 362.8893187577789, 364.70823341326934, 385.5027015150456, 16041.759373609391, 16540.503784886456, 17790.288388464447, 17801.7329740054, 17806.287748490045, 16844.157792110374, 17303.0, 18007.63984720308, 18023.36918207863, 18045.187966541504, 5168.560672342846, 5303.628745987782, 5315.840524784263, 5341.893162136755, 5348.0, 5193.922091168635, 5237.3715154181555, 5251.816186433475, 5266.183741520071, 5288.92066619001, 4945.134601444751, 5055.191169412895, 5082.771275292602, 5165.8450246492475, 5201.803585175412, 5125.615578831584, 5135.4094279158, 5145.0481660892665, 5174.223866420049, 5193.63644544882, 4572.0, 4589.35748995141, 4609.861704148881, 4616.5152658970665, 4637.420322459692, 20582.691259631116, 20648.58702825935, 21119.260825871173, 21463.570728585342, 21647.134114635395, 1909.9236030558761, 1914.626647803679, 1930.671785796418, 1966.7246585478044, 2004.4187185716125, 13659.590212293648, 13783.931080344635, 13904.791428128587, 13942.23317717525, 14182.645433864132, 1800.3968670495399, 1802.8828126171888, 1802.9723057857027, 1865.8787178833331, 1874.4095609882843, 50364.0, 70697.64651176763, 72513.63743181303, 72789.27210727878, 73251.63374183148, 9072.501012444247, 9196.172344489029, 9431.952840235892, 9533.52332383378, 9580.425174489554, 12451.25292482454, 12488.500459981498, 12501.624951251477, 12580.748385032248, 12601.369931503388, 7314.122305323395, 7330.633468326562, 7457.664405101675, 7533.962330188424, 7593.6582853771715, 7517.436192285601, 7535.208803075708, 7589.962050189713, 7646.464747467624, 7686.269804368576, 6026.126211699367, 6074.453299203093, 6142.447179753844, 6164.3835616438, 6194.34959329273, 1774.946751597454, 1783.1440908363797, 1815.192239453457, 1816.7093265077524, 1823.972640410395, 847.5211505499373, 897.0, 914.8444764390069, 916.1983264643437, 948.0661548374983, 16973.745393819103, 18064.81935180658, 18410.35563755289, 18454.81545184531, 18674.626507469773, 859.3297228162044, 911.9361644684941, 922.6770630279483, 929.3540989012706, 956.933014688965, 10116.241281903887, 10303.845442318372, 10331.690049298533, 10338.224633152544, 10599.311044782064, 365758.0, 366149.0, 383246.0, 400515.0, 401414.0, 50826.49173508218, 64688.67655661691, 65323.0, 71534.64232678803, 74382.0, 929.8977112517617, 943.2783920300839, 957.9377340472847, 960.1502670136839, 971.6890595009529, 13395.598132056053, 15550.0, 16434.01395916249, 16515.83484165191, 16663.166841658112, 24847.875760621082, 32739.836300818344, 34644.13389665178, 37144.6285537152, 37188.81405592955, 49250.0, 49445.752771235915, 49732.0, 49999.50000500094, 52301.7384913073, 4536.6143877770755, 4725.078609671081, 6729.5625784323865, 7580.582755439141, 7624.237576242332, 11647.88352116468, 12078.03375729957, 12218.20581662189, 12612.810807838074, 12760.617181484571, 10655.0, 10742.73143171427, 10899.400532970763, 11094.5562177512, 11191.44042797873, 10542.683719488428, 10771.19216058783, 11058.502367393326, 11078.944605276922, 11079.5568177272, 11108.777824443305, 11121.777564448505, 11218.2147249695, 11220.66338009861, 11364.374959377314, 7737.690492380467, 7867.7639670807675, 7972.123066462568, 8020.117787043304, 8106.108328083788, 7853.293203611703, 9846.704598862045, 10176.18590512772, 10368.948155259175, 10800.621978230723], "value": 8347.914476600881, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1433.3836450326355, 1435.5549779568332, 1556.2063347692674, 1736.3922627080515, 1753.4388995521422, 7084.716611335541, 7723.189065148163, 7786.260305270997, 8353.0, 8374.246317831394, 7789.92210077899, 7972.760817175494, 8092.312153466948, 8113.5131892086365, 8126.309263712592, 2242.910283588659, 2279.5668822923676, 2292.495650956787, 2293.094227780026, 2300.229423143249, 2238.563480121377, 2291.8395712300144, 2292.793648571628, 2301.5051763870765, 2301.746807851135, 2245.9438514037197, 2259.243153543565, 2261.8416710830247, 2278.692376529164, 2294.27730264966, 2210.80102790748, 2213.147938043857, 2229.9665505017438, 2231.0852550454238, 2232.866028038323, 2165.350394881529, 2180.0, 2192.78072192781, 2193.802557769792, 2203.9779602204094, 8013.7195198168365, 8119.75640730779, 8163.387745919021, 8174.26431621151, 8179.79550511236, 4718.8584342469785, 4836.782344794493, 4860.489648586883, 4871.391076115486, 4873.122837889178, 2883.7548808351107, 3005.6242969628797, 3020.6828283030404, 3025.7730670199603, 3053.8931137410304, 923.9769005774842, 924.3437159616681, 946.5598496699068, 949.050949050949, 961.1205746741723, 11195.776084478264, 11200.66398008053, 11208.551657933673, 11215.0, 11246.044086252678, 4135.234981528367, 4209.6000879916355, 4427.358033085249, 4431.4903786065015, 4433.0, 9401.10689484498, 9437.858432123523, 9462.621495140118, 9499.810003799885, 9522.571484283224, 4825.806967721252, 4828.155072862235, 4853.587445067138, 4856.95143048565, 4867.756612169377, 3881.514810648669, 4276.401303817468, 4435.356873253425, 4458.420405347284, 4459.777011149429, 3751.868684596026, 3799.1072098056934, 3814.9427758583643, 3865.4781604483596, 3879.1853710721066, 1181.2203945395997, 1208.353530860985, 1217.3487184356504, 1218.0499210615733, 1218.1899037140379, 734.6547122852251, 809.3727361294925, 843.8818565400849, 848.1687945813014, 853.5305581929914, 5443.42844001382, 5443.673379597237, 5452.100403433468, 5531.889362212733, 5761.827145185651, 843.6288033265344, 851.7231899632644, 895.1317222294364, 909.0909090909091, 909.777104609375, 3696.4085746281003, 3733.2747094621077, 3893.240818040455, 3947.980260098681, 3950.7827069510877, 9910.35582687123, 10219.846702299472, 10290.228232882564, 10292.691219263434, 10306.433146177033, 9897.703068907944, 10116.241281903887, 10211.540480678388, 10242.743931401774, 10279.331843430302, 7693.884591731128, 7700.075990881242, 7713.884291735629, 7778.494397864234, 7798.961005194938, 5349.812756553502, 5376.247325374529, 5390.029794637003, 5483.7258137092185, 5484.588655850907, 8906.86639700392, 9268.119528644767, 9282.535873206178, 9526.714198574055, 9540.284478663989, 9306.767330816783, 9599.376040557341, 9676.9032309676, 9712.271579631415, 9790.118889299998, 6771.93228067713, 6982.860342793014, 7031.296870312928, 7043.542169758949, 7079.221285658677, 7919.643616037408, 7949.8807517886125, 7958.442908996315, 8001.119876813662, 8015.599220038858, 7037.120359955005, 7062.71749130029, 7190.4607154464675, 7213.242609526134, 7408.222136675571, 6784.76253331131, 6834.248232694499, 6898.793036208922, 7039.929600704132, 7125.786226413008, 6405.807825765234, 6602.1747281589805, 6604.0754294399785, 6634.4029037384935, 6647.734090636321, 4516.299973504112, 4605.078984203105, 4746.098241334135, 4814.229723244264, 4893.755312234445, 4713.457952335525, 4752.596029337545, 4755.619550436026, 4773.474917759113, 4898.975505122452], "value": 4309.464475805237, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.79581191072185, 301.58532018474597, 307.19821266494455, 307.87531049924786, 309.6980444067036, 5030.245463180525, 5047.394312682474, 5213.452587478317, 5239.345081864767, 5266.657667251636, 5110.565601923841, 5140.177571588547, 5153.896922061556, 5158.174692049273, 5168.664036837603, 4040.090979529597, 4058.1883623275316, 4058.8782336529875, 4081.693872959525, 4089.386592011207, 3929.7031979446715, 4034.6800589660916, 4051.270771261172, 4089.427480152781, 4096.815643296059, 3996.920061598766, 4030.9596904031023, 4031.4759081319535, 4035.8183881725245, 4042.939355909664, 3965.147493288957, 3999.8400063997406, 4021.3163762160502, 4032.1129351542613, 4039.717219794601, 3573.6605022522817, 3582.301451217014, 3590.5870824855215, 3595.7662751921043, 3602.2075143468396, 4914.4839791821705, 5067.619928505377, 5071.695698258116, 5080.720560369178, 5155.432902380735, 4623.398958135454, 4631.675782695213, 4642.814287428532, 4659.114768194032, 4661.300804879262, 5371.785128594852, 5378.892422151535, 5386.165144402624, 5387.78448862045, 5402.37872644647, 3719.330520506308, 3830.3488406970882, 3835.53973523179, 3890.9221815563815, 3902.609739026103, 5597.648987425291, 5649.774009039634, 5658.886822263573, 5682.971585142048, 5700.5724570657785, 3968.444417781513, 3995.780232087263, 4000.3199456092534, 4007.2786898358577, 4010.6189911958318, 3968.6647687682516, 4009.8195581198916, 4028.254772867029, 4065.0853557949818, 4071.1654110907193, 4516.932246016312, 4529.297958816389, 4542.500324964251, 4545.204589196877, 4610.654200934943, 5407.864803379868, 5450.700211488327, 5458.918116228259, 5459.781608735686, 5459.918101228484, 1322.907396482237, 1348.2517202952456, 1392.5752645443238, 1393.9684633371232, 1398.9160650361011, 946.0492205333733, 946.8011717539256, 959.9856002159974, 969.5007071358256, 972.1105188752213, 4634.930476042862, 4652.395188625457, 4655.697379670379, 4657.5575320344515, 4669.272369223409, 5473.8357849264585, 5502.477264659851, 5525.309336332958, 5528.226048353234, 5545.77816887328, 4485.484169320504, 4662.7202367858035, 4680.953190468052, 4688.0, 4690.273007683746, 2933.574631678395, 2965.8072225305286, 2993.6407631083976, 2999.2801727585224, 3002.573777455691, 5146.433892271847, 5162.793488260428, 5196.428392876781, 5248.527632513092, 5254.238135470336, 5412.702301373462, 5710.314762228559, 5745.0, 5769.451902069297, 5779.739911703983, 5209.609279304067, 5246.737663116829, 5267.473252674702, 5274.709890955957, 5275.340582427197, 5557.694326812064, 5563.276774019351, 5571.0, 5597.468240517144, 5631.3242410909315, 5247.4227834937365, 5472.728817540835, 5497.45025497447, 5532.2254884315425, 5536.501714845684, 5205.219217117463, 5238.873642166953, 5251.816186433456, 5257.5005374489365, 5267.815626453055, 3848.7113466489564, 3856.652901238902, 3874.302625527432, 3916.9020774479727, 3931.3906344516645, 5295.9470405297, 5578.497935185853, 5602.719864006702, 5618.971905140612, 5624.247510853323, 5222.451642577475, 5367.677939323653, 5388.141091323487, 5390.029794637003, 5399.325084364455, 5369.865753356197, 5379.838604841861, 5385.653586603349, 5410.594205434687, 5419.972900135632, 5234.842954711365, 5298.258243845942, 5334.279872217357, 5341.78632854697, 5366.745966694076, 5418.458154184707, 5429.972850135724, 5440.300595595033, 5449.754761035842, 5464.890702186013, 5266.526012658879, 5305.787768489372, 5330.747274390593, 5333.813316534058, 5374.4088150304215], "value": 4076.8739501138707, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.7765171016001, 657.9965552532387, 717.411722387642, 723.5152447859937, 785.3520845302627, 13006.284654344006, 14037.649058773535, 14047.22740249286, 14051.156930584171, 14065.859341406596, 13308.255337781671, 13328.800067998964, 13331.93334033331, 13771.931140344284, 13829.239391833446, 616.910547970544, 759.5860256160378, 761.5887420792765, 780.2002946979363, 783.1854870934221, 776.0377132355866, 788.6766425765437, 790.182161462886, 790.7706765038132, 791.9722809701661, 839.1817977471977, 839.6389552492426, 841.3437518735396, 841.3479553346175, 842.6039761312204, 831.8918540589746, 833.2167762303445, 833.4665813879092, 834.4034015678819, 836.5482639374791, 611.9418655227746, 612.3876123876124, 613.0467123622765, 613.7790395457631, 614.7448808744366, 14300.356483958143, 14321.14073155614, 14417.639559011004, 14435.350409231505, 14455.638609034753, 13927.930360348235, 14050.086744361686, 14119.929400353036, 14254.0, 14309.427622895177, 10876.09668308043, 10968.890311096866, 11068.612598559092, 11095.945885140898, 11118.666440006813, 3305.5537502437105, 3309.4373956427225, 3382.2728113455723, 3385.5260263563123, 3454.6199918008997, 68723.31276687219, 69347.65326173387, 69356.65321673409, 69816.30183698148, 70037.0, 9733.56198971048, 9760.072793084646, 9796.363236389612, 11461.656150315504, 11469.713257168638, 18909.621807563773, 19176.0, 19216.61566768657, 19226.903865480584, 19237.807621923883, 6751.392374686302, 6809.5233333666165, 6876.587404755731, 6909.136357955255, 7029.26192749754, 3747.6252374762853, 3836.827342769582, 3881.165549406891, 3909.237698648793, 3913.5499417566775, 3433.210361616842, 3655.8484077515495, 3656.03115174479, 3662.963370366262, 3665.340238756996, 587.1632923084672, 590.0618017352344, 592.7006861534898, 594.4679511836882, 602.5119653081018, 524.9527542521115, 556.3324011186593, 575.9049756790166, 584.9908907135158, 616.5468380740152, 8459.096703241721, 8796.196779660155, 8903.421277616933, 8967.282617390592, 8967.417117887317, 571.4456976732563, 595.2737660054727, 602.5932495565476, 602.7920367473215, 616.7687117331001, 4045.19096180765, 4089.7955102245364, 4109.938350924738, 4118.402831589403, 4219.092895027584, 56953.145702814494, 57236.0, 80119.59940200378, 97988.0, 100136.0, 83751.16248837434, 84565.0, 84873.0, 85669.57165214134, 86883.56558217168, 74289.62855185689, 77215.61392193002, 78769.60615196887, 78911.60544197242, 79068.60465697749, 8266.173382661686, 8476.745697629081, 8583.65665373378, 8933.687320943996, 9108.362414631178, 43584.56415435805, 44122.77938610286, 45539.772301138284, 45923.311150332105, 47035.294470583656, 57289.42710573008, 66651.33348666452, 67260.66369668121, 67513.3248667507, 69244.0, 11551.075913926697, 11652.0, 11726.413679315829, 11894.524219031488, 12024.0, 12465.266365891099, 13093.73812523725, 13179.736405272033, 13450.46198152063, 13486.527971520949, 12289.508419663114, 12376.566820161252, 12622.179558328678, 12878.742425151631, 13317.334133293103, 12750.936245318713, 12814.487420503076, 13157.0, 13266.336683165997, 13646.0, 12204.572839950559, 12332.136750427742, 12409.689757756129, 12412.069094817743, 12472.501099956264, 9684.95157524208, 10196.72016643636, 10200.0, 10219.540120694437, 10432.530536125741, 9856.852147217654, 9958.50207489637, 9975.551100200364, 10015.799684006133, 10062.69811905644], "value": 6825.246006076784, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1569.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 109.0, 115.0, 113.0, 113.0, 115.0, 115.0, 114.0, 115.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 126.0, 144.0, 177.0, 126.0, 147.0, 155.0, 129.0, 187.0, 122.0], "value": 147.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 181.0, 163.0, 163.0, 162.0, 162.0, 163.0, 163.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 166.0, 77.0, 78.0, 76.0, 77.0, 160.0, 77.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 89.0, 150.0, 85.0, 85.0, 86.0, 137.0, 84.0, 86.0, 133.0], "value": 102.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 119.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 149.0, 147.0, 150.0, 147.0, 148.0, 147.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 101.0, 100.0, 96.0, 95.0, 96.0, 96.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 69.0, 65.0, 65.0, 64.0, 65.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 71.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 78.0, 79.0, 80.0, 81.0, 80.0, 81.0, 79.0, 79.0, 78.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 146.0, 146.0, 129.0, 134.0, 133.0, 131.0, 134.0, 174.0, 133.0], "value": 140.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 167.0, 170.0, 164.0, 167.0, 172.0, 166.0, 167.0, 170.0, 166.0], "value": 167.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 68.0, 65.0, 69.0, 68.0, 69.0, 68.0, 70.0, 66.0], "value": 67.9, "unit": "score"}]}]} 18:57:38 INFO - Return code: 0 18:57:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:57:38 ERROR - # TBPL SUCCESS # 18:57:38 INFO - Running post-action listener: _resource_record_post_action 18:57:38 INFO - ##### 18:57:38 INFO - ##### Finished run-tests step (success) 18:57:38 INFO - ##### 18:57:38 INFO - Running post-run listener: _resource_record_post_run 18:57:38 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 546996224; Read time: 16; Write time: 367180 18:57:38 INFO - TinderboxPrint: CPU usage
13.3% 18:57:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 18:57:38 INFO - TinderboxPrint: I/O write bytes / time
546,996,224 / 367,180 18:57:38 INFO - TinderboxPrint: CPU idle
8,282.5 (86.7%) 18:57:38 INFO - TinderboxPrint: CPU user
1,216.0 (12.7%) 18:57:38 INFO - TinderboxPrint: Swap in / out
0 / 0 18:57:38 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 219701248; Read time: 0; Write time: 197356 18:57:38 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288051200; Read time: 0; Write time: 158584 18:57:39 INFO - Running post-run listener: _upload_blobber_files 18:57:39 INFO - Blob upload gear active. 18:57:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:57:39 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 18:57:39 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:57:39 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:57:39 INFO - (blobuploader) - INFO - Open directory for files ... 18:57:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:57:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:57:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:57:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:57:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:57:43 INFO - (blobuploader) - INFO - Done attempting. 18:57:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:57:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:57:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:57:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:57:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:57:44 INFO - (blobuploader) - INFO - Done attempting. 18:57:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:57:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:57:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:57:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:57:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:57:44 INFO - (blobuploader) - INFO - Done attempting. 18:57:44 INFO - (blobuploader) - INFO - Iteration through files over. 18:57:44 INFO - Return code: 0 18:57:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:57:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:57:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d09a563530c698d1912082a65a255af481eafac0016bf8a445f0af67025b58068fd238959ad1ed544a83d8c4fb620c180b2ce79ef8b8318dc32a66db202351a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/41a6c54144f9605a54b1be446669044e012c556b9e9a176b1db1d21d6eaaad70abd2ac102424fe6329ef3f02874c574138e4eb4a60ef850268457f9c124e8da4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6e861316447640cbe3613c3bf70a49918a6ac3193bf47379b8c703cea484338554f0e2798ce5d01402012a6f62eb3d1fe387f4a0efa985ab04f1fc7dd3bd4f95"} 18:57:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:57:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:57:44 INFO - Contents: 18:57:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d09a563530c698d1912082a65a255af481eafac0016bf8a445f0af67025b58068fd238959ad1ed544a83d8c4fb620c180b2ce79ef8b8318dc32a66db202351a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/41a6c54144f9605a54b1be446669044e012c556b9e9a176b1db1d21d6eaaad70abd2ac102424fe6329ef3f02874c574138e4eb4a60ef850268457f9c124e8da4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6e861316447640cbe3613c3bf70a49918a6ac3193bf47379b8c703cea484338554f0e2798ce5d01402012a6f62eb3d1fe387f4a0efa985ab04f1fc7dd3bd4f95"} 18:57:44 INFO - Running post-run listener: copy_logs_to_upload_dir 18:57:44 INFO - Copying logs to upload dir... 18:57:44 INFO - mkdir: /builds/slave/test/build/upload/logs 18:57:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.363371 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-06 18:57:44.589056) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 18:57:44.592451) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1467846842.734340-921813110 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/Autoland-Non-PGO/sha512/d09a563530c698d1912082a65a255af481eafac0016bf8a445f0af67025b58068fd238959ad1ed544a83d8c4fb620c180b2ce79ef8b8318dc32a66db202351a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/41a6c54144f9605a54b1be446669044e012c556b9e9a176b1db1d21d6eaaad70abd2ac102424fe6329ef3f02874c574138e4eb4a60ef850268457f9c124e8da4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6e861316447640cbe3613c3bf70a49918a6ac3193bf47379b8c703cea484338554f0e2798ce5d01402012a6f62eb3d1fe387f4a0efa985ab04f1fc7dd3bd4f95"} build_url:https://queue.taskcluster.net/v1/task/LZarEKfASaacdzZCeKmsLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011223 build_url: 'https://queue.taskcluster.net/v1/task/LZarEKfASaacdzZCeKmsLg/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/Autoland-Non-PGO/sha512/d09a563530c698d1912082a65a255af481eafac0016bf8a445f0af67025b58068fd238959ad1ed544a83d8c4fb620c180b2ce79ef8b8318dc32a66db202351a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/41a6c54144f9605a54b1be446669044e012c556b9e9a176b1db1d21d6eaaad70abd2ac102424fe6329ef3f02874c574138e4eb4a60ef850268457f9c124e8da4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6e861316447640cbe3613c3bf70a49918a6ac3193bf47379b8c703cea484338554f0e2798ce5d01402012a6f62eb3d1fe387f4a0efa985ab04f1fc7dd3bd4f95"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 18:57:44.617809) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 18:57:44.618138) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1467846842.734340-921813110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 18:57:44.704014) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 18:57:44.704369) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 18:57:44.704663) ========= ========= Total master_lag: 0.19 =========