builder: graphics_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-018 starttime: 1479427285.83 results: success (0) buildid: 20161117134528 builduid: 5ca3a4fb8a4846b186cb4aedf31ad5c9 revision: 3427f77e5e3c344bb4e83cc3262246e43d23ec8f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 16:01:25.826395) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 16:01:25.833053) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 16:01:25.833337) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 16:01:25.862004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 16:01:25.862289) ========= 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=62c568580acbfdaac3eec7be000001dc-1479427284.795445-2079217055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-17 16:01:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 228M=0s 2016-11-17 16:01:26 (228 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.174896 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 16:01:26.051530) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 16:01:26.051855) ========= 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=62c568580acbfdaac3eec7be000001dc-1479427284.795445-2079217055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.012951 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 16:01:26.101359) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-17 16:01:26.101718) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 3427f77e5e3c344bb4e83cc3262246e43d23ec8f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 3427f77e5e3c344bb4e83cc3262246e43d23ec8f --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=62c568580acbfdaac3eec7be000001dc-1479427284.795445-2079217055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-17 16:01:26,247 truncating revision to first 12 chars 2016-11-17 16:01:26,247 Setting DEBUG logging. 2016-11-17 16:01:26,247 attempt 1/10 2016-11-17 16:01:26,247 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/3427f77e5e3c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-17 16:01:27,264 unpacking tar archive at: graphics-3427f77e5e3c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.689113 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-17 16:01:27.804909) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 16:01:27.805231) ========= script_repo_revision: 3427f77e5e3c344bb4e83cc3262246e43d23ec8f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 16:01:27.805634) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 16:01:27.805910) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 16:01:27.813730) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-11-17 16:01:27.814001) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=62c568580acbfdaac3eec7be000001dc-1479427284.795445-2079217055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:01:28 INFO - MultiFileLogger online at 20161117 16:01:28 in /builds/slave/test 16:01:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 16:01:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:01:28 INFO - {'append_to_log': False, 16:01:28 INFO - 'base_work_dir': '/builds/slave/test', 16:01:28 INFO - 'blob_upload_branch': 'Graphics', 16:01:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:01:28 INFO - 'branch': 'Graphics', 16:01:28 INFO - 'buildbot_json_path': 'buildprops.json', 16:01:28 INFO - 'config_files': ('talos/linux_config.py',), 16:01:28 INFO - 'default_actions': ('clobber', 16:01:28 INFO - 'read-buildbot-config', 16:01:28 INFO - 'download-and-extract', 16:01:28 INFO - 'populate-webroot', 16:01:28 INFO - 'create-virtualenv', 16:01:28 INFO - 'install', 16:01:28 INFO - 'run-tests'), 16:01:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:01:28 INFO - 'download_minidump_stackwalk': True, 16:01:28 INFO - 'download_symbols': 'ondemand', 16:01:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:01:28 INFO - 'tooltool.py': '/tools/tooltool.py', 16:01:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:01:28 INFO - '/tools/misc-python/virtualenv.py')}, 16:01:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:01:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:01:28 INFO - 'installer_path': 'installer.exe', 16:01:28 INFO - 'log_level': 'info', 16:01:28 INFO - 'log_name': 'talos', 16:01:28 INFO - 'log_to_console': True, 16:01:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:01:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:01:28 INFO - 'opt_config_files': (), 16:01:28 INFO - 'pip_index': False, 16:01:28 INFO - 'sps_profile': False, 16:01:28 INFO - 'sps_profile_interval': 0, 16:01:28 INFO - 'suite': 'dromaeojs-e10s', 16:01:28 INFO - 'system_bits': '32', 16:01:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:01:28 INFO - 'title': 'talos-linux64-ix-018', 16:01:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:01:28 INFO - 'use_talos_json': True, 16:01:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:01:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:01:28 INFO - 'work_dir': 'build'} 16:01:28 INFO - [mozharness: 2016-11-18 00:01:28.161916Z] Running clobber step. 16:01:28 INFO - Running pre-action listener: _resource_record_pre_action 16:01:28 INFO - Running main action method: clobber 16:01:28 INFO - rmtree: /builds/slave/test/build 16:01:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:01:28 INFO - Running post-action listener: _resource_record_post_action 16:01:28 INFO - [mozharness: 2016-11-18 00:01:28.586211Z] Finished clobber step (success) 16:01:28 INFO - [mozharness: 2016-11-18 00:01:28.586310Z] Running read-buildbot-config step. 16:01:28 INFO - Running pre-action listener: _resource_record_pre_action 16:01:28 INFO - Running main action method: read_buildbot_config 16:01:28 INFO - Using buildbot properties: 16:01:28 INFO - { 16:01:28 INFO - "project": "", 16:01:28 INFO - "product": "firefox", 16:01:28 INFO - "script_repo_revision": "default", 16:01:28 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs-e10s", 16:01:28 INFO - "repository": "", 16:01:28 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs-e10s", 16:01:28 INFO - "buildid": "20161117134528", 16:01:28 INFO - "pgo_build": "False", 16:01:28 INFO - "basedir": "/builds/slave/test", 16:01:28 INFO - "buildnumber": 4, 16:01:28 INFO - "slavename": "talos-linux64-ix-018", 16:01:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:01:28 INFO - "platform": "ubuntu64_hw", 16:01:28 INFO - "scheduler": "tests-graphics-linux64-talos", 16:01:28 INFO - "branch": "graphics", 16:01:28 INFO - "repo_path": "projects/graphics", 16:01:28 INFO - "revision": "3427f77e5e3c344bb4e83cc3262246e43d23ec8f", 16:01:28 INFO - "stage_platform": "linux64", 16:01:28 INFO - "builduid": "5ca3a4fb8a4846b186cb4aedf31ad5c9", 16:01:28 INFO - "slavebuilddir": "test" 16:01:28 INFO - } 16:01:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/dsrgsWMIRNSi2lxGu94taA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 16:01:28 INFO - Running post-action listener: _resource_record_post_action 16:01:28 INFO - [mozharness: 2016-11-18 00:01:28.588713Z] Finished read-buildbot-config step (success) 16:01:28 INFO - [mozharness: 2016-11-18 00:01:28.588802Z] Running download-and-extract step. 16:01:28 INFO - Running pre-action listener: _resource_record_pre_action 16:01:28 INFO - Running main action method: download_and_extract 16:01:28 INFO - mkdir: /builds/slave/test/build/tests 16:01:28 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:28 INFO - trying https://queue.taskcluster.net/v1/task/dsrgsWMIRNSi2lxGu94taA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 16:01:28 INFO - Downloading https://queue.taskcluster.net/v1/task/dsrgsWMIRNSi2lxGu94taA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 16:01:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dsrgsWMIRNSi2lxGu94taA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:01:29 INFO - Downloaded 1361 bytes. 16:01:29 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 16:01:29 INFO - Using the following test package requirements: 16:01:29 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 16:01:29 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:01:29 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:01:29 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:01:29 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:01:29 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:01:29 INFO - u'jsshell-linux-x86_64.zip'], 16:01:29 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:01:29 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:01:29 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 16:01:29 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:01:29 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:01:29 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:01:29 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:01:29 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:01:29 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:01:29 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:01:29 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:01:29 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:01:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dsrgsWMIRNSi2lxGu94taA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 16:01:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dsrgsWMIRNSi2lxGu94taA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:01:29 INFO - Fetch https://queue.taskcluster.net/v1/task/dsrgsWMIRNSi2lxGu94taA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:01:29 INFO - Http code: 200 16:01:29 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 16:01:29 INFO - x-amz-cf-id: rci9PB6jV6Yk1Ej_5CgIL7tRQXyZIZf3BcAojZ9p4eRxYnHtN4EdIg== 16:01:29 INFO - x-amz-version-id: QG5Urv.x7F4D1veT8DGhwCDl9pXy9uRq 16:01:30 INFO - Expected file size: 20361480 16:01:30 INFO - Obtained file size: 20361480 16:01:34 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:01:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dsrgsWMIRNSi2lxGu94taA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 16:01:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dsrgsWMIRNSi2lxGu94taA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:01:34 INFO - Fetch https://queue.taskcluster.net/v1/task/dsrgsWMIRNSi2lxGu94taA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:01:34 INFO - Http code: 200 16:01:34 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 16:01:34 INFO - x-amz-cf-id: 2WmhiahCo0_FtycDBHKao8kTieCNQiL87OLInFiTMgXFDPFPYqDTmg== 16:01:34 INFO - x-amz-version-id: QG5Urv.x7F4D1veT8DGhwCDl9pXy9uRq 16:01:34 INFO - Expected file size: 20361480 16:01:34 INFO - Obtained file size: 20361480 16:01:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dsrgsWMIRNSi2lxGu94taA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 16:01:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dsrgsWMIRNSi2lxGu94taA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:01:39 INFO - Fetch https://queue.taskcluster.net/v1/task/dsrgsWMIRNSi2lxGu94taA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 16:01:39 INFO - Http code: 200 16:01:39 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 16:01:39 INFO - x-amz-cf-id: jupV5FS_ZJhr3vjoSwGFjpRgtY1MbkvDV1oxY9zYFi2_qtLw9xly-w== 16:01:39 INFO - x-amz-version-id: e0XzggRmmXry3wgKwAalq51aIaftxT3i 16:01:40 INFO - Expected file size: 14409392 16:01:40 INFO - Obtained file size: 14409392 16:01: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:40 INFO - trying https://queue.taskcluster.net/v1/task/dsrgsWMIRNSi2lxGu94taA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 16:01:40 INFO - Downloading https://queue.taskcluster.net/v1/task/dsrgsWMIRNSi2lxGu94taA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 16:01:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dsrgsWMIRNSi2lxGu94taA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:01:41 INFO - Downloaded 55730137 bytes. 16:01:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dsrgsWMIRNSi2lxGu94taA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 16:01:41 INFO - mkdir: /builds/slave/test/properties 16:01:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:01:41 INFO - Writing to file /builds/slave/test/properties/build_url 16:01:41 INFO - Contents: 16:01:41 INFO - build_url:https://queue.taskcluster.net/v1/task/dsrgsWMIRNSi2lxGu94taA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 16:01:42 INFO - Running post-action listener: _resource_record_post_action 16:01:42 INFO - Running post-action listener: set_extra_try_arguments 16:01:42 INFO - [mozharness: 2016-11-18 00:01:42.151593Z] Finished download-and-extract step (success) 16:01:42 INFO - [mozharness: 2016-11-18 00:01:42.151819Z] Running populate-webroot step. 16:01:42 INFO - Running pre-action listener: _resource_record_pre_action 16:01:42 INFO - Running main action method: populate_webroot 16:01:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:01:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:01:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:01:42 INFO - '--tppagecycles', 16:01:42 INFO - '7'], 16:01:42 INFO - 'tests': ['tsvgm']}}, 16:01:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:01:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:01:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:01:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:01:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:01:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:01:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:01:42 INFO - 'talos_options': ['--disable-e10s'], 16:01:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:01:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:01:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:01:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:01:42 INFO - 'talos_options': ['--disable-e10s'], 16:01:42 INFO - 'tests': ['damp', 'tps']}, 16:01:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:01:42 INFO - 'tests': ['damp', 'tps']}, 16:01:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:01:42 INFO - 'tests': ['dromaeo_dom']}, 16:01:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:01:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:01:42 INFO - 'tests': ['basic_compositor_video']}, 16:01:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:01:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:01:42 INFO - 'tests': ['a11yr', 16:01:42 INFO - 'ts_paint', 16:01:42 INFO - 'tpaint', 16:01:42 INFO - 'sessionrestore', 16:01:42 INFO - 'sessionrestore_no_auto_restore', 16:01:42 INFO - 'tabpaint']}, 16:01:42 INFO - 'other-e10s': {'tests': ['a11yr', 16:01:42 INFO - 'ts_paint', 16:01:42 INFO - 'tpaint', 16:01:42 INFO - 'sessionrestore', 16:01:42 INFO - 'sessionrestore_no_auto_restore', 16:01:42 INFO - 'tabpaint']}, 16:01:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:01:42 INFO - 'ts_paint', 16:01:42 INFO - 'tpaint', 16:01:42 INFO - 'sessionrestore', 16:01:42 INFO - 'sessionrestore_no_auto_restore', 16:01:42 INFO - 'tabpaint']}, 16:01:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:01:42 INFO - 'ts_paint', 16:01:42 INFO - 'tpaint', 16:01:42 INFO - 'sessionrestore', 16:01:42 INFO - 'sessionrestore_no_auto_restore', 16:01:42 INFO - 'tabpaint']}, 16:01:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:01:42 INFO - 'tests': ['a11yr', 16:01:42 INFO - 'ts_paint', 16:01:42 INFO - 'tpaint', 16:01:42 INFO - 'sessionrestore', 16:01:42 INFO - 'sessionrestore_no_auto_restore', 16:01:42 INFO - 'tabpaint']}, 16:01:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:01:42 INFO - 'tests': ['a11yr', 16:01:42 INFO - 'ts_paint', 16:01:42 INFO - 'tpaint', 16:01:42 INFO - 'sessionrestore', 16:01:42 INFO - 'sessionrestore_no_auto_restore', 16:01:42 INFO - 'tabpaint']}, 16:01:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:01:42 INFO - 'tests': ['tsvgx', 16:01:42 INFO - 'tsvgr_opacity', 16:01:42 INFO - 'tart', 16:01:42 INFO - 'tscrollx', 16:01:42 INFO - 'cart']}, 16:01:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:01:42 INFO - 'tsvgr_opacity', 16:01:42 INFO - 'tart', 16:01:42 INFO - 'tscrollx', 16:01:42 INFO - 'cart']}, 16:01:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:01:42 INFO - 'talos_options': ['--disable-e10s'], 16:01:42 INFO - 'tests': ['tp5o']}, 16:01:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:01:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:01:42 INFO - 'talos_options': ['--disable-e10s', 16:01:42 INFO - '--xperf_path', 16:01:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:01:42 INFO - 'tests': ['tp5n']}, 16:01:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:01:42 INFO - 'talos_options': ['--xperf_path', 16:01:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:01:42 INFO - 'tests': ['tp5n']}}, 16:01:42 INFO - 'talos.zip': {'path': '', 16:01:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:01:42 INFO - Running post-action listener: _resource_record_post_action 16:01:42 INFO - [mozharness: 2016-11-18 00:01:42.170701Z] Finished populate-webroot step (success) 16:01:42 INFO - [mozharness: 2016-11-18 00:01:42.170789Z] Running create-virtualenv step. 16:01:42 INFO - Running pre-action listener: _resource_record_pre_action 16:01:42 INFO - Running main action method: create_virtualenv 16:01:42 INFO - Creating virtualenv /builds/slave/test/build/venv 16:01:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:01:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:01:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:01:42 INFO - Using real prefix '/usr' 16:01:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:01:42 INFO - Installing distribute.............................................................................................................................................................................................done. 16:01:44 INFO - Installing pip.................done. 16:01:44 INFO - Return code: 0 16:01:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:01:45 INFO - Reading from file tmpfile_stdout 16:01:45 INFO - Output received: 16:01:45 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:01:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f784d76ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fb130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689fc0>, '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 0x268aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268b350>, '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': '62c568580acbfdaac3eec7be000001dc-1479427284.795445-2079217055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:01:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:01:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:01:45 INFO - Using env: {'DISPLAY': ':0', 16:01:45 INFO - 'HOME': '/home/cltbld', 16:01:45 INFO - 'LANG': 'en_US.UTF-8', 16:01:45 INFO - 'LANGUAGE': 'en_US:en', 16:01:45 INFO - 'LOGNAME': 'cltbld', 16:01:45 INFO - 'MAIL': '/var/mail/cltbld', 16:01:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:45 INFO - 'MOZ_NO_REMOTE': '1', 16:01:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:45 INFO - 'NO_EM_RESTART': '1', 16:01:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:45 INFO - 'PWD': '/builds/slave/test', 16:01:45 INFO - 'SHELL': '/bin/bash', 16:01:45 INFO - 'SHLVL': '1', 16:01:45 INFO - 'TERM': 'linux', 16:01:45 INFO - 'TMOUT': '86400', 16:01:45 INFO - 'USER': 'cltbld', 16:01:45 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1479427284.795445-2079217055', 16:01:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:45 INFO - '_': '/tools/buildbot/bin/python'} 16:01:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:01:45 INFO - Cleaning up... 16:01:45 INFO - Return code: 0 16:01:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f784d76ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fb130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689fc0>, '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 0x268aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268b350>, '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': '62c568580acbfdaac3eec7be000001dc-1479427284.795445-2079217055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:01:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:01:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:01:45 INFO - Using env: {'DISPLAY': ':0', 16:01:45 INFO - 'HOME': '/home/cltbld', 16:01:45 INFO - 'LANG': 'en_US.UTF-8', 16:01:45 INFO - 'LANGUAGE': 'en_US:en', 16:01:45 INFO - 'LOGNAME': 'cltbld', 16:01:45 INFO - 'MAIL': '/var/mail/cltbld', 16:01:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:45 INFO - 'MOZ_NO_REMOTE': '1', 16:01:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:45 INFO - 'NO_EM_RESTART': '1', 16:01:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:45 INFO - 'PWD': '/builds/slave/test', 16:01:45 INFO - 'SHELL': '/bin/bash', 16:01:45 INFO - 'SHLVL': '1', 16:01:45 INFO - 'TERM': 'linux', 16:01:45 INFO - 'TMOUT': '86400', 16:01:45 INFO - 'USER': 'cltbld', 16:01:45 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1479427284.795445-2079217055', 16:01:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:45 INFO - '_': '/tools/buildbot/bin/python'} 16:01:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:45 INFO - Downloading/unpacking psutil>=3.1.1 16:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:01:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:01:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:01:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:01:48 INFO - Installing collected packages: psutil 16:01:48 INFO - Running setup.py install for psutil 16:01:48 INFO - building 'psutil._psutil_linux' extension 16:01:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:01:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:01:49 INFO - building 'psutil._psutil_posix' extension 16:01:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:01:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:01:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:01:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:01:49 INFO - Successfully installed psutil 16:01:49 INFO - Cleaning up... 16:01:49 INFO - Return code: 0 16:01:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f784d76ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fb130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689fc0>, '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 0x268aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268b350>, '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': '62c568580acbfdaac3eec7be000001dc-1479427284.795445-2079217055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:01:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:01:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:01:49 INFO - Using env: {'DISPLAY': ':0', 16:01:49 INFO - 'HOME': '/home/cltbld', 16:01:49 INFO - 'LANG': 'en_US.UTF-8', 16:01:49 INFO - 'LANGUAGE': 'en_US:en', 16:01:49 INFO - 'LOGNAME': 'cltbld', 16:01:49 INFO - 'MAIL': '/var/mail/cltbld', 16:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:49 INFO - 'MOZ_NO_REMOTE': '1', 16:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:49 INFO - 'NO_EM_RESTART': '1', 16:01:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:49 INFO - 'PWD': '/builds/slave/test', 16:01:49 INFO - 'SHELL': '/bin/bash', 16:01:49 INFO - 'SHLVL': '1', 16:01:49 INFO - 'TERM': 'linux', 16:01:49 INFO - 'TMOUT': '86400', 16:01:49 INFO - 'USER': 'cltbld', 16:01:49 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1479427284.795445-2079217055', 16:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:49 INFO - '_': '/tools/buildbot/bin/python'} 16:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:01:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:01:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:01:52 INFO - Installing collected packages: mozsystemmonitor 16:01:52 INFO - Running setup.py install for mozsystemmonitor 16:01:52 INFO - Successfully installed mozsystemmonitor 16:01:52 INFO - Cleaning up... 16:01:52 INFO - Return code: 0 16:01:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f784d76ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fb130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689fc0>, '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 0x268aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268b350>, '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': '62c568580acbfdaac3eec7be000001dc-1479427284.795445-2079217055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:01:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:01:52 INFO - Using env: {'DISPLAY': ':0', 16:01:52 INFO - 'HOME': '/home/cltbld', 16:01:52 INFO - 'LANG': 'en_US.UTF-8', 16:01:52 INFO - 'LANGUAGE': 'en_US:en', 16:01:52 INFO - 'LOGNAME': 'cltbld', 16:01:52 INFO - 'MAIL': '/var/mail/cltbld', 16:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:52 INFO - 'MOZ_NO_REMOTE': '1', 16:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:52 INFO - 'NO_EM_RESTART': '1', 16:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:52 INFO - 'PWD': '/builds/slave/test', 16:01:52 INFO - 'SHELL': '/bin/bash', 16:01:52 INFO - 'SHLVL': '1', 16:01:52 INFO - 'TERM': 'linux', 16:01:52 INFO - 'TMOUT': '86400', 16:01:52 INFO - 'USER': 'cltbld', 16:01:52 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1479427284.795445-2079217055', 16:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:52 INFO - '_': '/tools/buildbot/bin/python'} 16:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:52 INFO - Downloading/unpacking jsonschema==2.5.1 16:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:01:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:01:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:01:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:54 INFO - Downloading functools32-3.2.3-2.tar.gz 16:01:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:01:54 INFO - warning: no files found matching '*.txt' 16:01:54 INFO - no previously-included directories found matching 'build' 16:01:54 INFO - no previously-included directories found matching 'dist' 16:01:54 INFO - no previously-included directories found matching '.git*' 16:01:54 INFO - Installing collected packages: jsonschema, functools32 16:01:54 INFO - Running setup.py install for functools32 16:01:54 INFO - warning: no files found matching '*.txt' 16:01:54 INFO - no previously-included directories found matching 'build' 16:01:54 INFO - no previously-included directories found matching 'dist' 16:01:54 INFO - no previously-included directories found matching '.git*' 16:01:54 INFO - Successfully installed jsonschema functools32 16:01:54 INFO - Cleaning up... 16:01:54 INFO - Return code: 0 16:01:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f784d76ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fb130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689fc0>, '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 0x268aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268b350>, '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': '62c568580acbfdaac3eec7be000001dc-1479427284.795445-2079217055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:01:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:01:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:01:54 INFO - Using env: {'DISPLAY': ':0', 16:01:54 INFO - 'HOME': '/home/cltbld', 16:01:54 INFO - 'LANG': 'en_US.UTF-8', 16:01:54 INFO - 'LANGUAGE': 'en_US:en', 16:01:54 INFO - 'LOGNAME': 'cltbld', 16:01:54 INFO - 'MAIL': '/var/mail/cltbld', 16:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:54 INFO - 'MOZ_NO_REMOTE': '1', 16:01:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:54 INFO - 'NO_EM_RESTART': '1', 16:01:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:54 INFO - 'PWD': '/builds/slave/test', 16:01:54 INFO - 'SHELL': '/bin/bash', 16:01:54 INFO - 'SHLVL': '1', 16:01:54 INFO - 'TERM': 'linux', 16:01:54 INFO - 'TMOUT': '86400', 16:01:54 INFO - 'USER': 'cltbld', 16:01:54 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1479427284.795445-2079217055', 16:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:54 INFO - '_': '/tools/buildbot/bin/python'} 16:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:01:55 INFO - Cleaning up... 16:01:55 INFO - Return code: 0 16:01:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f784d76ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fb130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689fc0>, '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 0x268aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268b350>, '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': '62c568580acbfdaac3eec7be000001dc-1479427284.795445-2079217055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:01:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:01:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:01:55 INFO - Using env: {'DISPLAY': ':0', 16:01:55 INFO - 'HOME': '/home/cltbld', 16:01:55 INFO - 'LANG': 'en_US.UTF-8', 16:01:55 INFO - 'LANGUAGE': 'en_US:en', 16:01:55 INFO - 'LOGNAME': 'cltbld', 16:01:55 INFO - 'MAIL': '/var/mail/cltbld', 16:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:55 INFO - 'MOZ_NO_REMOTE': '1', 16:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:55 INFO - 'NO_EM_RESTART': '1', 16:01:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:55 INFO - 'PWD': '/builds/slave/test', 16:01:55 INFO - 'SHELL': '/bin/bash', 16:01:55 INFO - 'SHLVL': '1', 16:01:55 INFO - 'TERM': 'linux', 16:01:55 INFO - 'TMOUT': '86400', 16:01:55 INFO - 'USER': 'cltbld', 16:01:55 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1479427284.795445-2079217055', 16:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:55 INFO - '_': '/tools/buildbot/bin/python'} 16:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:55 INFO - Downloading/unpacking blobuploader==1.2.4 16:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:01:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:57 INFO - Downloading blobuploader-1.2.4.tar.gz 16:01:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:01:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:01:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:01:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:01:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:58 INFO - Downloading docopt-0.6.1.tar.gz 16:01:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:01:58 INFO - Installing collected packages: blobuploader, requests, docopt 16:01:58 INFO - Running setup.py install for blobuploader 16:01:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:01:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:01:58 INFO - Running setup.py install for requests 16:01:58 INFO - Running setup.py install for docopt 16:01:58 INFO - Successfully installed blobuploader requests docopt 16:01:58 INFO - Cleaning up... 16:01:59 INFO - Return code: 0 16:01:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:01:59 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:59 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:59 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 0x7f784d76ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fb130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689fc0>, '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 0x268aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268b350>, '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': '62c568580acbfdaac3eec7be000001dc-1479427284.795445-2079217055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:01:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:01:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:01:59 INFO - Using env: {'DISPLAY': ':0', 16:01:59 INFO - 'HOME': '/home/cltbld', 16:01:59 INFO - 'LANG': 'en_US.UTF-8', 16:01:59 INFO - 'LANGUAGE': 'en_US:en', 16:01:59 INFO - 'LOGNAME': 'cltbld', 16:01:59 INFO - 'MAIL': '/var/mail/cltbld', 16:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:59 INFO - 'MOZ_NO_REMOTE': '1', 16:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:59 INFO - 'NO_EM_RESTART': '1', 16:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:59 INFO - 'PWD': '/builds/slave/test', 16:01:59 INFO - 'SHELL': '/bin/bash', 16:01:59 INFO - 'SHLVL': '1', 16:01:59 INFO - 'TERM': 'linux', 16:01:59 INFO - 'TMOUT': '86400', 16:01:59 INFO - 'USER': 'cltbld', 16:01:59 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1479427284.795445-2079217055', 16:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:59 INFO - '_': '/tools/buildbot/bin/python'} 16:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:01:59 INFO - Running setup.py (path:/tmp/pip-1hAAB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:01:59 INFO - Running setup.py (path:/tmp/pip-u5pGsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:01:59 INFO - Running setup.py (path:/tmp/pip-txKePr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:01:59 INFO - Running setup.py (path:/tmp/pip-7KemA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:01:59 INFO - Running setup.py (path:/tmp/pip-UN3lc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:01:59 INFO - Running setup.py (path:/tmp/pip-CNqX_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:01:59 INFO - Running setup.py (path:/tmp/pip-MGcgSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:01:59 INFO - Running setup.py (path:/tmp/pip-JWoD58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:01:59 INFO - Running setup.py (path:/tmp/pip-4jxXHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:01:59 INFO - Running setup.py (path:/tmp/pip-P8SdSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:01:59 INFO - Running setup.py (path:/tmp/pip-F0FSbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:01:59 INFO - Running setup.py (path:/tmp/pip-pwjDLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:02:00 INFO - Running setup.py (path:/tmp/pip-g7GDxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:02:00 INFO - Running setup.py (path:/tmp/pip-qsLd6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:02:00 INFO - Running setup.py (path:/tmp/pip-m5pXuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:02:00 INFO - Running setup.py (path:/tmp/pip-8zXnzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:02:00 INFO - Running setup.py (path:/tmp/pip-u_16Bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:02:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:02:00 INFO - Running setup.py install for manifestparser 16:02:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:02:00 INFO - Running setup.py install for mozcrash 16:02:00 INFO - Running setup.py install for mozdebug 16:02:00 INFO - Running setup.py install for mozdevice 16:02:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:02:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:02:00 INFO - Running setup.py install for mozfile 16:02:00 INFO - Running setup.py install for mozhttpd 16:02:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:02:00 INFO - Running setup.py install for mozinfo 16:02:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:02:01 INFO - Running setup.py install for mozInstall 16:02:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:02:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:02:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:02:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:02:01 INFO - Running setup.py install for mozleak 16:02:01 INFO - Running setup.py install for mozlog 16:02:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:02:01 INFO - Running setup.py install for moznetwork 16:02:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:02:01 INFO - Running setup.py install for mozprocess 16:02:01 INFO - Running setup.py install for mozprofile 16:02:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:02:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:02:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:02:01 INFO - Running setup.py install for mozrunner 16:02:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:02:01 INFO - Running setup.py install for mozscreenshot 16:02:01 INFO - Running setup.py install for moztest 16:02:01 INFO - Running setup.py install for mozversion 16:02:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:02:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:02:02 INFO - Cleaning up... 16:02:02 INFO - Return code: 0 16:02:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:02:02 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:02 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:02 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 0x7f784d76ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fb130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689fc0>, '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 0x268aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268b350>, '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': '62c568580acbfdaac3eec7be000001dc-1479427284.795445-2079217055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:02:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:02:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:02:02 INFO - Using env: {'DISPLAY': ':0', 16:02:02 INFO - 'HOME': '/home/cltbld', 16:02:02 INFO - 'LANG': 'en_US.UTF-8', 16:02:02 INFO - 'LANGUAGE': 'en_US:en', 16:02:02 INFO - 'LOGNAME': 'cltbld', 16:02:02 INFO - 'MAIL': '/var/mail/cltbld', 16:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:02 INFO - 'MOZ_NO_REMOTE': '1', 16:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:02 INFO - 'NO_EM_RESTART': '1', 16:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:02 INFO - 'PWD': '/builds/slave/test', 16:02:02 INFO - 'SHELL': '/bin/bash', 16:02:02 INFO - 'SHLVL': '1', 16:02:02 INFO - 'TERM': 'linux', 16:02:02 INFO - 'TMOUT': '86400', 16:02:02 INFO - 'USER': 'cltbld', 16:02:02 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1479427284.795445-2079217055', 16:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:02 INFO - '_': '/tools/buildbot/bin/python'} 16:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:02:02 INFO - Running setup.py (path:/tmp/pip-ICNvno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:02:02 INFO - Running setup.py (path:/tmp/pip-dPqevU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:02:02 INFO - Running setup.py (path:/tmp/pip-GBk2ND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:02:02 INFO - Running setup.py (path:/tmp/pip-8hKLW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:02:02 INFO - Running setup.py (path:/tmp/pip-C54TZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:02:02 INFO - Running setup.py (path:/tmp/pip-5gYItf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:02:02 INFO - Running setup.py (path:/tmp/pip-JF2gEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:02:02 INFO - Running setup.py (path:/tmp/pip-8DQH1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:02:02 INFO - Running setup.py (path:/tmp/pip-hQ0ONT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:02:02 INFO - Running setup.py (path:/tmp/pip-Ug4Xel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:02:03 INFO - Running setup.py (path:/tmp/pip-3iAzaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:02:03 INFO - Running setup.py (path:/tmp/pip-VkqyJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:02:03 INFO - Running setup.py (path:/tmp/pip-7HLzA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:02:03 INFO - Running setup.py (path:/tmp/pip-WGvNGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:02:03 INFO - Running setup.py (path:/tmp/pip-5rflMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:02:03 INFO - Running setup.py (path:/tmp/pip-nenYYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:02:03 INFO - Running setup.py (path:/tmp/pip-sMXLkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:02:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:05 INFO - Downloading blessings-1.6.tar.gz 16:02:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:02:05 INFO - Installing collected packages: blessings 16:02:05 INFO - Running setup.py install for blessings 16:02:05 INFO - Successfully installed blessings 16:02:05 INFO - Cleaning up... 16:02:05 INFO - Return code: 0 16:02:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:02:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:02:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:02:06 INFO - Reading from file tmpfile_stdout 16:02:06 INFO - Current package versions: 16:02:06 INFO - argparse == 1.2.1 16:02:06 INFO - blessings == 1.6 16:02:06 INFO - blobuploader == 1.2.4 16:02:06 INFO - docopt == 0.6.1 16:02:06 INFO - functools32 == 3.2.3-2 16:02:06 INFO - jsonschema == 2.5.1 16:02:06 INFO - manifestparser == 1.1 16:02:06 INFO - mozInstall == 1.12 16:02:06 INFO - mozcrash == 1.0 16:02:06 INFO - mozdebug == 0.1 16:02:06 INFO - mozdevice == 0.48 16:02:06 INFO - mozfile == 1.2 16:02:06 INFO - mozhttpd == 0.7 16:02:06 INFO - mozinfo == 0.9 16:02:06 INFO - mozleak == 0.1 16:02:06 INFO - mozlog == 3.4 16:02:06 INFO - moznetwork == 0.27 16:02:06 INFO - mozprocess == 0.23 16:02:06 INFO - mozprofile == 0.28 16:02:06 INFO - mozrunner == 6.13 16:02:06 INFO - mozscreenshot == 0.1 16:02:06 INFO - mozsystemmonitor == 0.3 16:02:06 INFO - moztest == 0.7 16:02:06 INFO - mozversion == 1.4 16:02:06 INFO - psutil == 3.1.1 16:02:06 INFO - requests == 1.2.3 16:02:06 INFO - wsgiref == 0.1.2 16:02:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:02:06 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:06 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:06 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 0x7f784d76ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fb130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689fc0>, '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 0x268aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268b350>, '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': '62c568580acbfdaac3eec7be000001dc-1479427284.795445-2079217055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:02:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:02:06 INFO - Using env: {'DISPLAY': ':0', 16:02:06 INFO - 'HOME': '/home/cltbld', 16:02:06 INFO - 'LANG': 'en_US.UTF-8', 16:02:06 INFO - 'LANGUAGE': 'en_US:en', 16:02:06 INFO - 'LOGNAME': 'cltbld', 16:02:06 INFO - 'MAIL': '/var/mail/cltbld', 16:02:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:06 INFO - 'MOZ_NO_REMOTE': '1', 16:02:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:06 INFO - 'NO_EM_RESTART': '1', 16:02:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:06 INFO - 'PWD': '/builds/slave/test', 16:02:06 INFO - 'SHELL': '/bin/bash', 16:02:06 INFO - 'SHLVL': '1', 16:02:06 INFO - 'TERM': 'linux', 16:02:06 INFO - 'TMOUT': '86400', 16:02:06 INFO - 'USER': 'cltbld', 16:02:06 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1479427284.795445-2079217055', 16:02:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:06 INFO - '_': '/tools/buildbot/bin/python'} 16:02:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:02:06 INFO - Cleaning up... 16:02:06 INFO - Return code: 0 16:02:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:02:06 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:06 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:06 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 0x7f784d76ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fb130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689fc0>, '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 0x268aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268b350>, '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': '62c568580acbfdaac3eec7be000001dc-1479427284.795445-2079217055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:02:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:02:06 INFO - Using env: {'DISPLAY': ':0', 16:02:06 INFO - 'HOME': '/home/cltbld', 16:02:06 INFO - 'LANG': 'en_US.UTF-8', 16:02:06 INFO - 'LANGUAGE': 'en_US:en', 16:02:06 INFO - 'LOGNAME': 'cltbld', 16:02:06 INFO - 'MAIL': '/var/mail/cltbld', 16:02:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:06 INFO - 'MOZ_NO_REMOTE': '1', 16:02:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:06 INFO - 'NO_EM_RESTART': '1', 16:02:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:06 INFO - 'PWD': '/builds/slave/test', 16:02:06 INFO - 'SHELL': '/bin/bash', 16:02:06 INFO - 'SHLVL': '1', 16:02:06 INFO - 'TERM': 'linux', 16:02:06 INFO - 'TMOUT': '86400', 16:02:06 INFO - 'USER': 'cltbld', 16:02:06 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1479427284.795445-2079217055', 16:02:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:06 INFO - '_': '/tools/buildbot/bin/python'} 16:02:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:02:06 INFO - Cleaning up... 16:02:06 INFO - Return code: 0 16:02:06 INFO - Running post-action listener: _resource_record_post_action 16:02:06 INFO - Running post-action listener: _start_resource_monitoring 16:02:06 INFO - Starting resource monitoring. 16:02:06 INFO - [mozharness: 2016-11-18 00:02:06.512613Z] Finished create-virtualenv step (success) 16:02:06 INFO - [mozharness: 2016-11-18 00:02:06.513068Z] Running install step. 16:02:06 INFO - Running pre-action listener: _resource_record_pre_action 16:02:06 INFO - Running main action method: install 16:02:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:02:06 INFO - Reading from file tmpfile_stdout 16:02:06 INFO - Detecting whether we're running mozinstall >=1.0... 16:02:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:02:06 INFO - Reading from file tmpfile_stdout 16:02:06 INFO - Output received: 16:02:06 INFO - Usage: mozinstall [options] installer 16:02:06 INFO - Options: 16:02:06 INFO - -h, --help show this help message and exit 16:02:06 INFO - -d DEST, --destination=DEST 16:02:06 INFO - Directory to install application into. [default: 16:02:06 INFO - "/builds/slave/test"] 16:02:06 INFO - --app=APP Application being installed. [default: firefox] 16:02:06 INFO - mkdir: /builds/slave/test/build/application 16:02:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:02:22 INFO - Reading from file tmpfile_stdout 16:02:22 INFO - Output received: 16:02:22 INFO - /builds/slave/test/build/application/firefox/firefox 16:02:22 INFO - Running post-action listener: _resource_record_post_action 16:02:22 INFO - [mozharness: 2016-11-18 00:02:22.861791Z] Finished install step (success) 16:02:22 INFO - [mozharness: 2016-11-18 00:02:22.862048Z] Running run-tests step. 16:02:22 INFO - Running pre-action listener: _resource_record_pre_action 16:02:22 INFO - Running main action method: run_tests 16:02:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:02:22 INFO - Python 2.7.3 16:02:22 INFO - Return code: 0 16:02:22 INFO - grabbing minidump binary from tooltool 16:02: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:22 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2689fc0>, '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 0x268aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x268b350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:02:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:02:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:02:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:02:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:02:22 INFO - Return code: 0 16:02:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:02:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:02:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:02:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:02:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:02:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dsrgsWMIRNSi2lxGu94taA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dsrgsWMIRNSi2lxGu94taA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:02:22 INFO - Using env: {'DISPLAY': ':0', 16:02:22 INFO - 'HOME': '/home/cltbld', 16:02:22 INFO - 'LANG': 'en_US.UTF-8', 16:02:22 INFO - 'LANGUAGE': 'en_US:en', 16:02:22 INFO - 'LOGNAME': 'cltbld', 16:02:22 INFO - 'MAIL': '/var/mail/cltbld', 16:02:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:02:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:22 INFO - 'MOZ_NO_REMOTE': '1', 16:02:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:22 INFO - 'NO_EM_RESTART': '1', 16:02:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:22 INFO - 'PWD': '/builds/slave/test', 16:02:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:02:22 INFO - 'SHELL': '/bin/bash', 16:02:22 INFO - 'SHLVL': '1', 16:02:22 INFO - 'TERM': 'linux', 16:02:22 INFO - 'TMOUT': '86400', 16:02:22 INFO - 'USER': 'cltbld', 16:02:22 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1479427284.795445-2079217055', 16:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:22 INFO - '_': '/tools/buildbot/bin/python'} 16:02:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dsrgsWMIRNSi2lxGu94taA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:02:23 INFO - mozversion application_buildid: 20161117134528 16:02:23 INFO - mozversion application_changeset: 3427f77e5e3c344bb4e83cc3262246e43d23ec8f 16:02:23 INFO - mozversion application_display_name: Nightly 16:02:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:02:23 INFO - mozversion application_name: Firefox 16:02:23 INFO - mozversion application_remotingname: firefox 16:02:23 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 16:02:23 INFO - mozversion application_vendor: Mozilla 16:02:23 INFO - mozversion application_version: 53.0a1 16:02:23 INFO - mozversion platform_buildid: 20161117134528 16:02:23 INFO - mozversion platform_changeset: 3427f77e5e3c344bb4e83cc3262246e43d23ec8f 16:02:23 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 16:02:23 INFO - mozversion platform_version: 53.0a1 16:02:23 INFO - using testdate: 1479427343 16:02:23 INFO - actual date: 1479427343 16:02:23 INFO - starting webserver on 'localhost:45412' 16:02:23 INFO - SUITE-START | Running 2 tests 16:02:23 INFO - TEST-START | dromaeo_css 16:02:23 INFO - operating with platform_type : linux_ 16:02:23 INFO - Initialising browser for dromaeo_css test... 16:02:23 INFO - TEST-INFO | started process 3338 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0JnBAm/profile http://localhost:45412/getInfo.html) 16:02:31 INFO - PROCESS | 3338 | __metrics Screen width/height:1600/1200 16:02:31 INFO - PROCESS | 3338 | colorDepth:24 16:02:31 INFO - PROCESS | 3338 | Browser inner width/height: 1024/697 16:02:31 INFO - PROCESS | 3338 | __metrics 16:02:31 ERROR - PROCESS | 3338 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined 16:02:32 INFO - TEST-INFO | 3338: exit 0 16:02:32 INFO - Browser initialized. 16:02:32 INFO - Running cycle 1/1 for dromaeo_css test... 16:02:32 INFO - TEST-INFO | started process 3461 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0JnBAm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:02:45 INFO - PROCESS | 3461 | RSS: Main: 187830272 16:02:45 INFO - PROCESS | 3461 | 16:03:34 INFO - PROCESS | 3461 | 1479427414837 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:05:48 INFO - PROCESS | 3461 | Cycle 1(1): loaded http://localhost:45412/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45412/tests/dromaeo/cssquery-ext.html) 16:05:50 INFO - PROCESS | 3461 | RSS: Main: 197533696 16:05:50 INFO - PROCESS | 3461 | 16:08:52 INFO - PROCESS | 3461 | Cycle 1(1): loaded http://localhost:45412/tests/dromaeo/cssquery-ext.html (next: http://localhost:45412/tests/dromaeo/cssquery-jquery.html) 16:08:53 INFO - PROCESS | 3461 | RSS: Main: 197484544 16:08:53 INFO - PROCESS | 3461 | 16:11:55 INFO - PROCESS | 3461 | Cycle 1(1): loaded http://localhost:45412/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45412/tests/dromaeo/cssquery-mootools.html) 16:11:55 INFO - PROCESS | 3461 | RSS: Main: 199729152 16:11:55 INFO - PROCESS | 3461 | 16:14:57 INFO - PROCESS | 3461 | Cycle 1(1): loaded http://localhost:45412/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45412/tests/dromaeo/cssquery-prototype.html) 16:14:58 INFO - PROCESS | 3461 | RSS: Main: 196317184 16:14:58 INFO - PROCESS | 3461 | 16:18:01 INFO - PROCESS | 3461 | Cycle 1(1): loaded http://localhost:45412/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45412/tests/dromaeo/cssquery-yui.html) 16:18:02 INFO - PROCESS | 3461 | RSS: Main: 199274496 16:18:02 INFO - PROCESS | 3461 | 16:21:05 INFO - PROCESS | 3461 | Cycle 1(1): loaded http://localhost:45412/tests/dromaeo/cssquery-yui.html (next: http://localhost:45412/tests/dromaeo/cssquery-dojo.html) 16:21:05 INFO - PROCESS | 3461 | RSS: Main: 199712768 16:21:05 INFO - PROCESS | 3461 | 16:21:05 INFO - PROCESS | 3461 | __start_tp_report 16:21:05 INFO - PROCESS | 3461 | _x_x_mozilla_page_load 16:21:05 INFO - PROCESS | 3461 | _x_x_mozilla_page_load_details 16:21:05 INFO - PROCESS | 3461 | |i|pagename|runs| 16:21:05 INFO - PROCESS | 3461 | |0;dojo.html;2537.0486067724605;2556.2459074573;2560.847618571642;2564.038485567912;2582.470593528327;4494.573015563525;4578.496365399812;4588.426446694163;4597.977010114949;4621.353010578513;4526.524714904937;4527.185106680796;4539.954600453994;4597.54024597541;4604.194266003453;4158.4178215049915;4198.349255865331;4264.829406823739;4298.634616057623;4322.805473753689;4183.435236243114;4247.5964783345535;4278.144371125772;4285.700000999931;4315.4605674290715;4055.3916912463073;4079.73481723687;4268.189044081614;4272.743635381887;4335.56644335567;4112.670986321087;4120.196561670476;4122.958770412288;4123.299039163349;4135.5657655946;4135.338345864678;4138.565450627701;4184.51878034027;4198.118395137025;4245.936310955338;4514.954850451519;4557.134144512532;4567.2920697291975;4582.221022426163;4605.355250264965;4834.540718631724;4854.441739200002;4861.295112208745;4866.245731911524;4883.291922671228;4776.737279449629;4823.445303790074;4827.300041493963;4828.686135401188;4839.467658557556;4588.274520147101;4590.655700822452;4602.493725690205;4633.096546173498;4633.2818413146015;4953.702777833341;4966.1309270877455;4966.726830024311;4970.950290497049;5017.247412888023;4636.83771068011;4690.695104818176;4698.060387922429;4698.248280275208;4784.856454306377;4815.277708343777;4817.181079216542;4830.396200474941;4832.975835120872;4857.077155340474;4810.11012962603;4840.878978025577;4848.127337079289;4878.463369029404;4891.021795640886;4816.229403295456;4824;4827.155247831615;4834.347363105936;4859.708417494961;3961.801909904493;3994.241094192152;4081.551029386765;4133.937990930139;4154.709170358046;3617.5478065241846;3630.3828349180703;3662.7985460799378;3666.1934374437583;3675.320065787838;4198.181354635817;4216.64158546527;4223.598758117974;4225.746455212697;4267.253230684618;4741.66808323421;4744.905101897943;4903.092927808367;4930.605551555867;4978.352814134139;4151.190517848991;4158.459400277945;4172.916541669149;4180.623743863067;4188.4136220929095;4412.271975124133;4427.22523558376;4435.844745433894;4436.889077773081;4479.417675702138;4561.521040290788;4583.74789386587;4596.862094137115;4600.861974140781;4634.212183928673;4764.666473346832;4782.163121453801;4784.186688262934;4833.371661683958;4923.753812309442;4498.775061246859;4501.527339629291;4530.88672783183;4545.454545454434;4546.74992875395;4738.763061846825;4767.356406885026;4785.569298763128;4816.686915350491;4843.685160464559;4872.512748725241;4874.805007799649;4880.585150262267;4883.633727470525;4926.531979461945;4539.568740969603;4682.367880336111;4683.461401938821;4730.47964723887;4797.808087676453;4642.094791515622;4706.882327941828;4715.504871988529;4716.787744551435;4719.3628860103445;4570.063137056962;4603.562661547147;4655.255159174651;4663.370444990019;4711.034237981275;4748.548887855648;4758.095961767253;4764.642651801199;4779.354787103835;4818.590419814215;4649.163150632919;4654.976725116353;4659.767011649472;4661.440627124767;4685.718856868599 16:21:05 INFO - PROCESS | 3461 | |1;ext.html;535.4404647143734;545.1087471983308;557.4369886414721;558.7846434006041;564.1087082409792;26485.867570662143;27736.583951240722;27914.860425697843;30315.84842075792;30350.24124396891;27149;27406.177814665592;27440;27463.725362746365;27540.862295688494;5316.3354580677515;5444.91832622511;5453.618246722731;5467.289252397202;5468.152436372348;5625.128105143689;5696.344920334152;5699.116636921284;5699.886002279973;5710.800121995731;5700.800471983482;5729.255196824407;5735.827925162252;5738.139279108125;5739.713014349287;5655.981923253813;5675.659460432387;5703.0589952657765;5708.686022268795;5712.028955077647;5490.368607610136;5546.750396232179;5552.333719953591;5558.416366281523;5565.1374037024325;25256.87371563149;25514.744852551423;25530.361740956625;25552.616710749353;25559.233223003153;2888.2201805512605;2919.357741296911;2921.1528656689534;3087.938241235163;3235.4014507316224;17847.286108555643;18122.184501697455;18173.546116310794;19317.4204773857;19464.513387165294;2628.9605655915175;2652.1910817200746;2662.4142688608476;2677.785777137844;2679.2765953192725;229840;232778;232908;233015;233223;46885.29672054922;47229.29156062662;47250;47313;47377.76311118422;55344.446555534734;55363.16955245675;55542.72228638831;55564;55594.16608750872;13797.310134493235;13974.650633734238;14009.439622415193;14043.50847720325;14047.648808779657;10335.793284134426;10400.375977441226;10405.427701476492;10434.12185806547;10476.266661333786;16656.50030499087;17269.740953885703;17281.740773888403;17304;17346.3061477542;6472.611643301417;6510.934890651128;6565.179352580927;6725.899111513331;6815.863682726417;762.6377470701373;885.8051228729669;893.5219657483216;929.8930622978309;950.334765664038;26937.595936060974;27260.727392725817;27329.590056149173;27367.589486157725;27695.584566231522;930.7393929699695;943.4763706143157;964.7636329099415;970.4274478057838;1015.8984101589782;13233.978539764385;13969;14083.929580352238;14236.217008064448;14321.212333321559;329958;331363;332181;332920;333620;42133;42743;42799.7860010698;42824.78587607042;42901.785491072966;1156.780211759763;1160.6111952496008;1167.988320116788;1179.687382843547;1200.543793358518;24214.129476185855;25156.61638609894;26220.60669089927;26317.605235921095;26541.867290663424;40301;40919.38620920629;40964.79517602393;41009.1798164041;41258;300759;302481;303860;304258;305340;22353.776462235168;22704;23092.538149237258;23420.88289558541;23586.88206558956;35918.8204058978;36359.81820090883;36519.81740091283;36691;36875.81562092173;31084.533731994492;31153.8442307787;31360.843195783877;31374.686253137177;32214.872479463105;30715.699802028183;30995.535066973564;31024.844875775478;31447;32278.677213227566;30623.693763062085;30934.381312373178;31170.532442012933;31174.532382013833;31726;26732.465350692488;28802.855985719936;29174.27064323324;29178.270543236587;29487.810822775475;22706.318810435714;22884.885575572014;23116.19093331725;23149.65275520835;23335.766642333358 16:21:05 INFO - PROCESS | 3461 | |2;jquery.html;334.9349069957536;353.8372348719589;355.6372500049948;359.1362772532061;381.4811855876008;11228.887711122887;11474.90988356107;12213;12357.814632780504;12359.393278873757;13622.114562553426;13745.725085498285;13815.1020183688;13902.930485347584;14358.784618230735;3970.920581588374;4226.1336426032585;4230.111676547913;4232.238197124517;4234.555371685975;3959.9208015839667;4033.556308806029;4114.3211370124045;4160.43834082398;4167.541570427251;4113.053997580559;4132.566080561543;4135.255653982282;4156.127213285214;4161.313383291768;3863.1887303666263;4125.628693417591;4129.525104612963;4140.648044916185;4163.770992595406;3735.477033215352;3804.0680033391995;3828.0812604974885;3830.4828848105426;3832.3485007548784;10319.742006449824;10385.2211084169;10392.376457412503;11075.944620276927;15871.761923571155;1848.7873894502036;1862;1904.6381187574316;1907.0560072764072;1920.532116230651;7572.469927105105;7869.763907082739;8143.348532117476;9940.204783617293;10873.619423320224;1380.5030189131905;1417.688108616103;1418.9077709948924;1426.3937826423728;1449.4622802492174;63874.68062659657;66363.33636663668;67212;67799.66100169517;69348.3065169347;9546.140847323773;9654.131128198496;9669.854952175723;9893.307468477282;9920.603175873028;12862.292573908524;12918.966482681362;12921.28932908699;12927.353632318534;12952.417141228667;6584.9012264816065;7010.123734533184;7081.185663648644;7151.392131668762;7158.498905076699;6690.933090669128;6723.63020033893;6860.485463590251;6871.828204294932;6905.861882762417;4095.28332541804;4107.199096176277;4157.3140431829015;4225.302825033897;4300.569943005675;1761.1898526677614;1772.9822701773076;1785.7678501794683;1835.3667984545311;1850.4726153046317;792.4136139257024;824.3652387661467;878.2447095497866;882.3999680217386;887.4276091920675;16229.756553651705;16545.586360341087;16882.831171688373;17208.483745487654;17529.82470175282;860.2945584620551;861.9913800862037;883.7083762358407;910.4446287764458;916.8899732032199;9395.90604093964;9556.808863822685;9647.758806029766;9699.418034917928;9701.563429645541;364814;366677;369540;369885;372059.9779007722;73785;74179.62910185415;75135.24864751392;76503.61748191224;78699.60650196712;864.1574464896801;891.0421297105637;891.0599317719867;893.2630579771585;899.5052721003552;14162.504312349018;14958.626034349229;14960.102393856403;15171.620709482351;15601.687966240384;35354.29291414209;35994.64005359913;36774.63225367712;36984.815075924445;37724.43413348857;48897.75551122222;49276.75361623169;49326.75336623294;49434.505654942994;49613.75193124011;6970.268121847336;6984.092068031327;7060.964695176492;7101.360877521048;7103;10196.745081372728;10515.631952881613;10728.73178170552;10929.672109836718;10962.616308429167;9290.396124251902;9429;9452.905470945203;9829.705108846745;10093.687820583276;9266.258699303904;9362.531873406439;9494.28792840526;9499.335046546676;9757.170640495637;9287.907120928705;9682.612695492384;9792;9800.411975281506;10086;6626.210923050653;6841.623710695761;6896.241413444417;7026.367626913602;7241.4206863451855;9440.527973601429;9444.181940265156;9502.952485237529;9718.173955213886;9839.311248212556 16:21:05 INFO - PROCESS | 3461 | |3;mootools.html;1323.6360000999728;1342.2483409290799;1385.501219560958;1575.5829211168716;1598.7282162032454;5583.994880921433;5791.391903850098;5956.821295361141;6341.746330146794;6349.301576826551;5873.559483038768;6090.421409966058;6096.573239873211;6205.596636218654;6209.379062093788;1699.2183595546032;1714.682783685016;1721.0190191590798;1726.4820553833863;1732.3417101501411;1713.8200488948605;1733.8989741514167;1739.3477445957765;1744.127936031984;1766.2846547148426;1665.092524574104;1684.376780591183;1684.7220208665556;1689.763433119358;1691.365737848307;1605.4461210882228;1616.3211451190527;1661.983380166195;1703.778508793849;1711.084569755175;1713.3318005977678;1733.566608347913;1736.3401907275154;1737.7567140600327;1740.6344667619815;6149.046897730859;6278.654673992928;6280.528960327993;6281.87436251277;6284.24589049317;4030.0932290234464;4148.896277593054;4150.543440221573;4161.459010328668;4163.646090082347;2466.90132394704;2758.7103354147926;2759.6826364968083;2762.3646561290816;2774.8057635965492;721.8664547058811;766.4175226827596;773.4585789947004;783.3537331701369;789.2344425906919;8476.27951624119;8572.528510931896;8587.398882078258;8593.097724738938;8620.525871077089;3661.8718344857803;3664.9633503664622;3744.6629803317833;3867.8839634811;3869.555001174901;7468.925310746931;7531.246875312425;7539.170691223961;7542.057242844645;7606.391488681003;4136.751794892256;4154.626083652486;4161.56303588125;4167.624913757716;4169.145325208325;3366.444536651474;3813.313603551332;3813.694904407641;3814.1608846053823;3835.6164383561977;2874.2239595309147;3276.164578032634;3285.1458620758776;3299.4555898276517;3300.85146168423;1052.4632437456953;1088.1077516436446;1088.2491081153978;1091.8635170603675;1100.1803656276124;583.9854003649858;667.679513833353;674.5547938360756;677.1197443323659;678.2064983968768;4350.108227813291;4402.669799765031;4557.453105627346;4574.611158051603;4621.890746220883;350.40606172537815;375.86488803812335;379.2907263417427;380.6498021819932;382.7722505109455;3035.210845180269;3085.4291955988215;3098.7366073883522;3150.9054728358187;3245.545623612696;7669.654865531064;7798.649060792278;7988.121306656263;7993.480423772437;7996;7977.3618110551015;7979.521228726295;8033.558154301452;8035.357171426272;8036.517808931483;5884.617499862496;6049.818505444844;6069.089636554464;6071.453569178795;6075.392460753889;4466.754328511963;4614.792334345029;4650.232711602683;4691.835785747482;4719.622430205644;7253.746118886025;7270.127584689871;7292.817679558054;7354.227806080285;7359.153697324662;7244.782656520313;7370.889436658347;7430.888536672062;7472.813179670552;7515;5594.1608758686525;5672.376038635829;5742.971285143548;5789.8552536186935;5808.709564521672;5537.612367134262;5710.057840456278;6151.569390142826;6348.269948955744;6353.523485738496;5546;5745.712714364348;5790.073588226032;5790.334111577054;5825.446582574648;5529.751161197675;5596.272484576979;5598.10430331145;5621;5648.15277708347;5183.663061900965;5233.293505376725;5283.260343551829;5292.9470705294;5322.228276899906;3972.304846651882;3999.1601763629965;4035.8991025224605;4090.484352123482;4151.647109995684;4090.1001779608437;4109.732867363612;4122.690798190088;4250.978745106255;4274.487061552633 16:21:05 INFO - PROCESS | 3461 | |4;prototype.html;275.7146353524103;276.83528300661106;277.52820205650386;278.6725597423029;282.30130427192694;4571.200039992997;4863.473981363519;4929.728864912428;4950.504949505048;4958.157113290745;4834.951650483494;4851.908320627866;4867.561919427251;4878.999805039967;4885.4381746099125;3797.3354662934016;3805.600411956746;3807.4859893914245;3810.5236845394325;3811.3330167220765;3673.797941113238;3818.560865500461;3833.195029043904;3846.423036544513;3850.4801851749935;3752;3777.9811100944457;3783.751362050517;3788.545374555057;3792.886213413602;3747.718921080916;3761.54861416629;3793;3795.438079296464;3798.5441746990264;3154.984225078883;3256.615938226268;3261.3966416213075;3348.782329148622;3357.748168887343;4741.454732705749;4752.738599377033;4758.643101767381;4759.953220115349;4778.976105119452;4213.726107803013;4220.388043733672;4240.872773816791;4254.127903779718;4261.914761704748;4883.754642566123;5038.420581633086;5041.470645582198;5053.9241911371355;5059.848204553869;3549.1304630365466;3551.8224088795714;3556.1287484566187;3567.6967457766123;3568.4825700273313;5286.418493965661;5294.894102117936;5304.2839216706025;5317.867053323659;5326.813561525328;3638.526991491089;3638.7816730995696;3639.2721455708966;3644.1618427761764;3650.142216579155;3530.223350862806;3645.635436456333;3674.632536746304;3679.4296883983025;3682.705383569308;4204.600562946515;4207.810648520824;4211.305134652809;4216.984855828097;4218.34615634571;5050.974745126251;5055.34280543527;5065.518775716301;5071.290019397287;5073.239014147834;1149.6780901347636;1154.163231657042;1178.5344788808545;1201.165190192825;1235.7775600392015;810.3962547901851;817.7896712864874;830.8670612701939;833.69942889092;838.5765188579728;4281.272183728774;4282.35764635301;4294.475461211225;4296.613304802583;4313.719608225455;4929.457759646436;4987.426445958761;5012.122878496321;5016.924746128811;5052.7726252318735;4310.827566897289;4313.352997050468;4315.3742707307265;4322.978385108117;4324.437823082979;2554.9744502554736;2696.36635390683;2706.9458610827674;2715.3890374665543;2730.8224965377185;4755.548222918817;4760.619150467955;4761.785719642625;4770.546798054249;4778.856634300976;5191.273221748958;5202.24567437727;5208.635395522353;5223.242629818655;5244.790208391698;4545.636229190375;4697.671163018625;4751.976240118777;4765.356676848651;4769.42766867978;5136.563392111712;5137.17805151174;5137.768800404066;5144.225242291403;5180.471760830639;4992.650514463952;5004.424491183415;5013.24801279811;5023.598112151092;5026;4661.696989695659;4906.435759887659;4930.556249937523;4943.431505376928;4943.480934501826;3618.2763447310117;3644.3986742188304;3662.7252956027874;3665.6151104133683;3669.6146904574634;5314.681119132864;5336.919946200733;5337.786488540415;5358.356997160366;5359.169328754049;4814.398200224972;4846.612271018381;5011.248312753116;5040.672356296829;5041.8487445376695;5003.299538064746;5016.187697350113;5016.949830501794;5030.5975521957425;5045.646804723634;4873.658843880894;4972.041635227034;5009.824656137018;5016.698998060128;5022.949770502394;5051.747412629427;5090.847274581768;5091.287219789158;5098.439171691037;5100.719460429712;4976.825811096594;4977.925331119964;5002.2496625506465;5009.874753131201;5024.949750502448 16:21:05 INFO - PROCESS | 3461 | |5;yui.html;583.4259406254961;606.4814583531078;606.6754286456746;651.8761435327287;661.1801366305782;10576.78846423071;11217.383043932581;11423.371714555706;11453.255538389998;11543.711407214823;10557.577696892115;10747.301425407342;10775.461226938642;10782.514786834592;10846.566137354497;730.03635201534;743.7954562495303;747.2452822649109;747.9887801682979;748.3713680508372;695.6000299827595;720.4380583145129;723.4646361692362;725.1841678112124;733.2520828754667;784.4665627373412;789.0807209600837;789.0886026639241;789.8183417813906;789.9368050555942;784.945053846231;785.8899754034439;785.9096203936534;786.0920636664662;786.8229648329109;580.6690186593644;581.2792137749203;582.2925145947652;582.4932308891249;583.7548229743518;9790.608375664964;9884.703458896245;9903.603855845757;9905.20758339331;9911;8304.086550479442;8366.247037766569;8846.690365837165;8919.331050171264;9413;7375.11498620169;7448.515846470016;7541.962290188569;7728.961355193188;7897.8025549361155;2438.7805097541304;2445.217530390276;2455.398427385302;2484.428581426264;2507.6489291499206;46008.53991460076;48215.75892120552;48409.547713568296;48471.51528484705;49609;6043;6241.937580624136;6507.609543427409;6524.641144737085;6605.768798092044;13472.393742281425;13542.526011589547;13641.795373069412;13644.93177534106;13741.175529468264;6289.7484100635465;6417.743290268337;6446.258680251737;6471.579347342407;6485.902711459332;3578.051816268691;3583.6774690278;3603.4955106285142;3665.3035923175044;3680.7803015615;2458.4591389894194;2530.253575195285;2533.518631460017;2535.429528356142;2541.885615147323;437.4182337491129;441.34239982425953;450.38297532380847;450.4189595421869;451.4492319370363;483.8645179349788;485.2938973793122;516.770037333383;518.271828081546;523.1185452512452;6064.818055458255;6492.285848556655;6522.836929076811;6774.8645027100165;6796.320367963263;460.16709755342936;474.962003039756;490.73009844585334;498.1083859890827;511.66741617948634;2999.9850000749857;3096.380723855238;3183.633882103588;3187.442197615408;3319.618243901982;41549.376759348634;41898.37152442716;69482.65258673775;69516.65241673759;72149.63925180446;38856.41715374272;47395;56267.15599266014;61996;62332.376676233565;55634.72182639061;56965.14552281636;58167;59106.70446647825;59601.70199148977;5954.851128721816;6086.239220097488;6088.269407671108;6232.626042437469;6375.234971803413;26682.733172668803;33332.666673332955;33631.15922101967;33722.3255534883;36729.44905826468;32483.837580811945;33422;43453;45001.54998449974;48379.75810120927;7794.22057794216;8603.225709686158;8731.432456890281;8784.912150878665;8797.560121993747;9857.309988301036;10032;10059;10626.203034772268;10725.249232553646;8262.17378262169;8433.578321083798;8567.485950842969;9187.632494700138;9301.209397201314;8985.910140898768;9048.502332371783;9113.863292050492;9389.248860091313;9434.764130896783;8127.715529956423;8181.386396020203;8351.540665263468;8552.828943420973;8895;7561.4706970513735;7710.306072453506;7894.500941244279;7905.130435652189;8034.718784842503;7773.844523109619;7804.8829267559895;7860.606969651609;7884.526928384315;7979.84040319202 16:21:05 INFO - PROCESS | 3461 | __end_tp_report 16:21:05 INFO - PROCESS | 3461 | __start_cc_report 16:21:05 INFO - PROCESS | 3461 | _x_x_mozilla_cycle_collect,353 16:21:05 INFO - PROCESS | 3461 | __end_cc_report 16:21:05 INFO - PROCESS | 3461 | __startTimestamp1479428465275__endTimestamp 16:21:05 INFO - PROCESS | 3461 | 16:21:05 INFO - PROCESS | 3461 | ------- Summary: start ------- 16:21:05 INFO - PROCESS | 3461 | Number of tests: 6 16:21:05 INFO - PROCESS | 3461 | 16:21:05 INFO - PROCESS | 3461 | [#0] dojo.html Cycles:165 Average:4492.39 Median:4604.19 stddev:459.14 (10.0%) stddev-sans-first:434.17 16:21:05 INFO - PROCESS | 3461 | Values: 2537.0 2556.2 2560.8 2564.0 2582.5 4494.6 4578.5 4588.4 4598.0 4621.4 4526.5 4527.2 4540.0 4597.5 4604.2 4158.4 4198.3 4264.8 4298.6 4322.8 4183.4 4247.6 4278.1 4285.7 4315.5 4055.4 4079.7 4268.2 4272.7 4335.6 4112.7 4120.2 4123.0 4123.3 4135.6 4135.3 4138.6 4184.5 4198.1 4245.9 4515.0 4557.1 4567.3 4582.2 4605.4 4834.5 4854.4 4861.3 4866.2 4883.3 4776.7 4823.4 4827.3 4828.7 4839.5 4588.3 4590.7 4602.5 4633.1 4633.3 4953.7 4966.1 4966.7 4971.0 5017.2 4636.8 4690.7 4698.1 4698.2 4784.9 4815.3 4817.2 4830.4 4833.0 4857.1 4810.1 4840.9 4848.1 4878.5 4891.0 4816.2 4824.0 4827.2 4834.3 4859.7 3961.8 3994.2 4081.6 4133.9 4154.7 3617.5 3630.4 3662.8 3666.2 3675.3 4198.2 4216.6 4223.6 4225.7 4267.3 4741.7 4744.9 4903.1 4930.6 4978.4 4151.2 4158.5 4172.9 4180.6 4188.4 4412.3 4427.2 4435.8 4436.9 4479.4 4561.5 4583.7 4596.9 4600.9 4634.2 4764.7 4782.2 4784.2 4833.4 4923.8 4498.8 4501.5 4530.9 4545.5 4546.7 4738.8 4767.4 4785.6 4816.7 4843.7 4872.5 4874.8 4880.6 4883.6 4926.5 4539.6 4682.4 4683.5 4730.5 4797.8 4642.1 4706.9 4715.5 4716.8 4719.4 4570.1 4603.6 4655.3 4663.4 4711.0 4748.5 4758.1 4764.6 4779.4 4818.6 4649.2 4655.0 4659.8 4661.4 4685.7 16:21:05 INFO - PROCESS | 3461 | 16:21:05 INFO - PROCESS | 3461 | [#1] ext.html Cycles:180 Average:41987.31 Median:16901.82 stddev:77082.20 (456.1%) stddev-sans-first:77235.60 16:21:05 INFO - PROCESS | 3461 | Values: 535.4 545.1 557.4 558.8 564.1 26485.9 27736.6 27914.9 30315.8 30350.2 27149.0 27406.2 27440.0 27463.7 27540.9 5316.3 5444.9 5453.6 5467.3 5468.2 5625.1 5696.3 5699.1 5699.9 5710.8 5700.8 5729.3 5735.8 5738.1 5739.7 5656.0 5675.7 5703.1 5708.7 5712.0 5490.4 5546.8 5552.3 5558.4 5565.1 25256.9 25514.7 25530.4 25552.6 25559.2 2888.2 2919.4 2921.2 3087.9 3235.4 17847.3 18122.2 18173.5 19317.4 19464.5 2629.0 2652.2 2662.4 2677.8 2679.3 229840.0 232778.0 232908.0 233015.0 233223.0 46885.3 47229.3 47250.0 47313.0 47377.8 55344.4 55363.2 55542.7 55564.0 55594.2 13797.3 13974.7 14009.4 14043.5 14047.6 10335.8 10400.4 10405.4 10434.1 10476.3 16656.5 17269.7 17281.7 17304.0 17346.3 6472.6 6510.9 6565.2 6725.9 6815.9 762.6 885.8 893.5 929.9 950.3 26937.6 27260.7 27329.6 27367.6 27695.6 930.7 943.5 964.8 970.4 1015.9 13234.0 13969.0 14083.9 14236.2 14321.2 329958.0 331363.0 332181.0 332920.0 333620.0 42133.0 42743.0 42799.8 42824.8 42901.8 1156.8 1160.6 1168.0 1179.7 1200.5 24214.1 25156.6 26220.6 26317.6 26541.9 40301.0 40919.4 40964.8 41009.2 41258.0 300759.0 302481.0 303860.0 304258.0 305340.0 22353.8 22704.0 23092.5 23420.9 23586.9 35918.8 36359.8 36519.8 36691.0 36875.8 31084.5 31153.8 31360.8 31374.7 32214.9 30715.7 30995.5 31024.8 31447.0 32278.7 30623.7 30934.4 31170.5 31174.5 31726.0 26732.5 28802.9 29174.3 29178.3 29487.8 22706.3 22884.9 23116.2 23149.7 23335.8 16:21:05 INFO - PROCESS | 3461 | 16:21:05 INFO - PROCESS | 3461 | [#2] jquery.html Cycles:180 Average:22691.25 Median:4165.66 stddev:61069.89 (1466.0%) stddev-sans-first:61218.14 16:21:05 INFO - PROCESS | 3461 | Values: 334.9 353.8 355.6 359.1 381.5 11228.9 11474.9 12213.0 12357.8 12359.4 13622.1 13745.7 13815.1 13902.9 14358.8 3970.9 4226.1 4230.1 4232.2 4234.6 3959.9 4033.6 4114.3 4160.4 4167.5 4113.1 4132.6 4135.3 4156.1 4161.3 3863.2 4125.6 4129.5 4140.6 4163.8 3735.5 3804.1 3828.1 3830.5 3832.3 10319.7 10385.2 10392.4 11075.9 15871.8 1848.8 1862.0 1904.6 1907.1 1920.5 7572.5 7869.8 8143.3 9940.2 10873.6 1380.5 1417.7 1418.9 1426.4 1449.5 63874.7 66363.3 67212.0 67799.7 69348.3 9546.1 9654.1 9669.9 9893.3 9920.6 12862.3 12919.0 12921.3 12927.4 12952.4 6584.9 7010.1 7081.2 7151.4 7158.5 6690.9 6723.6 6860.5 6871.8 6905.9 4095.3 4107.2 4157.3 4225.3 4300.6 1761.2 1773.0 1785.8 1835.4 1850.5 792.4 824.4 878.2 882.4 887.4 16229.8 16545.6 16882.8 17208.5 17529.8 860.3 862.0 883.7 910.4 916.9 9395.9 9556.8 9647.8 9699.4 9701.6 364814.0 366677.0 369540.0 369885.0 372060.0 73785.0 74179.6 75135.2 76503.6 78699.6 864.2 891.0 891.1 893.3 899.5 14162.5 14958.6 14960.1 15171.6 15601.7 35354.3 35994.6 36774.6 36984.8 37724.4 48897.8 49276.8 49326.8 49434.5 49613.8 6970.3 6984.1 7061.0 7101.4 7103.0 10196.7 10515.6 10728.7 10929.7 10962.6 9290.4 9429.0 9452.9 9829.7 10093.7 9266.3 9362.5 9494.3 9499.3 9757.2 9287.9 9682.6 9792.0 9800.4 10086.0 6626.2 6841.6 6896.2 7026.4 7241.4 9440.5 9444.2 9503.0 9718.2 9839.3 16:21:05 INFO - PROCESS | 3461 | 16:21:05 INFO - PROCESS | 3461 | [#3] mootools.html Cycles:180 Average:4290.92 Median:4618.34 stddev:2342.29 (50.7%) stddev-sans-first:2338.24 16:21:05 INFO - PROCESS | 3461 | Values: 1323.6 1342.2 1385.5 1575.6 1598.7 5584.0 5791.4 5956.8 6341.7 6349.3 5873.6 6090.4 6096.6 6205.6 6209.4 1699.2 1714.7 1721.0 1726.5 1732.3 1713.8 1733.9 1739.3 1744.1 1766.3 1665.1 1684.4 1684.7 1689.8 1691.4 1605.4 1616.3 1662.0 1703.8 1711.1 1713.3 1733.6 1736.3 1737.8 1740.6 6149.0 6278.7 6280.5 6281.9 6284.2 4030.1 4148.9 4150.5 4161.5 4163.6 2466.9 2758.7 2759.7 2762.4 2774.8 721.9 766.4 773.5 783.4 789.2 8476.3 8572.5 8587.4 8593.1 8620.5 3661.9 3665.0 3744.7 3867.9 3869.6 7468.9 7531.2 7539.2 7542.1 7606.4 4136.8 4154.6 4161.6 4167.6 4169.1 3366.4 3813.3 3813.7 3814.2 3835.6 2874.2 3276.2 3285.1 3299.5 3300.9 1052.5 1088.1 1088.2 1091.9 1100.2 584.0 667.7 674.6 677.1 678.2 4350.1 4402.7 4557.5 4574.6 4621.9 350.4 375.9 379.3 380.6 382.8 3035.2 3085.4 3098.7 3150.9 3245.5 7669.7 7798.6 7988.1 7993.5 7996.0 7977.4 7979.5 8033.6 8035.4 8036.5 5884.6 6049.8 6069.1 6071.5 6075.4 4466.8 4614.8 4650.2 4691.8 4719.6 7253.7 7270.1 7292.8 7354.2 7359.2 7244.8 7370.9 7430.9 7472.8 7515.0 5594.2 5672.4 5743.0 5789.9 5808.7 5537.6 5710.1 6151.6 6348.3 6353.5 5546.0 5745.7 5790.1 5790.3 5825.4 5529.8 5596.3 5598.1 5621.0 5648.2 5183.7 5233.3 5283.3 5292.9 5322.2 3972.3 3999.2 4035.9 4090.5 4151.6 4090.1 4109.7 4122.7 4251.0 4274.5 16:21:05 INFO - PROCESS | 3461 | 16:21:05 INFO - PROCESS | 3461 | [#4] prototype.html Cycles:180 Average:4164.81 Median:4761.20 stddev:1225.07 (25.7%) stddev-sans-first:1193.22 16:21:05 INFO - PROCESS | 3461 | Values: 275.7 276.8 277.5 278.7 282.3 4571.2 4863.5 4929.7 4950.5 4958.2 4835.0 4851.9 4867.6 4879.0 4885.4 3797.3 3805.6 3807.5 3810.5 3811.3 3673.8 3818.6 3833.2 3846.4 3850.5 3752.0 3778.0 3783.8 3788.5 3792.9 3747.7 3761.5 3793.0 3795.4 3798.5 3155.0 3256.6 3261.4 3348.8 3357.7 4741.5 4752.7 4758.6 4760.0 4779.0 4213.7 4220.4 4240.9 4254.1 4261.9 4883.8 5038.4 5041.5 5053.9 5059.8 3549.1 3551.8 3556.1 3567.7 3568.5 5286.4 5294.9 5304.3 5317.9 5326.8 3638.5 3638.8 3639.3 3644.2 3650.1 3530.2 3645.6 3674.6 3679.4 3682.7 4204.6 4207.8 4211.3 4217.0 4218.3 5051.0 5055.3 5065.5 5071.3 5073.2 1149.7 1154.2 1178.5 1201.2 1235.8 810.4 817.8 830.9 833.7 838.6 4281.3 4282.4 4294.5 4296.6 4313.7 4929.5 4987.4 5012.1 5016.9 5052.8 4310.8 4313.4 4315.4 4323.0 4324.4 2555.0 2696.4 2706.9 2715.4 2730.8 4755.5 4760.6 4761.8 4770.5 4778.9 5191.3 5202.2 5208.6 5223.2 5244.8 4545.6 4697.7 4752.0 4765.4 4769.4 5136.6 5137.2 5137.8 5144.2 5180.5 4992.7 5004.4 5013.2 5023.6 5026.0 4661.7 4906.4 4930.6 4943.4 4943.5 3618.3 3644.4 3662.7 3665.6 3669.6 5314.7 5336.9 5337.8 5358.4 5359.2 4814.4 4846.6 5011.2 5040.7 5041.8 5003.3 5016.2 5016.9 5030.6 5045.6 4873.7 4972.0 5009.8 5016.7 5022.9 5051.7 5090.8 5091.3 5098.4 5100.7 4976.8 4977.9 5002.2 5009.9 5024.9 16:21:05 INFO - PROCESS | 3461 | 16:21:05 INFO - PROCESS | 3461 | [#5] yui.html Cycles:180 Average:12703.24 Median:6087.25 stddev:17233.13 (283.1%) stddev-sans-first:17257.44 16:21:05 INFO - PROCESS | 3461 | Values: 583.4 606.5 606.7 651.9 661.2 10576.8 11217.4 11423.4 11453.3 11543.7 10557.6 10747.3 10775.5 10782.5 10846.6 730.0 743.8 747.2 748.0 748.4 695.6 720.4 723.5 725.2 733.3 784.5 789.1 789.1 789.8 789.9 784.9 785.9 785.9 786.1 786.8 580.7 581.3 582.3 582.5 583.8 9790.6 9884.7 9903.6 9905.2 9911.0 8304.1 8366.2 8846.7 8919.3 9413.0 7375.1 7448.5 7542.0 7729.0 7897.8 2438.8 2445.2 2455.4 2484.4 2507.6 46008.5 48215.8 48409.5 48471.5 49609.0 6043.0 6241.9 6507.6 6524.6 6605.8 13472.4 13542.5 13641.8 13644.9 13741.2 6289.7 6417.7 6446.3 6471.6 6485.9 3578.1 3583.7 3603.5 3665.3 3680.8 2458.5 2530.3 2533.5 2535.4 2541.9 437.4 441.3 450.4 450.4 451.4 483.9 485.3 516.8 518.3 523.1 6064.8 6492.3 6522.8 6774.9 6796.3 460.2 475.0 490.7 498.1 511.7 3000.0 3096.4 3183.6 3187.4 3319.6 41549.4 41898.4 69482.7 69516.7 72149.6 38856.4 47395.0 56267.2 61996.0 62332.4 55634.7 56965.1 58167.0 59106.7 59601.7 5954.9 6086.2 6088.3 6232.6 6375.2 26682.7 33332.7 33631.2 33722.3 36729.4 32483.8 33422.0 43453.0 45001.5 48379.8 7794.2 8603.2 8731.4 8784.9 8797.6 9857.3 10032.0 10059.0 10626.2 10725.2 8262.2 8433.6 8567.5 9187.6 9301.2 8985.9 9048.5 9113.9 9389.2 9434.8 8127.7 8181.4 8351.5 8552.8 8895.0 7561.5 7710.3 7894.5 7905.1 8034.7 7773.8 7804.9 7860.6 7884.5 7979.8 16:21:05 INFO - PROCESS | 3461 | -------- Summary: end -------- 16:21:05 INFO - PROCESS | 3461 | 16:21:06 INFO - TEST-INFO | 3461: exit 0 16:21:06 INFO - TEST-OK | dromaeo_css | took 1123031ms 16:21:06 INFO - TEST-START | kraken 16:21:06 INFO - operating with platform_type : linux_ 16:21:06 INFO - Initialising browser for kraken test... 16:21:06 INFO - TEST-INFO | started process 3822 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7Shfzq/profile http://localhost:45412/getInfo.html) 16:21:11 INFO - PROCESS | 3822 | __metrics Screen width/height:1600/1200 16:21:11 INFO - PROCESS | 3822 | colorDepth:24 16:21:11 INFO - PROCESS | 3822 | Browser inner width/height: 1024/697 16:21:11 INFO - PROCESS | 3822 | __metrics 16:21:11 ERROR - PROCESS | 3822 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined 16:21:12 INFO - TEST-INFO | 3822: exit 0 16:21:12 INFO - Browser initialized. 16:21:12 INFO - Running cycle 1/1 for kraken test... 16:21:12 INFO - TEST-INFO | started process 3944 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7Shfzq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:21:24 INFO - PROCESS | 3944 | RSS: Main: 187662336 16:21:24 INFO - PROCESS | 3944 | 16:21:27 INFO - PROCESS | 3944 | Cycle 1(1): loaded http://localhost:45412/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45412/tests/kraken/driver.html?testName=audio-beat-detection) 16:21:28 INFO - PROCESS | 3944 | RSS: Main: 200126464 16:21:28 INFO - PROCESS | 3944 | 16:21:31 INFO - PROCESS | 3944 | Cycle 1(1): loaded http://localhost:45412/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45412/tests/kraken/driver.html?testName=audio-dft) 16:21:32 INFO - PROCESS | 3944 | RSS: Main: 197869568 16:21:32 INFO - PROCESS | 3944 | 16:21:35 INFO - PROCESS | 3944 | Cycle 1(1): loaded http://localhost:45412/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45412/tests/kraken/driver.html?testName=audio-fft) 16:21:35 INFO - PROCESS | 3944 | RSS: Main: 194408448 16:21:35 INFO - PROCESS | 3944 | 16:21:38 INFO - PROCESS | 3944 | Cycle 1(1): loaded http://localhost:45412/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45412/tests/kraken/driver.html?testName=audio-oscillator) 16:21:38 INFO - PROCESS | 3944 | RSS: Main: 195227648 16:21:38 INFO - PROCESS | 3944 | 16:21:40 INFO - PROCESS | 3944 | Cycle 1(1): loaded http://localhost:45412/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45412/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:21:41 INFO - PROCESS | 3944 | RSS: Main: 195227648 16:21:41 INFO - PROCESS | 3944 | 16:21:44 INFO - PROCESS | 3944 | Cycle 1(1): loaded http://localhost:45412/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45412/tests/kraken/driver.html?testName=imaging-darkroom) 16:21:45 INFO - PROCESS | 3944 | RSS: Main: 201342976 16:21:45 INFO - PROCESS | 3944 | 16:21:48 INFO - PROCESS | 3944 | Cycle 1(1): loaded http://localhost:45412/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45412/tests/kraken/driver.html?testName=imaging-desaturate) 16:21:49 INFO - PROCESS | 3944 | RSS: Main: 197095424 16:21:49 INFO - PROCESS | 3944 | 16:21:52 INFO - PROCESS | 3944 | Cycle 1(1): loaded http://localhost:45412/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45412/tests/kraken/driver.html?testName=json-parse-financial) 16:21:52 INFO - PROCESS | 3944 | RSS: Main: 198590464 16:21:52 INFO - PROCESS | 3944 | 16:21:54 INFO - PROCESS | 3944 | Cycle 1(1): loaded http://localhost:45412/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45412/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:21:55 INFO - PROCESS | 3944 | RSS: Main: 198414336 16:21:55 INFO - PROCESS | 3944 | 16:21:57 INFO - PROCESS | 3944 | Cycle 1(1): loaded http://localhost:45412/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45412/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:21:57 INFO - PROCESS | 3944 | RSS: Main: 198619136 16:21:57 INFO - PROCESS | 3944 | 16:22:00 INFO - PROCESS | 3944 | Cycle 1(1): loaded http://localhost:45412/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45412/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:22:00 INFO - PROCESS | 3944 | RSS: Main: 198496256 16:22:00 INFO - PROCESS | 3944 | 16:22:03 INFO - PROCESS | 3944 | Cycle 1(1): loaded http://localhost:45412/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45412/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:22:04 INFO - PROCESS | 3944 | RSS: Main: 198524928 16:22:04 INFO - PROCESS | 3944 | 16:22:07 INFO - PROCESS | 3944 | Cycle 1(1): loaded http://localhost:45412/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45412/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:22:08 INFO - PROCESS | 3944 | RSS: Main: 203018240 16:22:08 INFO - PROCESS | 3944 | 16:22:09 INFO - PROCESS | 3944 | Cycle 1(1): loaded http://localhost:45412/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45412/tests/kraken/driver.html?testName=ai-astar) 16:22:10 INFO - PROCESS | 3944 | RSS: Main: 204521472 16:22:10 INFO - PROCESS | 3944 | 16:22:10 INFO - PROCESS | 3944 | __start_tp_report 16:22:10 INFO - PROCESS | 3944 | _x_x_mozilla_page_load 16:22:10 INFO - PROCESS | 3944 | _x_x_mozilla_page_load_details 16:22:10 INFO - PROCESS | 3944 | |i|pagename|runs| 16:22:10 INFO - PROCESS | 3944 | |0;ai-astar;109;117;118;118;117;118;117;117;117;117 16:22:10 INFO - PROCESS | 3944 | |1;audio-beat-detection;153;136;133;178;135;131;132;135;166;133 16:22:10 INFO - PROCESS | 3944 | |2;audio-dft;166;176;163;162;165;164;162;161;161;164 16:22:10 INFO - PROCESS | 3944 | |3;audio-fft;76;75;77;107;77;77;77;76;99;77 16:22:10 INFO - PROCESS | 3944 | |4;audio-oscillator;85;83;125;82;84;83;103;85;83;107 16:22:10 INFO - PROCESS | 3944 | |5;imaging-gaussian-blur;118;118;118;122;118;119;118;118;118;118 16:22:10 INFO - PROCESS | 3944 | |6;imaging-darkroom;149;148;147;148;147;146;148;148;149;150 16:22:10 INFO - PROCESS | 3944 | |7;imaging-desaturate;96;96;96;95;96;96;96;97;97;96 16:22:10 INFO - PROCESS | 3944 | |8;json-parse-financial;63;64;64;64;64;65;65;66;64;64 16:22:10 INFO - PROCESS | 3944 | |9;json-stringify-tinderbox;68;68;68;68;67;67;66;66;68;69 16:22:10 INFO - PROCESS | 3944 | |10;stanford-crypto-aes;85;85;90;86;89;85;84;85;84;84 16:22:10 INFO - PROCESS | 3944 | |11;stanford-crypto-ccm;150;147;144;158;155;146;141;154;189;167 16:22:10 INFO - PROCESS | 3944 | |12;stanford-crypto-pbkdf2;186;188;184;192;185;178;177;178;182;184 16:22:10 INFO - PROCESS | 3944 | |13;stanford-crypto-sha256-iterative;70;70;70;70;73;70;72;68;79;68 16:22:10 INFO - PROCESS | 3944 | __end_tp_report 16:22:10 INFO - PROCESS | 3944 | __start_cc_report 16:22:10 INFO - PROCESS | 3944 | _x_x_mozilla_cycle_collect,881 16:22:10 INFO - PROCESS | 3944 | __end_cc_report 16:22:10 INFO - PROCESS | 3944 | __startTimestamp1479428530063__endTimestamp 16:22:10 INFO - PROCESS | 3944 | 16:22:10 INFO - PROCESS | 3944 | ------- Summary: start ------- 16:22:10 INFO - PROCESS | 3944 | Number of tests: 14 16:22:10 INFO - PROCESS | 3944 | 16:22:10 INFO - PROCESS | 3944 | [#0] ai-astar Cycles:10 Average:116.50 Median:117.00 stddev:2.68 (2.3%) stddev-sans-first:0.50 16:22:10 INFO - PROCESS | 3944 | Values: 109.0 117.0 118.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 16:22:10 INFO - PROCESS | 3944 | 16:22:10 INFO - PROCESS | 3944 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:135.50 stddev:16.65 (12.3%) stddev-sans-first:17.28 16:22:10 INFO - PROCESS | 3944 | Values: 153.0 136.0 133.0 178.0 135.0 131.0 132.0 135.0 166.0 133.0 16:22:10 INFO - PROCESS | 3944 | 16:22:10 INFO - PROCESS | 3944 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:4.40 (2.7%) stddev-sans-first:4.63 16:22:10 INFO - PROCESS | 3944 | Values: 166.0 176.0 163.0 162.0 165.0 164.0 162.0 161.0 161.0 164.0 16:22:10 INFO - PROCESS | 3944 | 16:22:10 INFO - PROCESS | 3944 | [#3] audio-fft Cycles:10 Average:81.80 Median:77.00 stddev:11.35 (14.7%) stddev-sans-first:11.84 16:22:10 INFO - PROCESS | 3944 | Values: 76.0 75.0 77.0 107.0 77.0 77.0 77.0 76.0 99.0 77.0 16:22:10 INFO - PROCESS | 3944 | 16:22:10 INFO - PROCESS | 3944 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:83.00 stddev:14.68 (17.7%) stddev-sans-first:15.35 16:22:10 INFO - PROCESS | 3944 | Values: 85.0 83.0 125.0 82.0 84.0 83.0 103.0 85.0 83.0 107.0 16:22:10 INFO - PROCESS | 3944 | 16:22:10 INFO - PROCESS | 3944 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:118.00 stddev:1.27 (1.1%) stddev-sans-first:1.33 16:22:10 INFO - PROCESS | 3944 | Values: 118.0 118.0 118.0 122.0 118.0 119.0 118.0 118.0 118.0 118.0 16:22:10 INFO - PROCESS | 3944 | 16:22:10 INFO - PROCESS | 3944 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.15 (0.8%) stddev-sans-first:1.17 16:22:10 INFO - PROCESS | 3944 | Values: 149.0 148.0 147.0 148.0 147.0 146.0 148.0 148.0 149.0 150.0 16:22:10 INFO - PROCESS | 3944 | 16:22:10 INFO - PROCESS | 3944 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 16:22:10 INFO - PROCESS | 3944 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 96.0 97.0 97.0 96.0 16:22:10 INFO - PROCESS | 3944 | 16:22:10 INFO - PROCESS | 3944 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.73 16:22:10 INFO - PROCESS | 3944 | Values: 63.0 64.0 64.0 64.0 64.0 65.0 65.0 66.0 64.0 64.0 16:22:10 INFO - PROCESS | 3944 | 16:22:10 INFO - PROCESS | 3944 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:68.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 16:22:10 INFO - PROCESS | 3944 | Values: 68.0 68.0 68.0 68.0 67.0 67.0 66.0 66.0 68.0 69.0 16:22:10 INFO - PROCESS | 3944 | 16:22:10 INFO - PROCESS | 3944 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.00 stddev:2.11 (2.5%) stddev-sans-first:2.22 16:22:10 INFO - PROCESS | 3944 | Values: 85.0 85.0 90.0 86.0 89.0 85.0 84.0 85.0 84.0 84.0 16:22:10 INFO - PROCESS | 3944 | 16:22:10 INFO - PROCESS | 3944 | [#11] stanford-crypto-ccm Cycles:10 Average:155.10 Median:154.50 stddev:14.13 (9.1%) stddev-sans-first:14.87 16:22:10 INFO - PROCESS | 3944 | Values: 150.0 147.0 144.0 158.0 155.0 146.0 141.0 154.0 189.0 167.0 16:22:10 INFO - PROCESS | 3944 | 16:22:10 INFO - PROCESS | 3944 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.40 Median:184.50 stddev:4.79 (2.6%) stddev-sans-first:4.99 16:22:10 INFO - PROCESS | 3944 | Values: 186.0 188.0 184.0 192.0 185.0 178.0 177.0 178.0 182.0 184.0 16:22:10 INFO - PROCESS | 3944 | 16:22:10 INFO - PROCESS | 3944 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:70.00 stddev:3.20 (4.6%) stddev-sans-first:3.37 16:22:10 INFO - PROCESS | 3944 | Values: 70.0 70.0 70.0 70.0 73.0 70.0 72.0 68.0 79.0 68.0 16:22:10 INFO - PROCESS | 3944 | -------- Summary: end -------- 16:22:10 INFO - PROCESS | 3944 | 16:22:11 INFO - TEST-INFO | 3944: exit 0 16:22:11 INFO - TEST-OK | kraken | took 65014ms 16:22:11 INFO - SUITE-END | took 1188s 16:22:11 INFO - Completed test suite (00:19:48) 16:22:11 INFO - javascript benchmark 16:22:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 5680.27919355854, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2537.0486067724605, 2556.2459074573, 2560.847618571642, 2564.038485567912, 2582.470593528327, 4494.573015563525, 4578.496365399812, 4588.426446694163, 4597.977010114949, 4621.353010578513, 4526.524714904937, 4527.185106680796, 4539.954600453994, 4597.54024597541, 4604.194266003453, 4158.4178215049915, 4198.349255865331, 4264.829406823739, 4298.634616057623, 4322.805473753689, 4183.435236243114, 4247.5964783345535, 4278.144371125772, 4285.700000999931, 4315.4605674290715, 4055.3916912463073, 4079.73481723687, 4268.189044081614, 4272.743635381887, 4335.56644335567, 4112.670986321087, 4120.196561670476, 4122.958770412288, 4123.299039163349, 4135.5657655946, 4135.338345864678, 4138.565450627701, 4184.51878034027, 4198.118395137025, 4245.936310955338, 4514.954850451519, 4557.134144512532, 4567.2920697291975, 4582.221022426163, 4605.355250264965, 4834.540718631724, 4854.441739200002, 4861.295112208745, 4866.245731911524, 4883.291922671228, 4776.737279449629, 4823.445303790074, 4827.300041493963, 4828.686135401188, 4839.467658557556, 4588.274520147101, 4590.655700822452, 4602.493725690205, 4633.096546173498, 4633.2818413146015, 4953.702777833341, 4966.1309270877455, 4966.726830024311, 4970.950290497049, 5017.247412888023, 4636.83771068011, 4690.695104818176, 4698.060387922429, 4698.248280275208, 4784.856454306377, 4815.277708343777, 4817.181079216542, 4830.396200474941, 4832.975835120872, 4857.077155340474, 4810.11012962603, 4840.878978025577, 4848.127337079289, 4878.463369029404, 4891.021795640886, 4816.229403295456, 4824.0, 4827.155247831615, 4834.347363105936, 4859.708417494961, 3961.801909904493, 3994.241094192152, 4081.551029386765, 4133.937990930139, 4154.709170358046, 3617.5478065241846, 3630.3828349180703, 3662.7985460799378, 3666.1934374437583, 3675.320065787838, 4198.181354635817, 4216.64158546527, 4223.598758117974, 4225.746455212697, 4267.253230684618, 4741.66808323421, 4744.905101897943, 4903.092927808367, 4930.605551555867, 4978.352814134139, 4151.190517848991, 4158.459400277945, 4172.916541669149, 4180.623743863067, 4188.4136220929095, 4412.271975124133, 4427.22523558376, 4435.844745433894, 4436.889077773081, 4479.417675702138, 4561.521040290788, 4583.74789386587, 4596.862094137115, 4600.861974140781, 4634.212183928673, 4764.666473346832, 4782.163121453801, 4784.186688262934, 4833.371661683958, 4923.753812309442, 4498.775061246859, 4501.527339629291, 4530.88672783183, 4545.454545454434, 4546.74992875395, 4738.763061846825, 4767.356406885026, 4785.569298763128, 4816.686915350491, 4843.685160464559, 4872.512748725241, 4874.805007799649, 4880.585150262267, 4883.633727470525, 4926.531979461945, 4539.568740969603, 4682.367880336111, 4683.461401938821, 4730.47964723887, 4797.808087676453, 4642.094791515622, 4706.882327941828, 4715.504871988529, 4716.787744551435, 4719.3628860103445, 4570.063137056962, 4603.562661547147, 4655.255159174651, 4663.370444990019, 4711.034237981275, 4748.548887855648, 4758.095961767253, 4764.642651801199, 4779.354787103835, 4818.590419814215, 4649.163150632919, 4654.976725116353, 4659.767011649472, 4661.440627124767, 4685.718856868599], "value": 4463.752249930123, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.4404647143734, 545.1087471983308, 557.4369886414721, 558.7846434006041, 564.1087082409792, 26485.867570662143, 27736.583951240722, 27914.860425697843, 30315.84842075792, 30350.24124396891, 27149.0, 27406.177814665592, 27440.0, 27463.725362746365, 27540.862295688494, 5316.3354580677515, 5444.91832622511, 5453.618246722731, 5467.289252397202, 5468.152436372348, 5625.128105143689, 5696.344920334152, 5699.116636921284, 5699.886002279973, 5710.800121995731, 5700.800471983482, 5729.255196824407, 5735.827925162252, 5738.139279108125, 5739.713014349287, 5655.981923253813, 5675.659460432387, 5703.0589952657765, 5708.686022268795, 5712.028955077647, 5490.368607610136, 5546.750396232179, 5552.333719953591, 5558.416366281523, 5565.1374037024325, 25256.87371563149, 25514.744852551423, 25530.361740956625, 25552.616710749353, 25559.233223003153, 2888.2201805512605, 2919.357741296911, 2921.1528656689534, 3087.938241235163, 3235.4014507316224, 17847.286108555643, 18122.184501697455, 18173.546116310794, 19317.4204773857, 19464.513387165294, 2628.9605655915175, 2652.1910817200746, 2662.4142688608476, 2677.785777137844, 2679.2765953192725, 229840.0, 232778.0, 232908.0, 233015.0, 233223.0, 46885.29672054922, 47229.29156062662, 47250.0, 47313.0, 47377.76311118422, 55344.446555534734, 55363.16955245675, 55542.72228638831, 55564.0, 55594.16608750872, 13797.310134493235, 13974.650633734238, 14009.439622415193, 14043.50847720325, 14047.648808779657, 10335.793284134426, 10400.375977441226, 10405.427701476492, 10434.12185806547, 10476.266661333786, 16656.50030499087, 17269.740953885703, 17281.740773888403, 17304.0, 17346.3061477542, 6472.611643301417, 6510.934890651128, 6565.179352580927, 6725.899111513331, 6815.863682726417, 762.6377470701373, 885.8051228729669, 893.5219657483216, 929.8930622978309, 950.334765664038, 26937.595936060974, 27260.727392725817, 27329.590056149173, 27367.589486157725, 27695.584566231522, 930.7393929699695, 943.4763706143157, 964.7636329099415, 970.4274478057838, 1015.8984101589782, 13233.978539764385, 13969.0, 14083.929580352238, 14236.217008064448, 14321.212333321559, 329958.0, 331363.0, 332181.0, 332920.0, 333620.0, 42133.0, 42743.0, 42799.7860010698, 42824.78587607042, 42901.785491072966, 1156.780211759763, 1160.6111952496008, 1167.988320116788, 1179.687382843547, 1200.543793358518, 24214.129476185855, 25156.61638609894, 26220.60669089927, 26317.605235921095, 26541.867290663424, 40301.0, 40919.38620920629, 40964.79517602393, 41009.1798164041, 41258.0, 300759.0, 302481.0, 303860.0, 304258.0, 305340.0, 22353.776462235168, 22704.0, 23092.538149237258, 23420.88289558541, 23586.88206558956, 35918.8204058978, 36359.81820090883, 36519.81740091283, 36691.0, 36875.81562092173, 31084.533731994492, 31153.8442307787, 31360.843195783877, 31374.686253137177, 32214.872479463105, 30715.699802028183, 30995.535066973564, 31024.844875775478, 31447.0, 32278.677213227566, 30623.693763062085, 30934.381312373178, 31170.532442012933, 31174.532382013833, 31726.0, 26732.465350692488, 28802.855985719936, 29174.27064323324, 29178.270543236587, 29487.810822775475, 22706.318810435714, 22884.885575572014, 23116.19093331725, 23149.65275520835, 23335.766642333358], "value": 15090.344543741861, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.9349069957536, 353.8372348719589, 355.6372500049948, 359.1362772532061, 381.4811855876008, 11228.887711122887, 11474.90988356107, 12213.0, 12357.814632780504, 12359.393278873757, 13622.114562553426, 13745.725085498285, 13815.1020183688, 13902.930485347584, 14358.784618230735, 3970.920581588374, 4226.1336426032585, 4230.111676547913, 4232.238197124517, 4234.555371685975, 3959.9208015839667, 4033.556308806029, 4114.3211370124045, 4160.43834082398, 4167.541570427251, 4113.053997580559, 4132.566080561543, 4135.255653982282, 4156.127213285214, 4161.313383291768, 3863.1887303666263, 4125.628693417591, 4129.525104612963, 4140.648044916185, 4163.770992595406, 3735.477033215352, 3804.0680033391995, 3828.0812604974885, 3830.4828848105426, 3832.3485007548784, 10319.742006449824, 10385.2211084169, 10392.376457412503, 11075.944620276927, 15871.761923571155, 1848.7873894502036, 1862.0, 1904.6381187574316, 1907.0560072764072, 1920.532116230651, 7572.469927105105, 7869.763907082739, 8143.348532117476, 9940.204783617293, 10873.619423320224, 1380.5030189131905, 1417.688108616103, 1418.9077709948924, 1426.3937826423728, 1449.4622802492174, 63874.68062659657, 66363.33636663668, 67212.0, 67799.66100169517, 69348.3065169347, 9546.140847323773, 9654.131128198496, 9669.854952175723, 9893.307468477282, 9920.603175873028, 12862.292573908524, 12918.966482681362, 12921.28932908699, 12927.353632318534, 12952.417141228667, 6584.9012264816065, 7010.123734533184, 7081.185663648644, 7151.392131668762, 7158.498905076699, 6690.933090669128, 6723.63020033893, 6860.485463590251, 6871.828204294932, 6905.861882762417, 4095.28332541804, 4107.199096176277, 4157.3140431829015, 4225.302825033897, 4300.569943005675, 1761.1898526677614, 1772.9822701773076, 1785.7678501794683, 1835.3667984545311, 1850.4726153046317, 792.4136139257024, 824.3652387661467, 878.2447095497866, 882.3999680217386, 887.4276091920675, 16229.756553651705, 16545.586360341087, 16882.831171688373, 17208.483745487654, 17529.82470175282, 860.2945584620551, 861.9913800862037, 883.7083762358407, 910.4446287764458, 916.8899732032199, 9395.90604093964, 9556.808863822685, 9647.758806029766, 9699.418034917928, 9701.563429645541, 364814.0, 366677.0, 369540.0, 369885.0, 372059.9779007722, 73785.0, 74179.62910185415, 75135.24864751392, 76503.61748191224, 78699.60650196712, 864.1574464896801, 891.0421297105637, 891.0599317719867, 893.2630579771585, 899.5052721003552, 14162.504312349018, 14958.626034349229, 14960.102393856403, 15171.620709482351, 15601.687966240384, 35354.29291414209, 35994.64005359913, 36774.63225367712, 36984.815075924445, 37724.43413348857, 48897.75551122222, 49276.75361623169, 49326.75336623294, 49434.505654942994, 49613.75193124011, 6970.268121847336, 6984.092068031327, 7060.964695176492, 7101.360877521048, 7103.0, 10196.745081372728, 10515.631952881613, 10728.73178170552, 10929.672109836718, 10962.616308429167, 9290.396124251902, 9429.0, 9452.905470945203, 9829.705108846745, 10093.687820583276, 9266.258699303904, 9362.531873406439, 9494.28792840526, 9499.335046546676, 9757.170640495637, 9287.907120928705, 9682.612695492384, 9792.0, 9800.411975281506, 10086.0, 6626.210923050653, 6841.623710695761, 6896.241413444417, 7026.367626913602, 7241.4206863451855, 9440.527973601429, 9444.181940265156, 9502.952485237529, 9718.173955213886, 9839.311248212556], "value": 7401.706020496626, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.6360000999728, 1342.2483409290799, 1385.501219560958, 1575.5829211168716, 1598.7282162032454, 5583.994880921433, 5791.391903850098, 5956.821295361141, 6341.746330146794, 6349.301576826551, 5873.559483038768, 6090.421409966058, 6096.573239873211, 6205.596636218654, 6209.379062093788, 1699.2183595546032, 1714.682783685016, 1721.0190191590798, 1726.4820553833863, 1732.3417101501411, 1713.8200488948605, 1733.8989741514167, 1739.3477445957765, 1744.127936031984, 1766.2846547148426, 1665.092524574104, 1684.376780591183, 1684.7220208665556, 1689.763433119358, 1691.365737848307, 1605.4461210882228, 1616.3211451190527, 1661.983380166195, 1703.778508793849, 1711.084569755175, 1713.3318005977678, 1733.566608347913, 1736.3401907275154, 1737.7567140600327, 1740.6344667619815, 6149.046897730859, 6278.654673992928, 6280.528960327993, 6281.87436251277, 6284.24589049317, 4030.0932290234464, 4148.896277593054, 4150.543440221573, 4161.459010328668, 4163.646090082347, 2466.90132394704, 2758.7103354147926, 2759.6826364968083, 2762.3646561290816, 2774.8057635965492, 721.8664547058811, 766.4175226827596, 773.4585789947004, 783.3537331701369, 789.2344425906919, 8476.27951624119, 8572.528510931896, 8587.398882078258, 8593.097724738938, 8620.525871077089, 3661.8718344857803, 3664.9633503664622, 3744.6629803317833, 3867.8839634811, 3869.555001174901, 7468.925310746931, 7531.246875312425, 7539.170691223961, 7542.057242844645, 7606.391488681003, 4136.751794892256, 4154.626083652486, 4161.56303588125, 4167.624913757716, 4169.145325208325, 3366.444536651474, 3813.313603551332, 3813.694904407641, 3814.1608846053823, 3835.6164383561977, 2874.2239595309147, 3276.164578032634, 3285.1458620758776, 3299.4555898276517, 3300.85146168423, 1052.4632437456953, 1088.1077516436446, 1088.2491081153978, 1091.8635170603675, 1100.1803656276124, 583.9854003649858, 667.679513833353, 674.5547938360756, 677.1197443323659, 678.2064983968768, 4350.108227813291, 4402.669799765031, 4557.453105627346, 4574.611158051603, 4621.890746220883, 350.40606172537815, 375.86488803812335, 379.2907263417427, 380.6498021819932, 382.7722505109455, 3035.210845180269, 3085.4291955988215, 3098.7366073883522, 3150.9054728358187, 3245.545623612696, 7669.654865531064, 7798.649060792278, 7988.121306656263, 7993.480423772437, 7996.0, 7977.3618110551015, 7979.521228726295, 8033.558154301452, 8035.357171426272, 8036.517808931483, 5884.617499862496, 6049.818505444844, 6069.089636554464, 6071.453569178795, 6075.392460753889, 4466.754328511963, 4614.792334345029, 4650.232711602683, 4691.835785747482, 4719.622430205644, 7253.746118886025, 7270.127584689871, 7292.817679558054, 7354.227806080285, 7359.153697324662, 7244.782656520313, 7370.889436658347, 7430.888536672062, 7472.813179670552, 7515.0, 5594.1608758686525, 5672.376038635829, 5742.971285143548, 5789.8552536186935, 5808.709564521672, 5537.612367134262, 5710.057840456278, 6151.569390142826, 6348.269948955744, 6353.523485738496, 5546.0, 5745.712714364348, 5790.073588226032, 5790.334111577054, 5825.446582574648, 5529.751161197675, 5596.272484576979, 5598.10430331145, 5621.0, 5648.15277708347, 5183.663061900965, 5233.293505376725, 5283.260343551829, 5292.9470705294, 5322.228276899906, 3972.304846651882, 3999.1601763629965, 4035.8991025224605, 4090.484352123482, 4151.647109995684, 4090.1001779608437, 4109.732867363612, 4122.690798190088, 4250.978745106255, 4274.487061552633], "value": 3423.8700602599047, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [275.7146353524103, 276.83528300661106, 277.52820205650386, 278.6725597423029, 282.30130427192694, 4571.200039992997, 4863.473981363519, 4929.728864912428, 4950.504949505048, 4958.157113290745, 4834.951650483494, 4851.908320627866, 4867.561919427251, 4878.999805039967, 4885.4381746099125, 3797.3354662934016, 3805.600411956746, 3807.4859893914245, 3810.5236845394325, 3811.3330167220765, 3673.797941113238, 3818.560865500461, 3833.195029043904, 3846.423036544513, 3850.4801851749935, 3752.0, 3777.9811100944457, 3783.751362050517, 3788.545374555057, 3792.886213413602, 3747.718921080916, 3761.54861416629, 3793.0, 3795.438079296464, 3798.5441746990264, 3154.984225078883, 3256.615938226268, 3261.3966416213075, 3348.782329148622, 3357.748168887343, 4741.454732705749, 4752.738599377033, 4758.643101767381, 4759.953220115349, 4778.976105119452, 4213.726107803013, 4220.388043733672, 4240.872773816791, 4254.127903779718, 4261.914761704748, 4883.754642566123, 5038.420581633086, 5041.470645582198, 5053.9241911371355, 5059.848204553869, 3549.1304630365466, 3551.8224088795714, 3556.1287484566187, 3567.6967457766123, 3568.4825700273313, 5286.418493965661, 5294.894102117936, 5304.2839216706025, 5317.867053323659, 5326.813561525328, 3638.526991491089, 3638.7816730995696, 3639.2721455708966, 3644.1618427761764, 3650.142216579155, 3530.223350862806, 3645.635436456333, 3674.632536746304, 3679.4296883983025, 3682.705383569308, 4204.600562946515, 4207.810648520824, 4211.305134652809, 4216.984855828097, 4218.34615634571, 5050.974745126251, 5055.34280543527, 5065.518775716301, 5071.290019397287, 5073.239014147834, 1149.6780901347636, 1154.163231657042, 1178.5344788808545, 1201.165190192825, 1235.7775600392015, 810.3962547901851, 817.7896712864874, 830.8670612701939, 833.69942889092, 838.5765188579728, 4281.272183728774, 4282.35764635301, 4294.475461211225, 4296.613304802583, 4313.719608225455, 4929.457759646436, 4987.426445958761, 5012.122878496321, 5016.924746128811, 5052.7726252318735, 4310.827566897289, 4313.352997050468, 4315.3742707307265, 4322.978385108117, 4324.437823082979, 2554.9744502554736, 2696.36635390683, 2706.9458610827674, 2715.3890374665543, 2730.8224965377185, 4755.548222918817, 4760.619150467955, 4761.785719642625, 4770.546798054249, 4778.856634300976, 5191.273221748958, 5202.24567437727, 5208.635395522353, 5223.242629818655, 5244.790208391698, 4545.636229190375, 4697.671163018625, 4751.976240118777, 4765.356676848651, 4769.42766867978, 5136.563392111712, 5137.17805151174, 5137.768800404066, 5144.225242291403, 5180.471760830639, 4992.650514463952, 5004.424491183415, 5013.24801279811, 5023.598112151092, 5026.0, 4661.696989695659, 4906.435759887659, 4930.556249937523, 4943.431505376928, 4943.480934501826, 3618.2763447310117, 3644.3986742188304, 3662.7252956027874, 3665.6151104133683, 3669.6146904574634, 5314.681119132864, 5336.919946200733, 5337.786488540415, 5358.356997160366, 5359.169328754049, 4814.398200224972, 4846.612271018381, 5011.248312753116, 5040.672356296829, 5041.8487445376695, 5003.299538064746, 5016.187697350113, 5016.949830501794, 5030.5975521957425, 5045.646804723634, 4873.658843880894, 4972.041635227034, 5009.824656137018, 5016.698998060128, 5022.949770502394, 5051.747412629427, 5090.847274581768, 5091.287219789158, 5098.439171691037, 5100.719460429712, 4976.825811096594, 4977.925331119964, 5002.2496625506465, 5009.874753131201, 5024.949750502448], "value": 3764.2184564070562, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.4259406254961, 606.4814583531078, 606.6754286456746, 651.8761435327287, 661.1801366305782, 10576.78846423071, 11217.383043932581, 11423.371714555706, 11453.255538389998, 11543.711407214823, 10557.577696892115, 10747.301425407342, 10775.461226938642, 10782.514786834592, 10846.566137354497, 730.03635201534, 743.7954562495303, 747.2452822649109, 747.9887801682979, 748.3713680508372, 695.6000299827595, 720.4380583145129, 723.4646361692362, 725.1841678112124, 733.2520828754667, 784.4665627373412, 789.0807209600837, 789.0886026639241, 789.8183417813906, 789.9368050555942, 784.945053846231, 785.8899754034439, 785.9096203936534, 786.0920636664662, 786.8229648329109, 580.6690186593644, 581.2792137749203, 582.2925145947652, 582.4932308891249, 583.7548229743518, 9790.608375664964, 9884.703458896245, 9903.603855845757, 9905.20758339331, 9911.0, 8304.086550479442, 8366.247037766569, 8846.690365837165, 8919.331050171264, 9413.0, 7375.11498620169, 7448.515846470016, 7541.962290188569, 7728.961355193188, 7897.8025549361155, 2438.7805097541304, 2445.217530390276, 2455.398427385302, 2484.428581426264, 2507.6489291499206, 46008.53991460076, 48215.75892120552, 48409.547713568296, 48471.51528484705, 49609.0, 6043.0, 6241.937580624136, 6507.609543427409, 6524.641144737085, 6605.768798092044, 13472.393742281425, 13542.526011589547, 13641.795373069412, 13644.93177534106, 13741.175529468264, 6289.7484100635465, 6417.743290268337, 6446.258680251737, 6471.579347342407, 6485.902711459332, 3578.051816268691, 3583.6774690278, 3603.4955106285142, 3665.3035923175044, 3680.7803015615, 2458.4591389894194, 2530.253575195285, 2533.518631460017, 2535.429528356142, 2541.885615147323, 437.4182337491129, 441.34239982425953, 450.38297532380847, 450.4189595421869, 451.4492319370363, 483.8645179349788, 485.2938973793122, 516.770037333383, 518.271828081546, 523.1185452512452, 6064.818055458255, 6492.285848556655, 6522.836929076811, 6774.8645027100165, 6796.320367963263, 460.16709755342936, 474.962003039756, 490.73009844585334, 498.1083859890827, 511.66741617948634, 2999.9850000749857, 3096.380723855238, 3183.633882103588, 3187.442197615408, 3319.618243901982, 41549.376759348634, 41898.37152442716, 69482.65258673775, 69516.65241673759, 72149.63925180446, 38856.41715374272, 47395.0, 56267.15599266014, 61996.0, 62332.376676233565, 55634.72182639061, 56965.14552281636, 58167.0, 59106.70446647825, 59601.70199148977, 5954.851128721816, 6086.239220097488, 6088.269407671108, 6232.626042437469, 6375.234971803413, 26682.733172668803, 33332.666673332955, 33631.15922101967, 33722.3255534883, 36729.44905826468, 32483.837580811945, 33422.0, 43453.0, 45001.54998449974, 48379.75810120927, 7794.22057794216, 8603.225709686158, 8731.432456890281, 8784.912150878665, 8797.560121993747, 9857.309988301036, 10032.0, 10059.0, 10626.203034772268, 10725.249232553646, 8262.17378262169, 8433.578321083798, 8567.485950842969, 9187.632494700138, 9301.209397201314, 8985.910140898768, 9048.502332371783, 9113.863292050492, 9389.248860091313, 9434.764130896783, 8127.715529956423, 8181.386396020203, 8351.540665263468, 8552.828943420973, 8895.0, 7561.4706970513735, 7710.306072453506, 7894.500941244279, 7905.130435652189, 8034.718784842503, 7773.844523109619, 7804.8829267559895, 7860.606969651609, 7884.526928384315, 7979.84040319202], "value": 5226.89327923742, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1587.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 136.0, 133.0, 178.0, 135.0, 131.0, 132.0, 135.0, 166.0, 133.0], "value": 143.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 176.0, 163.0, 162.0, 165.0, 164.0, 162.0, 161.0, 161.0, 164.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 107.0, 77.0, 77.0, 77.0, 76.0, 99.0, 77.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 125.0, 82.0, 84.0, 83.0, 103.0, 85.0, 83.0, 107.0], "value": 92.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 122.0, 118.0, 119.0, 118.0, 118.0, 118.0, 118.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 148.0, 147.0, 146.0, 148.0, 148.0, 149.0, 150.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 64.0, 65.0, 65.0, 66.0, 64.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 68.0, 67.0, 67.0, 66.0, 66.0, 68.0, 69.0], "value": 67.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 90.0, 86.0, 89.0, 85.0, 84.0, 85.0, 84.0, 84.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 144.0, 158.0, 155.0, 146.0, 141.0, 154.0, 189.0, 167.0], "value": 155.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 188.0, 184.0, 192.0, 185.0, 178.0, 177.0, 178.0, 182.0, 184.0], "value": 183.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 70.0, 73.0, 70.0, 72.0, 68.0, 79.0, 68.0], "value": 71.0, "unit": "score"}]}]} 16:22:11 INFO - Return code: 0 16:22:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:22:11 ERROR - # TBPL SUCCESS # 16:22:11 INFO - Running post-action listener: _resource_record_post_action 16:22:11 INFO - [mozharness: 2016-11-18 00:22:11.889798Z] Finished run-tests step (success) 16:22:11 INFO - Running post-run listener: _resource_record_post_run 16:22:11 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 8376320; Write bytes: 421146624; Read time: 3324; Write time: 397720 16:22:11 INFO - TinderboxPrint: CPU usage
13.4% 16:22:11 INFO - TinderboxPrint: I/O read bytes / time
8,376,320 / 3,324 16:22:11 INFO - TinderboxPrint: I/O write bytes / time
421,146,624 / 397,720 16:22:11 INFO - TinderboxPrint: CPU idle
8,317.2 (86.5%) 16:22:11 INFO - TinderboxPrint: CPU user
1,226.4 (12.8%) 16:22:11 INFO - TinderboxPrint: Swap in / out
0 / 0 16:22:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 4644864; Read time: 0; Write time: 436 16:22:11 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 6049792; Write bytes: 416501760; Read time: 2916; Write time: 397284 16:22:12 INFO - Running post-run listener: _upload_blobber_files 16:22:12 INFO - Blob upload gear active. 16:22:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:22:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:22:12 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:22:12 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:22:12 INFO - (blobuploader) - INFO - Open directory for files ... 16:22:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:22:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:22:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:22:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:22:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:22:13 INFO - (blobuploader) - INFO - Done attempting. 16:22:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:22:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:22:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:22:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:22:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:22:14 INFO - (blobuploader) - INFO - Done attempting. 16:22:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:22:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:22:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:22:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:22:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:22:17 INFO - (blobuploader) - INFO - Done attempting. 16:22:17 INFO - (blobuploader) - INFO - Iteration through files over. 16:22:17 INFO - Return code: 0 16:22:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:22:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:22:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b7545847557b675f91cda140a1046755a8a8964177cec309d26a798903c97da07a48402aca2c025e7e9766cbfa3da7472859c30bc18932086f23d81d08072b34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/88b10fca7cd38fa7c0baa0186c9179d52094842afe4ce72dde360da61858279acfd00128e32040c4365123f911486d92cd479000bd2012505b0091781775edcd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/cdc84ec9fc1b733bd20f3cf5a227c8c9ae3cd7fcadc16ec0d332a5c120f3cb3d89ec48e37736d9cc31762e43f49a82b2a004ca111b31bb3222bc30145737ec75"} 16:22:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:22:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:22:17 INFO - Contents: 16:22:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b7545847557b675f91cda140a1046755a8a8964177cec309d26a798903c97da07a48402aca2c025e7e9766cbfa3da7472859c30bc18932086f23d81d08072b34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/88b10fca7cd38fa7c0baa0186c9179d52094842afe4ce72dde360da61858279acfd00128e32040c4365123f911486d92cd479000bd2012505b0091781775edcd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/cdc84ec9fc1b733bd20f3cf5a227c8c9ae3cd7fcadc16ec0d332a5c120f3cb3d89ec48e37736d9cc31762e43f49a82b2a004ca111b31bb3222bc30145737ec75"} 16:22:17 INFO - Running post-run listener: copy_logs_to_upload_dir 16:22:17 INFO - Copying logs to upload dir... 16:22:17 INFO - mkdir: /builds/slave/test/build/upload/logs 16:22:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.948267 ========= master_lag: 0.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-11-17 16:22:17.933942) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 16:22:17.937017) ========= 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=62c568580acbfdaac3eec7be000001dc-1479427284.795445-2079217055 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/Graphics/sha512/b7545847557b675f91cda140a1046755a8a8964177cec309d26a798903c97da07a48402aca2c025e7e9766cbfa3da7472859c30bc18932086f23d81d08072b34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/88b10fca7cd38fa7c0baa0186c9179d52094842afe4ce72dde360da61858279acfd00128e32040c4365123f911486d92cd479000bd2012505b0091781775edcd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/cdc84ec9fc1b733bd20f3cf5a227c8c9ae3cd7fcadc16ec0d332a5c120f3cb3d89ec48e37736d9cc31762e43f49a82b2a004ca111b31bb3222bc30145737ec75"} build_url:https://queue.taskcluster.net/v1/task/dsrgsWMIRNSi2lxGu94taA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011737 build_url: 'https://queue.taskcluster.net/v1/task/dsrgsWMIRNSi2lxGu94taA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b7545847557b675f91cda140a1046755a8a8964177cec309d26a798903c97da07a48402aca2c025e7e9766cbfa3da7472859c30bc18932086f23d81d08072b34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/88b10fca7cd38fa7c0baa0186c9179d52094842afe4ce72dde360da61858279acfd00128e32040c4365123f911486d92cd479000bd2012505b0091781775edcd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/cdc84ec9fc1b733bd20f3cf5a227c8c9ae3cd7fcadc16ec0d332a5c120f3cb3d89ec48e37736d9cc31762e43f49a82b2a004ca111b31bb3222bc30145737ec75"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 16:22:17.962329) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 16:22:17.962668) ========= 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=62c568580acbfdaac3eec7be000001dc-1479427284.795445-2079217055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004398 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 16:22:18.045395) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 16:22:18.045719) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 16:22:18.046049) ========= ========= Total master_lag: 0.33 =========