builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-010 starttime: 1476685018.77 results: success (0) buildid: 20161016201450 builduid: 224945c9e2144f3e8f3a341954ac39aa revision: 2976adccde9b75596c469428228177ed3d0f0b61 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-16 23:16:58.773656) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-16 23:16:58.774238) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-16 23:16:58.774583) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-16 23:16:58.821603) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:16:58.821905) ========= 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=eca2ab57546de7b41f256b19000001ef-1476682536.857499-617807562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-16 23:16:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.9M=0s 2016-10-16 23:17:00 (88.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.156484 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:16:58.999057) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:16:58.999397) ========= 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=eca2ab57546de7b41f256b19000001ef-1476682536.857499-617807562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023578 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:16:59.053394) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:16:59.053756) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2976adccde9b75596c469428228177ed3d0f0b61 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 2976adccde9b75596c469428228177ed3d0f0b61 --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=eca2ab57546de7b41f256b19000001ef-1476682536.857499-617807562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-16 23:17:00,206 truncating revision to first 12 chars 2016-10-16 23:17:00,206 Setting DEBUG logging. 2016-10-16 23:17:00,206 attempt 1/10 2016-10-16 23:17:00,206 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2976adccde9b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-16 23:17:00,525 unpacking tar archive at: fx-team-2976adccde9b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.666254 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:16:59.737905) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-16 23:16:59.738472) ========= script_repo_revision: 2976adccde9b75596c469428228177ed3d0f0b61 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-16 23:16:59.739167) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-16 23:16:59.740126) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-16 23:16:59.750630) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-16 23:16:59.751018) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=eca2ab57546de7b41f256b19000001ef-1476682536.857499-617807562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:17:00 INFO - MultiFileLogger online at 20161016 23:17:00 in /builds/slave/test 23:17:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:17:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:17:00 INFO - {'append_to_log': False, 23:17:00 INFO - 'base_work_dir': '/builds/slave/test', 23:17:01 INFO - 'blob_upload_branch': 'Fx-Team', 23:17:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:17:01 INFO - 'branch': 'Fx-Team', 23:17:01 INFO - 'buildbot_json_path': 'buildprops.json', 23:17:01 INFO - 'config_files': ('talos/linux_config.py',), 23:17:01 INFO - 'default_actions': ('clobber', 23:17:01 INFO - 'read-buildbot-config', 23:17:01 INFO - 'download-and-extract', 23:17:01 INFO - 'populate-webroot', 23:17:01 INFO - 'create-virtualenv', 23:17:01 INFO - 'install', 23:17:01 INFO - 'run-tests'), 23:17:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:17:01 INFO - 'download_minidump_stackwalk': True, 23:17:01 INFO - 'download_symbols': 'ondemand', 23:17:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:17:01 INFO - 'tooltool.py': '/tools/tooltool.py', 23:17:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:17:01 INFO - '/tools/misc-python/virtualenv.py')}, 23:17:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:17:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:17:01 INFO - 'installer_path': 'installer.exe', 23:17:01 INFO - 'log_level': 'info', 23:17:01 INFO - 'log_name': 'talos', 23:17:01 INFO - 'log_to_console': True, 23:17:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:17:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:17:01 INFO - 'opt_config_files': (), 23:17:01 INFO - 'pip_index': False, 23:17:01 INFO - 'sps_profile': False, 23:17:01 INFO - 'sps_profile_interval': 0, 23:17:01 INFO - 'suite': 'dromaeojs-e10s', 23:17:01 INFO - 'system_bits': '32', 23:17:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:17:01 INFO - 'title': 'talos-linux64-ix-010', 23:17:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:17:01 INFO - 'use_talos_json': True, 23:17:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:17:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:17:01 INFO - 'work_dir': 'build'} 23:17:01 INFO - [mozharness: 2016-10-17 06:17:01.004996Z] Running clobber step. 23:17:01 INFO - Running pre-action listener: _resource_record_pre_action 23:17:01 INFO - Running main action method: clobber 23:17:01 INFO - rmtree: /builds/slave/test/build 23:17:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:17:01 INFO - Running post-action listener: _resource_record_post_action 23:17:01 INFO - [mozharness: 2016-10-17 06:17:01.473894Z] Finished clobber step (success) 23:17:01 INFO - [mozharness: 2016-10-17 06:17:01.473997Z] Running read-buildbot-config step. 23:17:01 INFO - Running pre-action listener: _resource_record_pre_action 23:17:01 INFO - Running main action method: read_buildbot_config 23:17:01 INFO - Using buildbot properties: 23:17:01 INFO - { 23:17:01 INFO - "project": "", 23:17:01 INFO - "product": "firefox", 23:17:01 INFO - "script_repo_revision": "production", 23:17:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:17:01 INFO - "repository": "", 23:17:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:17:01 INFO - "buildid": "20161016201450", 23:17:01 INFO - "pgo_build": "True", 23:17:01 INFO - "basedir": "/builds/slave/test", 23:17:01 INFO - "buildnumber": 823, 23:17:01 INFO - "slavename": "talos-linux64-ix-010", 23:17:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:17:01 INFO - "platform": "ubuntu64_hw", 23:17:01 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:17:01 INFO - "branch": "fx-team", 23:17:01 INFO - "repo_path": "integration/fx-team", 23:17:01 INFO - "revision": "2976adccde9b75596c469428228177ed3d0f0b61", 23:17:01 INFO - "stage_platform": "linux64-pgo", 23:17:01 INFO - "builduid": "224945c9e2144f3e8f3a341954ac39aa", 23:17:01 INFO - "slavebuilddir": "test" 23:17:01 INFO - } 23:17:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/VlIQuMY_SXCZLfkKOFRPEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 23:17:01 INFO - Running post-action listener: _resource_record_post_action 23:17:01 INFO - [mozharness: 2016-10-17 06:17:01.476469Z] Finished read-buildbot-config step (success) 23:17:01 INFO - [mozharness: 2016-10-17 06:17:01.476558Z] Running download-and-extract step. 23:17:01 INFO - Running pre-action listener: _resource_record_pre_action 23:17:01 INFO - Running main action method: download_and_extract 23:17:01 INFO - mkdir: /builds/slave/test/build/tests 23:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:01 INFO - trying https://queue.taskcluster.net/v1/task/VlIQuMY_SXCZLfkKOFRPEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:17:01 INFO - Downloading https://queue.taskcluster.net/v1/task/VlIQuMY_SXCZLfkKOFRPEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:17:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VlIQuMY_SXCZLfkKOFRPEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:17:02 INFO - Downloaded 1361 bytes. 23:17:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:17:02 INFO - Using the following test package requirements: 23:17:02 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 23:17:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:17:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:17:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:17:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:17:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:17:02 INFO - u'jsshell-linux-x86_64.zip'], 23:17:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:17:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:17:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 23:17:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:17:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:17:02 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:17:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:17:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:17:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:17:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:17:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:17:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:17:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VlIQuMY_SXCZLfkKOFRPEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 23:17:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VlIQuMY_SXCZLfkKOFRPEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:17:02 INFO - Fetch https://queue.taskcluster.net/v1/task/VlIQuMY_SXCZLfkKOFRPEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:17:02 INFO - Http code: 200 23:17:02 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 23:17:02 INFO - x-amz-cf-id: B50XPaGCEejKj3Og9VZ_l5QqJ7ffTbg7TD_fbqjHKXtTJhX5yvRERw== 23:17:02 INFO - x-amz-version-id: rBMXNwiYyRaB5TCdFUqe0IAu4TkRkofO 23:17:03 INFO - Expected file size: 22100321 23:17:03 INFO - Obtained file size: 22100321 23:17:08 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:17:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VlIQuMY_SXCZLfkKOFRPEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 23:17:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VlIQuMY_SXCZLfkKOFRPEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:17:08 INFO - Fetch https://queue.taskcluster.net/v1/task/VlIQuMY_SXCZLfkKOFRPEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:17:08 INFO - Http code: 200 23:17:08 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 23:17:08 INFO - x-amz-cf-id: V4rWp-bH8ZPgp_xJRiHbRa-DJZE5Wot8rsZXJF_TlUPH2iCxRBUt9g== 23:17:08 INFO - x-amz-version-id: rBMXNwiYyRaB5TCdFUqe0IAu4TkRkofO 23:17:08 INFO - Expected file size: 22100321 23:17:08 INFO - Obtained file size: 22100321 23:17:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VlIQuMY_SXCZLfkKOFRPEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 23:17:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VlIQuMY_SXCZLfkKOFRPEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:17:13 INFO - Fetch https://queue.taskcluster.net/v1/task/VlIQuMY_SXCZLfkKOFRPEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 23:17:14 INFO - Http code: 200 23:17:14 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 23:17:14 INFO - x-amz-cf-id: mcv9RRTmyWTvjZaVcjHKQwCOf_NttFmVnvlf_XhWOtIVNCLnuO2yOw== 23:17:14 INFO - x-amz-version-id: r45A7PgmQbuy2QSz2BSla_1b2UOd1.Mu 23:17:14 INFO - Expected file size: 14409006 23:17:14 INFO - Obtained file size: 14409006 23:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:15 INFO - trying https://queue.taskcluster.net/v1/task/VlIQuMY_SXCZLfkKOFRPEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:17:15 INFO - Downloading https://queue.taskcluster.net/v1/task/VlIQuMY_SXCZLfkKOFRPEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:17:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VlIQuMY_SXCZLfkKOFRPEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:17:17 INFO - Downloaded 59721130 bytes. 23:17:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VlIQuMY_SXCZLfkKOFRPEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:17:17 INFO - mkdir: /builds/slave/test/properties 23:17:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:17:17 INFO - Writing to file /builds/slave/test/properties/build_url 23:17:17 INFO - Contents: 23:17:17 INFO - build_url:https://queue.taskcluster.net/v1/task/VlIQuMY_SXCZLfkKOFRPEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:17:18 INFO - Running post-action listener: _resource_record_post_action 23:17:18 INFO - Running post-action listener: set_extra_try_arguments 23:17:18 INFO - [mozharness: 2016-10-17 06:17:18.189047Z] Finished download-and-extract step (success) 23:17:18 INFO - [mozharness: 2016-10-17 06:17:18.189275Z] Running populate-webroot step. 23:17:18 INFO - Running pre-action listener: _resource_record_pre_action 23:17:18 INFO - Running main action method: populate_webroot 23:17:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:17:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:17:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:17:18 INFO - '--tppagecycles', 23:17:18 INFO - '7'], 23:17:18 INFO - 'tests': ['tsvgm']}}, 23:17:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:17:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:17:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:17:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:17:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:17:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:17:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:18 INFO - 'talos_options': ['--disable-e10s'], 23:17:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:17:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:17:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:18 INFO - 'talos_options': ['--disable-e10s'], 23:17:18 INFO - 'tests': ['damp', 'tps']}, 23:17:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:18 INFO - 'tests': ['damp', 'tps']}, 23:17:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:17:18 INFO - 'tests': ['dromaeo_dom']}, 23:17:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:17:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:17:18 INFO - 'tests': ['basic_compositor_video']}, 23:17:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:17:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:17:18 INFO - 'tests': ['a11yr', 23:17:18 INFO - 'ts_paint', 23:17:18 INFO - 'tpaint', 23:17:18 INFO - 'sessionrestore', 23:17:18 INFO - 'sessionrestore_no_auto_restore', 23:17:18 INFO - 'tabpaint']}, 23:17:18 INFO - 'other-e10s': {'tests': ['a11yr', 23:17:18 INFO - 'ts_paint', 23:17:18 INFO - 'tpaint', 23:17:18 INFO - 'sessionrestore', 23:17:18 INFO - 'sessionrestore_no_auto_restore', 23:17:18 INFO - 'tabpaint']}, 23:17:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:17:18 INFO - 'ts_paint', 23:17:18 INFO - 'tpaint', 23:17:18 INFO - 'sessionrestore', 23:17:18 INFO - 'sessionrestore_no_auto_restore', 23:17:18 INFO - 'tabpaint']}, 23:17:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:17:18 INFO - 'ts_paint', 23:17:18 INFO - 'tpaint', 23:17:18 INFO - 'sessionrestore', 23:17:18 INFO - 'sessionrestore_no_auto_restore', 23:17:18 INFO - 'tabpaint']}, 23:17:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:17:18 INFO - 'tests': ['a11yr', 23:17:18 INFO - 'ts_paint', 23:17:18 INFO - 'tpaint', 23:17:18 INFO - 'sessionrestore', 23:17:18 INFO - 'sessionrestore_no_auto_restore', 23:17:18 INFO - 'tabpaint']}, 23:17:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:17:18 INFO - 'tests': ['a11yr', 23:17:18 INFO - 'ts_paint', 23:17:18 INFO - 'tpaint', 23:17:18 INFO - 'sessionrestore', 23:17:18 INFO - 'sessionrestore_no_auto_restore', 23:17:18 INFO - 'tabpaint']}, 23:17:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:17:18 INFO - 'tests': ['tsvgx', 23:17:18 INFO - 'tsvgr_opacity', 23:17:18 INFO - 'tart', 23:17:18 INFO - 'tscrollx', 23:17:18 INFO - 'cart']}, 23:17:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:17:18 INFO - 'tsvgr_opacity', 23:17:18 INFO - 'tart', 23:17:18 INFO - 'tscrollx', 23:17:18 INFO - 'cart']}, 23:17:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:18 INFO - 'talos_options': ['--disable-e10s'], 23:17:18 INFO - 'tests': ['tp5o']}, 23:17:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:18 INFO - 'tests': ['tp5o']}, 23:17:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:18 INFO - 'talos_options': ['--disable-e10s', 23:17:18 INFO - '--xperf_path', 23:17:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:17:18 INFO - 'tests': ['tp5n']}, 23:17:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:18 INFO - 'talos_options': ['--xperf_path', 23:17:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:17:18 INFO - 'tests': ['tp5n']}}, 23:17:18 INFO - 'talos.zip': {'path': '', 23:17:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:17:18 INFO - Running post-action listener: _resource_record_post_action 23:17:18 INFO - [mozharness: 2016-10-17 06:17:18.206479Z] Finished populate-webroot step (success) 23:17:18 INFO - [mozharness: 2016-10-17 06:17:18.206568Z] Running create-virtualenv step. 23:17:18 INFO - Running pre-action listener: _resource_record_pre_action 23:17:18 INFO - Running main action method: create_virtualenv 23:17:18 INFO - Creating virtualenv /builds/slave/test/build/venv 23:17:18 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 23:17:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:17:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:17:18 INFO - Using real prefix '/usr' 23:17:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:17:18 INFO - Installing distribute.............................................................................................................................................................................................done. 23:17:20 INFO - Installing pip.................done. 23:17:20 INFO - Return code: 0 23:17:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:17:21 INFO - Reading from file tmpfile_stdout 23:17:21 INFO - Output received: 23:17:21 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) 23:17:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:17:21 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')]} 23:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:21 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')]} 23:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:21 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 0x7ff0ad6e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1947930>, '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 0x1948830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1948cc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476682536.857499-617807562', '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 23:17:21 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 23:17:21 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 23:17:21 INFO - Using env: {'DISPLAY': ':0', 23:17:21 INFO - 'HOME': '/home/cltbld', 23:17:21 INFO - 'LANG': 'en_US.UTF-8', 23:17:21 INFO - 'LANGUAGE': 'en_US:en', 23:17:21 INFO - 'LOGNAME': 'cltbld', 23:17:21 INFO - 'MAIL': '/var/mail/cltbld', 23:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:21 INFO - 'MOZ_NO_REMOTE': '1', 23:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:21 INFO - 'NO_EM_RESTART': '1', 23:17:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:21 INFO - 'PWD': '/builds/slave/test', 23:17:21 INFO - 'SHELL': '/bin/bash', 23:17:21 INFO - 'SHLVL': '1', 23:17:21 INFO - 'TERM': 'linux', 23:17:21 INFO - 'TMOUT': '86400', 23:17:21 INFO - 'USER': 'cltbld', 23:17:21 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476682536.857499-617807562', 23:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:21 INFO - '_': '/tools/buildbot/bin/python'} 23:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:21 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 23:17:21 INFO - Cleaning up... 23:17:21 INFO - Return code: 0 23:17:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:17:21 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')]} 23:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:21 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')]} 23:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:21 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 0x7ff0ad6e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1947930>, '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 0x1948830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1948cc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476682536.857499-617807562', '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 23:17:21 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 23:17:21 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 23:17:21 INFO - Using env: {'DISPLAY': ':0', 23:17:21 INFO - 'HOME': '/home/cltbld', 23:17:21 INFO - 'LANG': 'en_US.UTF-8', 23:17:21 INFO - 'LANGUAGE': 'en_US:en', 23:17:21 INFO - 'LOGNAME': 'cltbld', 23:17:21 INFO - 'MAIL': '/var/mail/cltbld', 23:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:21 INFO - 'MOZ_NO_REMOTE': '1', 23:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:21 INFO - 'NO_EM_RESTART': '1', 23:17:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:21 INFO - 'PWD': '/builds/slave/test', 23:17:21 INFO - 'SHELL': '/bin/bash', 23:17:21 INFO - 'SHLVL': '1', 23:17:21 INFO - 'TERM': 'linux', 23:17:21 INFO - 'TMOUT': '86400', 23:17:21 INFO - 'USER': 'cltbld', 23:17:21 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476682536.857499-617807562', 23:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:21 INFO - '_': '/tools/buildbot/bin/python'} 23:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:21 INFO - Downloading/unpacking psutil>=3.1.1 23:17:21 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 23:17:21 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 23:17:21 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 23:17:21 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 23:17:21 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 23:17:21 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 23:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:17:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:17:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:17:23 INFO - Installing collected packages: psutil 23:17:23 INFO - Running setup.py install for psutil 23:17:23 INFO - building 'psutil._psutil_linux' extension 23:17:23 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 23:17:23 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 23:17:23 INFO - building 'psutil._psutil_posix' extension 23:17:23 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 23:17:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:17:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:17:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:17:24 INFO - Successfully installed psutil 23:17:24 INFO - Cleaning up... 23:17:24 INFO - Return code: 0 23:17:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:17:24 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')]} 23:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:24 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')]} 23:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:24 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 0x7ff0ad6e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1947930>, '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 0x1948830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1948cc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476682536.857499-617807562', '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 23:17:24 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 23:17:24 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 23:17:24 INFO - Using env: {'DISPLAY': ':0', 23:17:24 INFO - 'HOME': '/home/cltbld', 23:17:24 INFO - 'LANG': 'en_US.UTF-8', 23:17:24 INFO - 'LANGUAGE': 'en_US:en', 23:17:24 INFO - 'LOGNAME': 'cltbld', 23:17:24 INFO - 'MAIL': '/var/mail/cltbld', 23:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:24 INFO - 'MOZ_NO_REMOTE': '1', 23:17:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:24 INFO - 'NO_EM_RESTART': '1', 23:17:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:24 INFO - 'PWD': '/builds/slave/test', 23:17:24 INFO - 'SHELL': '/bin/bash', 23:17:24 INFO - 'SHLVL': '1', 23:17:24 INFO - 'TERM': 'linux', 23:17:24 INFO - 'TMOUT': '86400', 23:17:24 INFO - 'USER': 'cltbld', 23:17:24 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476682536.857499-617807562', 23:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:24 INFO - '_': '/tools/buildbot/bin/python'} 23:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:17:24 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 23:17:24 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 23:17:24 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 23:17:24 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 23:17:24 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 23:17:24 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 23:17:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:17:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:17:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:17:26 INFO - Installing collected packages: mozsystemmonitor 23:17:26 INFO - Running setup.py install for mozsystemmonitor 23:17:26 INFO - Successfully installed mozsystemmonitor 23:17:26 INFO - Cleaning up... 23:17:26 INFO - Return code: 0 23:17:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:17:26 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')]} 23:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:26 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')]} 23:17:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:26 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 0x7ff0ad6e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1947930>, '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 0x1948830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1948cc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476682536.857499-617807562', '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 23:17:26 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 23:17:26 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 23:17:26 INFO - Using env: {'DISPLAY': ':0', 23:17:26 INFO - 'HOME': '/home/cltbld', 23:17:26 INFO - 'LANG': 'en_US.UTF-8', 23:17:26 INFO - 'LANGUAGE': 'en_US:en', 23:17:26 INFO - 'LOGNAME': 'cltbld', 23:17:26 INFO - 'MAIL': '/var/mail/cltbld', 23:17:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:26 INFO - 'MOZ_NO_REMOTE': '1', 23:17:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:26 INFO - 'NO_EM_RESTART': '1', 23:17:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:26 INFO - 'PWD': '/builds/slave/test', 23:17:26 INFO - 'SHELL': '/bin/bash', 23:17:26 INFO - 'SHLVL': '1', 23:17:26 INFO - 'TERM': 'linux', 23:17:26 INFO - 'TMOUT': '86400', 23:17:26 INFO - 'USER': 'cltbld', 23:17:26 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476682536.857499-617807562', 23:17:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:26 INFO - '_': '/tools/buildbot/bin/python'} 23:17:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:26 INFO - Downloading/unpacking jsonschema==2.5.1 23:17:26 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 23:17:26 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 23:17:26 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 23:17:26 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 23:17:26 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 23:17:26 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 23:17:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:17:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:17:28 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 23:17:28 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 23:17:28 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 23:17:28 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 23:17:28 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 23:17:28 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 23:17:28 INFO - Downloading functools32-3.2.3-2.tar.gz 23:17:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:17:28 INFO - warning: no files found matching '*.txt' 23:17:28 INFO - no previously-included directories found matching 'build' 23:17:28 INFO - no previously-included directories found matching 'dist' 23:17:28 INFO - no previously-included directories found matching '.git*' 23:17:29 INFO - Installing collected packages: jsonschema, functools32 23:17:29 INFO - Running setup.py install for functools32 23:17:29 INFO - warning: no files found matching '*.txt' 23:17:29 INFO - no previously-included directories found matching 'build' 23:17:29 INFO - no previously-included directories found matching 'dist' 23:17:29 INFO - no previously-included directories found matching '.git*' 23:17:29 INFO - Successfully installed jsonschema functools32 23:17:29 INFO - Cleaning up... 23:17:29 INFO - Return code: 0 23:17:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:17:29 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')]} 23:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:29 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')]} 23:17:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:29 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 0x7ff0ad6e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1947930>, '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 0x1948830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1948cc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476682536.857499-617807562', '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 23:17:29 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 23:17:29 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 23:17:29 INFO - Using env: {'DISPLAY': ':0', 23:17:29 INFO - 'HOME': '/home/cltbld', 23:17:29 INFO - 'LANG': 'en_US.UTF-8', 23:17:29 INFO - 'LANGUAGE': 'en_US:en', 23:17:29 INFO - 'LOGNAME': 'cltbld', 23:17:29 INFO - 'MAIL': '/var/mail/cltbld', 23:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:29 INFO - 'MOZ_NO_REMOTE': '1', 23:17:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:29 INFO - 'NO_EM_RESTART': '1', 23:17:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:29 INFO - 'PWD': '/builds/slave/test', 23:17:29 INFO - 'SHELL': '/bin/bash', 23:17:29 INFO - 'SHLVL': '1', 23:17:29 INFO - 'TERM': 'linux', 23:17:29 INFO - 'TMOUT': '86400', 23:17:29 INFO - 'USER': 'cltbld', 23:17:29 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476682536.857499-617807562', 23:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:29 INFO - '_': '/tools/buildbot/bin/python'} 23:17:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:17:29 INFO - Cleaning up... 23:17:29 INFO - Return code: 0 23:17:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:17:29 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')]} 23:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:29 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')]} 23:17:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:29 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 0x7ff0ad6e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1947930>, '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 0x1948830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1948cc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476682536.857499-617807562', '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 23:17:29 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 23:17:29 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 23:17:29 INFO - Using env: {'DISPLAY': ':0', 23:17:29 INFO - 'HOME': '/home/cltbld', 23:17:29 INFO - 'LANG': 'en_US.UTF-8', 23:17:29 INFO - 'LANGUAGE': 'en_US:en', 23:17:29 INFO - 'LOGNAME': 'cltbld', 23:17:29 INFO - 'MAIL': '/var/mail/cltbld', 23:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:29 INFO - 'MOZ_NO_REMOTE': '1', 23:17:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:29 INFO - 'NO_EM_RESTART': '1', 23:17:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:29 INFO - 'PWD': '/builds/slave/test', 23:17:29 INFO - 'SHELL': '/bin/bash', 23:17:29 INFO - 'SHLVL': '1', 23:17:29 INFO - 'TERM': 'linux', 23:17:29 INFO - 'TMOUT': '86400', 23:17:29 INFO - 'USER': 'cltbld', 23:17:29 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476682536.857499-617807562', 23:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:29 INFO - '_': '/tools/buildbot/bin/python'} 23:17:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:29 INFO - Downloading/unpacking blobuploader==1.2.4 23:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:31 INFO - Downloading blobuploader-1.2.4.tar.gz 23:17:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:17:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:17:31 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 23:17:31 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 23:17:31 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 23:17:31 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 23:17:31 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 23:17:31 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 23:17:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:17:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:32 INFO - Downloading docopt-0.6.1.tar.gz 23:17:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:17:32 INFO - Installing collected packages: blobuploader, requests, docopt 23:17:32 INFO - Running setup.py install for blobuploader 23:17:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:17:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:17:32 INFO - Running setup.py install for requests 23:17:32 INFO - Running setup.py install for docopt 23:17:32 INFO - Successfully installed blobuploader requests docopt 23:17:32 INFO - Cleaning up... 23:17:32 INFO - Return code: 0 23:17:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:17:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:32 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 0x7ff0ad6e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1947930>, '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 0x1948830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1948cc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476682536.857499-617807562', '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 23:17:32 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 23:17:32 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 23:17:32 INFO - Using env: {'DISPLAY': ':0', 23:17:32 INFO - 'HOME': '/home/cltbld', 23:17:32 INFO - 'LANG': 'en_US.UTF-8', 23:17:32 INFO - 'LANGUAGE': 'en_US:en', 23:17:32 INFO - 'LOGNAME': 'cltbld', 23:17:32 INFO - 'MAIL': '/var/mail/cltbld', 23:17:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:32 INFO - 'MOZ_NO_REMOTE': '1', 23:17:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:32 INFO - 'NO_EM_RESTART': '1', 23:17:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:32 INFO - 'PWD': '/builds/slave/test', 23:17:32 INFO - 'SHELL': '/bin/bash', 23:17:32 INFO - 'SHLVL': '1', 23:17:32 INFO - 'TERM': 'linux', 23:17:32 INFO - 'TMOUT': '86400', 23:17:32 INFO - 'USER': 'cltbld', 23:17:32 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476682536.857499-617807562', 23:17:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:32 INFO - '_': '/tools/buildbot/bin/python'} 23:17:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:17:33 INFO - Running setup.py (path:/tmp/pip-GZSBln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:17:33 INFO - Running setup.py (path:/tmp/pip-TShkQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:17:33 INFO - Running setup.py (path:/tmp/pip-UkFXkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:17:33 INFO - Running setup.py (path:/tmp/pip-ihdRa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:17:33 INFO - Running setup.py (path:/tmp/pip-Iptwph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:17:33 INFO - Running setup.py (path:/tmp/pip-qYWVEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:17:33 INFO - Running setup.py (path:/tmp/pip-caGedc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:17:33 INFO - Running setup.py (path:/tmp/pip-6Ru8xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:17:33 INFO - Running setup.py (path:/tmp/pip-jNqoqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:17:33 INFO - Running setup.py (path:/tmp/pip-NvxPo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:17:33 INFO - Running setup.py (path:/tmp/pip-mBcNnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:17:33 INFO - Running setup.py (path:/tmp/pip-ITjErQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:17:34 INFO - Running setup.py (path:/tmp/pip-XLl7pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:17:34 INFO - Running setup.py (path:/tmp/pip-enSWXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:17:34 INFO - Running setup.py (path:/tmp/pip-nwhxUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:17:34 INFO - Running setup.py (path:/tmp/pip-_9nj59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:17:34 INFO - Running setup.py (path:/tmp/pip-3RkOxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:17:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:17:34 INFO - Running setup.py install for manifestparser 23:17:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:17:34 INFO - Running setup.py install for mozcrash 23:17:34 INFO - Running setup.py install for mozdebug 23:17:34 INFO - Running setup.py install for mozdevice 23:17:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:17:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:17:34 INFO - Running setup.py install for mozfile 23:17:34 INFO - Running setup.py install for mozhttpd 23:17:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:17:35 INFO - Running setup.py install for mozinfo 23:17:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:17:35 INFO - Running setup.py install for mozInstall 23:17:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:17:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:17:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:17:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:17:35 INFO - Running setup.py install for mozleak 23:17:35 INFO - Running setup.py install for mozlog 23:17:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:17:35 INFO - Running setup.py install for moznetwork 23:17:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:17:35 INFO - Running setup.py install for mozprocess 23:17:35 INFO - Running setup.py install for mozprofile 23:17:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:17:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:17:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:17:35 INFO - Running setup.py install for mozrunner 23:17:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:17:35 INFO - Running setup.py install for mozscreenshot 23:17:35 INFO - Running setup.py install for moztest 23:17:36 INFO - Running setup.py install for mozversion 23:17:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:17:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:17:36 INFO - Cleaning up... 23:17:36 INFO - Return code: 0 23:17:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0ad6e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1947930>, '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 0x1948830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1948cc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476682536.857499-617807562', '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 23:17:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:17:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:17:36 INFO - Using env: {'DISPLAY': ':0', 23:17:36 INFO - 'HOME': '/home/cltbld', 23:17:36 INFO - 'LANG': 'en_US.UTF-8', 23:17:36 INFO - 'LANGUAGE': 'en_US:en', 23:17:36 INFO - 'LOGNAME': 'cltbld', 23:17:36 INFO - 'MAIL': '/var/mail/cltbld', 23:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:36 INFO - 'MOZ_NO_REMOTE': '1', 23:17:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:36 INFO - 'NO_EM_RESTART': '1', 23:17:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:36 INFO - 'PWD': '/builds/slave/test', 23:17:36 INFO - 'SHELL': '/bin/bash', 23:17:36 INFO - 'SHLVL': '1', 23:17:36 INFO - 'TERM': 'linux', 23:17:36 INFO - 'TMOUT': '86400', 23:17:36 INFO - 'USER': 'cltbld', 23:17:36 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476682536.857499-617807562', 23:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:36 INFO - '_': '/tools/buildbot/bin/python'} 23:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:17:36 INFO - Running setup.py (path:/tmp/pip-HGDsAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:17:36 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)) 23:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:17:36 INFO - Running setup.py (path:/tmp/pip-LBtaL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:17:36 INFO - Running setup.py (path:/tmp/pip-g_uYap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:17:36 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)) 23:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:17:36 INFO - Running setup.py (path:/tmp/pip-Bx_u3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:17:36 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)) 23:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:17:36 INFO - Running setup.py (path:/tmp/pip-JLJj25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:17:36 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)) 23:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:17:36 INFO - Running setup.py (path:/tmp/pip-wVUfad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:17:36 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)) 23:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:17:36 INFO - Running setup.py (path:/tmp/pip-g7htV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:17:36 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)) 23:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:17:36 INFO - Running setup.py (path:/tmp/pip-3YSjeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:17:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:17:37 INFO - Running setup.py (path:/tmp/pip-wtQZ10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:17:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:17:37 INFO - Running setup.py (path:/tmp/pip-4Xn550-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:17:37 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)) 23:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:17:37 INFO - Running setup.py (path:/tmp/pip-RoJqp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:17:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:17:37 INFO - Running setup.py (path:/tmp/pip-pmy6k1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:17:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:17:37 INFO - Running setup.py (path:/tmp/pip-WAv9FV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:17:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:17:37 INFO - Running setup.py (path:/tmp/pip-d8S9Yk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:17:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:17:37 INFO - Running setup.py (path:/tmp/pip-XrHmQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:17:37 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)) 23:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:17:37 INFO - Running setup.py (path:/tmp/pip-wATojN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:17:37 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)) 23:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:17:37 INFO - Running setup.py (path:/tmp/pip-l_Dg3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:17:37 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)) 23:17:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:17:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:17:37 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)) 23:17:37 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)) 23:17:37 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)) 23:17:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:17:37 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 23:17:37 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 23:17:37 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 23:17:37 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 23:17:37 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 23:17:37 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 23:17:39 INFO - Downloading blessings-1.6.tar.gz 23:17:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:17:39 INFO - Installing collected packages: blessings 23:17:39 INFO - Running setup.py install for blessings 23:17:39 INFO - Successfully installed blessings 23:17:39 INFO - Cleaning up... 23:17:39 INFO - Return code: 0 23:17:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:17:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:17:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:17:40 INFO - Reading from file tmpfile_stdout 23:17:40 INFO - Current package versions: 23:17:40 INFO - argparse == 1.2.1 23:17:40 INFO - blessings == 1.6 23:17:40 INFO - blobuploader == 1.2.4 23:17:40 INFO - docopt == 0.6.1 23:17:40 INFO - functools32 == 3.2.3-2 23:17:40 INFO - jsonschema == 2.5.1 23:17:40 INFO - manifestparser == 1.1 23:17:40 INFO - mozInstall == 1.12 23:17:40 INFO - mozcrash == 0.17 23:17:40 INFO - mozdebug == 0.1 23:17:40 INFO - mozdevice == 0.48 23:17:40 INFO - mozfile == 1.2 23:17:40 INFO - mozhttpd == 0.7 23:17:40 INFO - mozinfo == 0.9 23:17:40 INFO - mozleak == 0.1 23:17:40 INFO - mozlog == 3.4 23:17:40 INFO - moznetwork == 0.27 23:17:40 INFO - mozprocess == 0.23 23:17:40 INFO - mozprofile == 0.28 23:17:40 INFO - mozrunner == 6.12 23:17:40 INFO - mozscreenshot == 0.1 23:17:40 INFO - mozsystemmonitor == 0.3 23:17:40 INFO - moztest == 0.7 23:17:40 INFO - mozversion == 1.4 23:17:40 INFO - psutil == 3.1.1 23:17:40 INFO - requests == 1.2.3 23:17:40 INFO - wsgiref == 0.1.2 23:17:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:17: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')]} 23:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17: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')]} 23:17:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0ad6e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1947930>, '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 0x1948830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1948cc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476682536.857499-617807562', '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 23:17:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 23:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:17:40 INFO - Using env: {'DISPLAY': ':0', 23:17:40 INFO - 'HOME': '/home/cltbld', 23:17:40 INFO - 'LANG': 'en_US.UTF-8', 23:17:40 INFO - 'LANGUAGE': 'en_US:en', 23:17:40 INFO - 'LOGNAME': 'cltbld', 23:17:40 INFO - 'MAIL': '/var/mail/cltbld', 23:17:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:40 INFO - 'MOZ_NO_REMOTE': '1', 23:17:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:40 INFO - 'NO_EM_RESTART': '1', 23:17:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:40 INFO - 'PWD': '/builds/slave/test', 23:17:40 INFO - 'SHELL': '/bin/bash', 23:17:40 INFO - 'SHLVL': '1', 23:17:40 INFO - 'TERM': 'linux', 23:17:40 INFO - 'TMOUT': '86400', 23:17:40 INFO - 'USER': 'cltbld', 23:17:40 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476682536.857499-617807562', 23:17:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:40 INFO - '_': '/tools/buildbot/bin/python'} 23:17:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:17:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:17:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:17:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:17:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:17:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:17:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:17:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:17:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:17:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:17:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:17:40 INFO - Cleaning up... 23:17:40 INFO - Return code: 0 23:17:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:17: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')]} 23:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17: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')]} 23:17:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0ad6e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1947930>, '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 0x1948830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1948cc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476682536.857499-617807562', '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 23:17:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:17:40 INFO - Using env: {'DISPLAY': ':0', 23:17:40 INFO - 'HOME': '/home/cltbld', 23:17:40 INFO - 'LANG': 'en_US.UTF-8', 23:17:40 INFO - 'LANGUAGE': 'en_US:en', 23:17:40 INFO - 'LOGNAME': 'cltbld', 23:17:40 INFO - 'MAIL': '/var/mail/cltbld', 23:17:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:40 INFO - 'MOZ_NO_REMOTE': '1', 23:17:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:40 INFO - 'NO_EM_RESTART': '1', 23:17:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:40 INFO - 'PWD': '/builds/slave/test', 23:17:40 INFO - 'SHELL': '/bin/bash', 23:17:40 INFO - 'SHLVL': '1', 23:17:40 INFO - 'TERM': 'linux', 23:17:40 INFO - 'TMOUT': '86400', 23:17:40 INFO - 'USER': 'cltbld', 23:17:40 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476682536.857499-617807562', 23:17:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:40 INFO - '_': '/tools/buildbot/bin/python'} 23:17:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:17:40 INFO - Cleaning up... 23:17:40 INFO - Return code: 0 23:17:40 INFO - Running post-action listener: _resource_record_post_action 23:17:40 INFO - Running post-action listener: _start_resource_monitoring 23:17:40 INFO - Starting resource monitoring. 23:17:40 INFO - [mozharness: 2016-10-17 06:17:40.536824Z] Finished create-virtualenv step (success) 23:17:40 INFO - [mozharness: 2016-10-17 06:17:40.537304Z] Running install step. 23:17:40 INFO - Running pre-action listener: _resource_record_pre_action 23:17:40 INFO - Running main action method: install 23:17:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:17:40 INFO - Reading from file tmpfile_stdout 23:17:40 INFO - Detecting whether we're running mozinstall >=1.0... 23:17:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:17:40 INFO - Reading from file tmpfile_stdout 23:17:40 INFO - Output received: 23:17:40 INFO - Usage: mozinstall [options] installer 23:17:40 INFO - Options: 23:17:40 INFO - -h, --help show this help message and exit 23:17:40 INFO - -d DEST, --destination=DEST 23:17:40 INFO - Directory to install application into. [default: 23:17:40 INFO - "/builds/slave/test"] 23:17:40 INFO - --app=APP Application being installed. [default: firefox] 23:17:40 INFO - mkdir: /builds/slave/test/build/application 23:17:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:17:57 INFO - Reading from file tmpfile_stdout 23:17:57 INFO - Output received: 23:17:57 INFO - /builds/slave/test/build/application/firefox/firefox 23:17:57 INFO - Running post-action listener: _resource_record_post_action 23:17:57 INFO - [mozharness: 2016-10-17 06:17:57.840026Z] Finished install step (success) 23:17:57 INFO - [mozharness: 2016-10-17 06:17:57.840272Z] Running run-tests step. 23:17:57 INFO - Running pre-action listener: _resource_record_pre_action 23:17:57 INFO - Running main action method: run_tests 23:17:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:17:57 INFO - Python 2.7.3 23:17:57 INFO - Return code: 0 23:17:57 INFO - grabbing minidump binary from tooltool 23:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:57 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1947930>, '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 0x1948830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1948cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:17:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:17:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:17:57 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 23:17:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:17:57 INFO - Return code: 0 23:17:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:17:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:17:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:17:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:17:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:17:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VlIQuMY_SXCZLfkKOFRPEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 23:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VlIQuMY_SXCZLfkKOFRPEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 23:17:57 INFO - Using env: {'DISPLAY': ':0', 23:17:57 INFO - 'HOME': '/home/cltbld', 23:17:57 INFO - 'LANG': 'en_US.UTF-8', 23:17:57 INFO - 'LANGUAGE': 'en_US:en', 23:17:57 INFO - 'LOGNAME': 'cltbld', 23:17:57 INFO - 'MAIL': '/var/mail/cltbld', 23:17:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:17:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:57 INFO - 'MOZ_NO_REMOTE': '1', 23:17:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:17:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:57 INFO - 'NO_EM_RESTART': '1', 23:17:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:57 INFO - 'PWD': '/builds/slave/test', 23:17:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:17:57 INFO - 'SHELL': '/bin/bash', 23:17:57 INFO - 'SHLVL': '1', 23:17:57 INFO - 'TERM': 'linux', 23:17:57 INFO - 'TMOUT': '86400', 23:17:57 INFO - 'USER': 'cltbld', 23:17:57 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476682536.857499-617807562', 23:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:57 INFO - '_': '/tools/buildbot/bin/python'} 23:17:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VlIQuMY_SXCZLfkKOFRPEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 23:17:58 INFO - mozversion application_buildid: 20161016201450 23:17:58 INFO - mozversion application_changeset: 2976adccde9b75596c469428228177ed3d0f0b61 23:17:58 INFO - mozversion application_display_name: Nightly 23:17:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:17:58 INFO - mozversion application_name: Firefox 23:17:58 INFO - mozversion application_remotingname: firefox 23:17:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:17:58 INFO - mozversion application_vendor: Mozilla 23:17:58 INFO - mozversion application_version: 52.0a1 23:17:58 INFO - mozversion platform_buildid: 20161016201450 23:17:58 INFO - mozversion platform_changeset: 2976adccde9b75596c469428228177ed3d0f0b61 23:17:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:17:58 INFO - mozversion platform_version: 52.0a1 23:17:58 INFO - using testdate: 1476685078 23:17:58 INFO - actual date: 1476685078 23:17:58 INFO - starting webserver on 'localhost:54933' 23:17:58 INFO - SUITE-START | Running 2 tests 23:17:58 INFO - TEST-START | dromaeo_css 23:17:58 INFO - operating with platform_type : linux_ 23:17:58 INFO - Initialising browser for dromaeo_css test... 23:17:58 INFO - TEST-INFO | started process 23348 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphFx_Uq/profile http://localhost:54933/getInfo.html) 23:18:03 INFO - PROCESS | 23348 | __metrics Screen width/height:1600/1200 23:18:03 INFO - PROCESS | 23348 | colorDepth:24 23:18:03 INFO - PROCESS | 23348 | Browser inner width/height: 1024/697 23:18:03 INFO - PROCESS | 23348 | __metrics 23:18:03 ERROR - PROCESS | 23348 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 23:18:04 INFO - TEST-INFO | 23348: exit 0 23:18:04 INFO - Browser initialized. 23:18:04 INFO - Running cycle 1/1 for dromaeo_css test... 23:18:04 INFO - TEST-INFO | started process 23475 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphFx_Uq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:18:16 INFO - PROCESS | 23475 | RSS: Main: 184258560 23:18:16 INFO - PROCESS | 23475 | 23:19:06 INFO - PROCESS | 23475 | 1476685146320 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] 23:21:17 INFO - PROCESS | 23475 | Cycle 1(1): loaded http://localhost:54933/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54933/tests/dromaeo/cssquery-ext.html) 23:21:18 INFO - PROCESS | 23475 | RSS: Main: 198823936 23:21:18 INFO - PROCESS | 23475 | 23:24:20 INFO - PROCESS | 23475 | Cycle 1(1): loaded http://localhost:54933/tests/dromaeo/cssquery-ext.html (next: http://localhost:54933/tests/dromaeo/cssquery-jquery.html) 23:24:20 INFO - PROCESS | 23475 | RSS: Main: 197640192 23:24:20 INFO - PROCESS | 23475 | 23:27:22 INFO - PROCESS | 23475 | Cycle 1(1): loaded http://localhost:54933/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54933/tests/dromaeo/cssquery-mootools.html) 23:27:23 INFO - PROCESS | 23475 | RSS: Main: 197918720 23:27:23 INFO - PROCESS | 23475 | 23:30:25 INFO - PROCESS | 23475 | Cycle 1(1): loaded http://localhost:54933/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54933/tests/dromaeo/cssquery-prototype.html) 23:30:25 INFO - PROCESS | 23475 | RSS: Main: 194703360 23:30:25 INFO - PROCESS | 23475 | 23:33:28 INFO - PROCESS | 23475 | Cycle 1(1): loaded http://localhost:54933/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54933/tests/dromaeo/cssquery-yui.html) 23:33:29 INFO - PROCESS | 23475 | RSS: Main: 198520832 23:33:29 INFO - PROCESS | 23475 | 23:36:31 INFO - PROCESS | 23475 | Cycle 1(1): loaded http://localhost:54933/tests/dromaeo/cssquery-yui.html (next: http://localhost:54933/tests/dromaeo/cssquery-dojo.html) 23:36:32 INFO - PROCESS | 23475 | RSS: Main: 198508544 23:36:32 INFO - PROCESS | 23475 | 23:36:32 INFO - PROCESS | 23475 | __start_tp_report 23:36:32 INFO - PROCESS | 23475 | _x_x_mozilla_page_load 23:36:32 INFO - PROCESS | 23475 | _x_x_mozilla_page_load_details 23:36:32 INFO - PROCESS | 23475 | |i|pagename|runs| 23:36:32 INFO - PROCESS | 23475 | |0;dojo.html;2998.5052466343054;3030.378772351668;3049.268175637846;3050.6339239291287;3072.416240914226;5173.224016397542;5201.2458193561915;5263.394709608391;5287.524122828944;5316.12283973144;5199.272101905736;5325.520703136717;5382.542483888874;5405.702686352259;5469.425710300411;4827.734474603886;4870.805167793284;4875.219964805632;4892.290617860408;4952.702837829724;4937.629677774181;4942.568053262744;4985.651004429691;5005.2492126181;5036.722980236085;4707.364505791708;4862.78117484714;4921.286413470045;4926.014797040571;4947.950520494803;4731.00648863739;4772.331873537708;4788.090262850047;4816.422029356465;4888.926666100011;4777.378940737716;4789.114013907439;4796.400449943757;4799.376081109468;4850.8059677612855;5249.895002099975;5281.603879709037;5300.946990530084;5307.150855863043;5319.867003324909;5433.782648694048;5515.283013208297;5540.806071787509;5601.243832082698;5606.187102870061;5619.859503512404;5644.322681278273;5668.914966275509;5681.914771278434;5684.488396044335;5273.077211487975;5297.231901374279;5308.336457942796;5310.044192045391;5360.65155764874;5729.312482502127;5764.942350576441;5777.104548794943;5798.507126894261;5810.244668193108;5359.866003349947;5412.891742165135;5473.8357849264585;5517;5609.354924183771;5637.379888212294;5662.462066103713;5663.716814159276;5701.971490142523;5720.799772008043;5467.835964921059;5511.58663100269;5565.415631358649;5609.5512359012;5613.7193140342815;5589.972050139804;5615.943840561624;5639.859003524863;5650.7174641267775;5652;4273.829046838092;4305.590968857953;4362.541933097043;4384.758838263926;4397.560243975641;3832.463455116286;3911.5697273299916;3927.116398810245;3934.6065393460426;3962.583928687504;5372.817980044384;5409.1615799550345;5448.291722076105;5467.125259958388;5515.779368825202;5485.533729632946;5540.2243685884005;5551.528120109836;5582.804601838998;5651.4348565143155;5412.296401467863;5415.864603384947;5418.83743487696;5426.457354264621;5488.25908502355;4821.566059054702;4837.879053023632;4844.15227335215;4845.466998630148;4899.069176856386;5706.714664266853;5775.65346079245;5827.271591051119;5847.239858818411;5850.268716410449;5623.0721930880945;5641.12562552805;5679.119736440858;5687.118496633028;5771.3651498335985;5892.616979896293;5903.2325797646035;5910.261217347832;5913.733881975236;5936.1689363488285;5570.805021824217;5585.441455854382;5588.776448941997;5618.88762224745;5704.828855134353;5733.627314224562;5740.598158128891;5760.222369979999;5774.538036957118;5826.533877289722;5600.27196464457;5611.6352437091455;5619.129034999582;5622.6064175508955;5630.60585758993;5406.918896216481;5409.648372855751;5424.728763561727;5438.320209973754;5624.915626265528;5439.3200849893765;5439.864003399946;5469.15228139639;5554.777808887761;5565.805196818092;5516.779328826802;5527.336719593513;5538.47384498472;5561.138023606348;5563.193336966036;5313.415524292247;5318.946810531846;5455.727213639223;5464.808731694372;5526.364468086061 23:36:32 INFO - PROCESS | 23475 | |1;ext.html;555.1478480532382;573.541167066347;577.5870252769272;580.7822066724979;598.709625831472;40418.79790601046;42398;42435.363469547985;46060.3090953636;46139;44420.3336949946;44660;44814.32778508325;44914.775426122906;44951;8884.333674974387;9029.142231487998;9038.683646072355;9042.638294468214;9051.049639787827;8852.51311177885;8909.376343655915;8912;8922.643094276222;8939.95530022349;8868.600912958933;8978.236849867737;8990;9001;9002.279817614575;8922.197002269795;8968.820623587557;8971.147740964598;8985.056569060253;8989.820203595924;8760.21158095768;8799.824003519958;8808.383413161082;8859.069797671216;8883;41376;41913.37129943053;42080.36879446811;42280.788596056824;42339.153216935796;3406.6423025582453;3436.415809312423;3454.602720687128;3658.2317713280245;3796.544414670257;31324.843375782973;31382.215444613837;31536.369272614418;31939;33056;4215.620594146541;4217.36739489076;4224.070704445017;4300.548442413564;4317.330813723878;243603;244044;244134;244167.99999999822;244512;56339.43660563342;56357.15464268039;56481.15278270829;56481.43518564762;56607.92400949881;58916.41083589195;58973.41026589679;59160;59175.112373314434;59241;15171.620709482131;15444.15057171844;15456.38174473031;15485.767713484307;15594.53216403487;11712.824307635392;11868.465919033664;11897.643070707893;11906.642800715992;11919.106067045006;16162.515124546282;16784.244708988124;16817.243224054946;16897;16969.915150424167;6367.649779262185;6393;6461.483081353575;6517.641529715911;6630.436412904957;937.5827756648363;985.9605615775289;992.245893121233;1021.8875923648393;1026.6765968719978;32362.838185809393;32369.838150809097;32392.35215295681;32447.837760811046;32580;1077.1992818671547;1125.836753670713;1186.6736647421856;1205.5479195301762;1220.853497580296;16754.246058927132;16959.576010599834;16973.575660608338;17044.829551704323;17048.829511704724;484361;488397;490741;491275;491946;56403.71798140983;56430.43569564334;56653.716731416076;56689;56765.71617141971;1281.2312612432465;1336.0580790542645;1349.38602935666;1357.8438479574777;1369.5412036967728;29515.638748900466;31448.528272076393;31689.623278253763;31716.36567268688;32077.198070048435;49638.50361496339;49649.75175124101;50005.24992125194;50123.74938125286;50142.74928625333;421464;424067;424100;424318;424333;39973;40257.597424025385;41239.1752164961;41321.79339103285;41498.227703814446;44876;45686.77156614196;45797.77101114473;46897.76551117223;47007;38872.2225555493;39376.40935386029;39386.606133938294;40658.59341406548;41333.79333103436;38837;38871.61128388793;39576;39807.20385592214;40775.38836917508;39206.41190382204;39856.800715996236;40666.79666601648;40744.185116298104;40892.18215635611;32087.67912320847;35401.64598354087;35817.82091089528;36119.81940090283;36880.262394751415;27602;27890.72109278881;28097.719022810328;28176.29559261035;28201 23:36:32 INFO - PROCESS | 23475 | |2;jquery.html;388.8230854960991;394.0896529017968;397.0807580451253;405.67951318458415;408.5771226780283;14058.367373468192;18807.623847523042;18821.62356752864;19506.31727889524;19525.023748812575;18112.27550897966;18137.093145342715;18204.453866383996;18938.431847044612;19289.903550482264;5740.311162660487;5770;5855.912161317562;5927.555433342516;5935.258092738408;5802.738876750556;5831.912521312183;5910.34986151523;5913.763449462016;5937.109433584975;5651.124075768263;5825.825225243249;5838.503727183194;5841.707914604274;5855.443732845373;5591.692456914868;5777.017906955806;5877.85305367365;5885.7351419186025;5901.645901245939;5106.540411362958;5118.283440318359;5121.359830021247;5144.588432925357;5164.251183578398;22816.31551053471;23417.531649367087;23700.407489812893;23715.88142059279;23736.101111911004;2325.5930212212793;2375.70303712036;2407.4222186675247;2419.358869899478;2490.203134996802;14058.648533786634;14334.928325358307;14923.179225142612;14977.850221497863;15424.614384640474;1853.1938606706126;1976.3082920977686;1982.8598555830456;2000.3898810862681;2007.6185524750251;49507.50492495101;51433;77237.99999999943;78864;79828;10110.69667909964;10154.187664986783;10245.180385569136;10281.53733082013;10495.737606559896;12099.395030248452;13067.085304028627;14631.780523292158;14658.853411465749;14669.119852808866;7468.626568671545;7474.215207403253;7532;7785;7874.763757087297;7187.7843664690145;7458.366038886756;7489.101307843093;7629.618519074024;7668.923310766932;3959.5050618672667;4097.44684467599;4106.917861642751;4261.126469073833;4289.785510724514;1948.1330807790398;1963.2245263120988;2016.4857961219795;2044.8568600197843;2076.781937896499;876.785187629035;903.8553831386946;980.7842274699555;1073.822819234833;1098.1708809848674;18916.62166756657;19702.931192224896;19818.60362792736;19837.20651173937;20210.191592336436;981.6417007792247;983.1151963233148;988.9406635601887;1009.0363702663939;1032.3496197395593;10467.738306542398;10970.561177552809;10970.725731856768;11093.846023172962;11141.387223702612;393183;411056;418053;420128;421180;84471.5776421114;86543;86791.56604216939;87865;89194.55402723074;975.8145952269047;1016.6492560066765;1046.199657262195;1051.369178492898;1062.176812969939;16453.8273789699;16716.916415417843;16920.830791691926;17493.562660933578;17635.647287054442;41322.58677413187;41331.7933410331;41711.374329384475;42138.367924480546;42614.78692606517;50903;53428.19857702215;54217.45782542282;57785.42214577801;57826.4217357821;7694.653740581575;7817.296443319901;8037.23646253605;8173;8257.876131857907;12847.614571562868;13320.600381988555;13358.398872050975;13545.525906593222;13721.17672939587;10989.560417583207;11089.778204435705;11137;11337.149713771665;11395.487203076047;11255.212135150789;11646.184767066563;11726.88273117258;11839.28964262147;12236.204646697935;11425.771484570429;11435.885641143816;11501.137414693763;11638.476268567765;11681.649550513499;6934.202566704894;7399.8150046249275;7510.812229694083;7916.920830791619;8760.605772740115;10158.441285729356;11107.333559986426;11220.270682405617;11273.943630281796;11558.826617600575 23:36:32 INFO - PROCESS | 23475 | |3;mootools.html;1497.273822196235;1539.6381850265186;1690.8140104588501;1755.6400937807734;1774.9112544372779;8468.364872634555;8662.653493860254;9081.091890810916;9156.496392698398;9178.311626627996;9102.590383432746;9274.118958698913;9277.95361023194;9287.117723816244;9298.674546390861;2273.318004598622;2302.5164715409783;2307.896144673494;2312.075169932024;2317.9072837086496;2309.307207837642;2312.445013196829;2354.1289722802585;2363.6336367862923;2364.1725396111397;2304.8962796674105;2307.14635584833;2317.9304620861317;2355.187460326185;2356.552255071531;2213.1589995801573;2214.9667754983607;2215.6233440315186;2217.0355895185485;2247.910083596654;2214.878181700006;2255.740589832174;2257.074599414232;2268.534950335177;2275.6472746724285;9059.229965452945;9100.180983711432;9119.589618467186;9177.265818734486;9197.540122993823;5212.947870521284;5241.711705856176;5266.605004624668;5267.578593712494;5356.0894647909945;3310.2882880180878;3324.401607710611;3542.8937131886087;3553.236054248349;3589.335972845032;1065.525841000755;1090.7709381029993;1104.6078642082025;1112.232559533927;1113.7883802077579;12262.325572093532;12263.080268979862;12350.814737778941;12387.504499820086;12431.564895228623;4263.8081286342185;4360.389545463638;4543.136804007228;4552.72363818091;4586.472555656075;9732.90267097334;9769.120779129913;9785.853212201822;9828.705138845846;9844.80310393788;5103.438621751604;5107;5144.819931302386;5163.7676304566385;5171.379434467888;4323.313907576048;4470.977645111753;4663.976680116578;4706.694064885772;4813.133635945494;3709.1654377764785;3767.321882061255;3827.234553089393;3833.3674943634546;3963.2667956428154;1138.1520767028617;1149.350616901448;1153.3310679805693;1154.7748189103213;1160.3733983648904;896.1128482801979;903.742433406476;925.3337596930199;933.3606479561522;941.152962333905;5556.472135147154;5773.191753154561;5859.794907178229;5868.119782032644;5961.821145365646;428.9319594210394;448.1753573424914;451.5078564364858;458.63767623577667;463.1986663072903;3865.8453661853773;3887.941680874789;3892.0464486200494;3898.941515877264;3905.5313362396696;10879.456027198608;11296.435178241056;11398.259113157617;11483.827742583868;11493.655190344303;11182.440877956069;11282.605108821315;11291;11324.716882078013;11336;8300.377471689648;8372.706955256537;8384.16158384169;8387.62255698495;8406.663733450716;5516.834494965157;5531.695756733418;5595.63628364155;5672.4894759471845;5679.858003549944;10188;10197.082262596401;10270.948645256725;10491.79016419652;10501.054905058581;9635.807283854143;9879.110880020833;9991.950040249752;10282.383057016305;10368.377897326185;7075.363217310261;7269.345758881726;7546.962265188639;7756.689732410866;8017.478863873829;8474.533900635524;8785.51679657625;8790.164934331227;8804.515751633466;8873;7712.228777122467;7855.489393189425;7877.094134174643;7922.168172342052;8243.711470098518;7449.739259125905;7565.848683026419;7576.583287919218;7693.038370203724;7762.7671169865;6719.260881302955;6855.485838562227;6856.280090590616;6857.485688573277;6868.107146070979;4879.731614761222;4944.703317800943;5001.374828146481;5063.480955713345;5128.820491282787;4875.488073752205;4983.825566105169;5043.041822053798;5056.873578160576;5060.696358218519 23:36:32 INFO - PROCESS | 23475 | |4;prototype.html;306.6519500367083;319.1590159928588;320.76904628667364;323.46789531221157;326.9901902942911;5246.504746147349;5386.703731294777;5463.803674850213;5472.2338872557875;5482.808101716436;5197.558207552363;5310.522053015228;5347.54545863602;5358.303420555332;5368.62419630625;4216.0935398889305;4256.957430425687;4291.527931927485;4303.160883627694;4304.24675681756;4216.7680777557225;4278.529361770203;4284.485861696601;4293.141371725652;4309.935350969738;4222.0922501662135;4232.217039847623;4254.340577210537;4255.851045213418;4283.464566929134;4192;4203.495580530356;4208.852690155861;4247.384129301249;4261.914761704748;3702.593014654441;3772.038130276762;3773.5660399054186;3811.142492939094;3814.618538146191;5219.616801547593;5240.711760853152;5245.895082098336;5257;5263.210518422229;4839.201531747258;4860.513948605147;4866.953604974948;4884.780184891652;4905.8773530661665;5552.972235138839;5665.2351932489;5665.915011274834;5671.249444019647;5703.9429605704245;4093.403572606686;4094.6110119538894;4111.465509483778;4122.958770412288;4159.168166366739;5862.912056319158;5891.293044834604;5904.911426328608;5919.467247947706;5929.584929055011;4120.011197312683;4226.429432026698;4234.70357075008;4242.490901091889;4244.363345498138;4228.851990180329;4235.2588297048505;4254.936175957363;4271.658267338606;4285.121550082225;4831;4845.442774080955;4845.854624361275;4869.464358920516;4877.3903262092235;5520.282363292747;5631.943680563142;5711.7144142792695;5732;5743.597948143673;1457.606446259504;1487.2861026707242;1487.4347747855745;1488.6352843553398;1494.1856688105008;903.6295119001178;943.7593413679468;948.5020364308793;958.6387329991429;960.2270172511196;4829.589484893823;4879.267859909752;4881.755152436106;4895.80052887045;4910.772306923269;5107.923381149286;5112.846614601568;5140.614453915971;5148.3564554430695;5164.8967020659375;4717.5282471753235;4845.248986407112;4883.853484395474;4887.193613053877;4887.36464259644;2702.8513431761444;2721.414895797413;2730.754232119079;2736.7832056034676;2738.1374866917254;5225.047847965887;5304.135766686023;5311.49540793624;5330.120530112566;5343.358996634772;4921.50784921505;5126.641135120581;5207.010667973073;5214.74846036956;5224.164133738584;5266.289050978069;5291.841244762663;5295.523402893758;5323.627346085892;5342.305500284938;5082.3138876252715;5107.744612769421;5123.897522049613;5161.354830646169;5172.353455818023;5054.342935418372;5374.355077390738;5727.513161381163;5737.713114344349;5740.339860916049;6086.513078953762;6171.321154673072;6173.166622505904;6191.938080619136;6231.096491008869;4003.159336539359;4096.344584866407;4103.548609652996;4109.732867363612;4170.958290417057;5785.537157027512;5794.913076303943;5828.446297601721;5833.854153646193;5867.119932010232;5634.85912852182;5693.743781529758;5737.56968227393;5737.741801618854;5767.442790446472;5684.090545512699;5699.658020518782;5701.458361455655;5704;5714.885702285847;5570.6657600544095;5599.720013999366;5645.661260324394;5648.5763567731765;5706.001449746194;5506.5870059746485;5652.63257888236;5663.263775709132;5678.4605462480995;5757.222774925499;5539.7784088636;5546.584006199632;5550.888982220414;5573.860653483695;5592.580556458201 23:36:32 INFO - PROCESS | 23475 | |5;yui.html;668.4051194436948;713.2546488919086;720.6180724216167;725.4087918346548;782.996085019575;13703.38334774935;14647;14726.63183420415;14762.852371476269;14845.480408185716;13018;13020.869791302084;13092.672683182926;13196.076274660778;14052.086614370084;626.8307556959618;649.4674367019046;764.1098120689418;802.1777677880191;807.309750163609;819.5451524403953;827.9213474719892;827.9379046571531;828.6478246745139;832.5795473285982;881.6914080071988;881.9294456443469;882.5763633455945;882.9955850220772;883.1124719656768;860.9870851937226;861.9138086191331;871.9476831390136;873.2490058549643;878.0867897386742;641.2945759664378;643.3084434233218;643.6170478565247;643.6620774093592;645.1902861908322;14660.340284687109;14732.48436304735;14737.778933315902;14769.261536923219;14783.482578109822;13392.129511581716;13571.592852214351;13625.454981800716;13691.452341906312;13911.930440347733;11161.218714689974;11185.440727963569;11274.887251127466;11323.32060076398;11511.654650360419;3747.7001839852746;3799.468074469549;3834.2906562286066;3884.126071633888;3925.6270654287796;78546.21453785503;81144.59427702882;81561;82111.58944205241;82696.58651706703;11237.381943992996;11413.311544344386;11430.314181149157;11464.656060318204;11517.25137866036;21296.254631088148;21400.036998335112;21436;21525;21555.137794488044;7820.726274580363;7869.252421019994;7978.880316795253;8251.917480825236;8594.570271486526;4460.30865215892;4493.483249426293;4523.434570678665;4630.53694630541;4662.673612847136;3526.5239192708655;3631.328204282216;3633.7638053526434;3634.0914771307175;3641.7268704847243;596.3589141672719;604.5194070713793;604.5526310530264;604.8639056212405;606.5026678123984;708.8653155900363;729.5330988167577;735.4961851131885;740.8294894067361;744.2026612687214;8604.182602652863;9083.45499270046;9385.343025988115;9777.755556111011;9873.851892221623;580.4195804195804;672.4116398151617;733.5378711411777;739.8594267089236;751.1474476469137;4422.977885110554;4583.770811459413;4842.7018331947165;4877.561019508261;4893.412790465096;72602.63698681473;116080.41959790316;122107;123124;124220.37889810493;104835;106766;108038;108303;111334;87643.42674299453;87679.99999999872;90156.6476502853;91534.54232728794;93071;8929.06244844282;9277.582508786985;9338.486383248986;9417.246620270225;9421.481818500048;52991.73504132609;53975;54229;54307;55576.16635750548;72344.63827680828;73667.6316618435;80245.59877200576;81398.8950828702;81930.18069819464;11777;11821.167719003224;11865.644030679094;12100.878991209975;12211.511539538318;12478.376081195722;12478.563250286197;12744.299063551223;12893.935530322664;13617.727645446837;11069.391183484986;11299;11615.245009074382;11866.110041746731;12279.754404911673;11432.714182145513;11584.189106762446;11705.707357316136;11965.880341196476;12390.380480975735;11668.899598072428;12739.74520509566;13069.869301306866;13416;13472.124311919693;10347.223958203014;11236.719082023015;11351.54593816238;11478.82781758291;11538.423078846192;10800.783984320427;10901.34591924487;11233.213675042669;11887.94056029749;11966.64100076999 23:36:32 INFO - PROCESS | 23475 | __end_tp_report 23:36:32 INFO - PROCESS | 23475 | __start_cc_report 23:36:32 INFO - PROCESS | 23475 | _x_x_mozilla_cycle_collect,312 23:36:32 INFO - PROCESS | 23475 | __end_cc_report 23:36:32 INFO - PROCESS | 23475 | __startTimestamp1476686192213__endTimestamp 23:36:32 INFO - PROCESS | 23475 | 23:36:32 INFO - PROCESS | 23475 | ------- Summary: start ------- 23:36:32 INFO - PROCESS | 23475 | Number of tests: 6 23:36:32 INFO - PROCESS | 23475 | 23:36:32 INFO - PROCESS | 23475 | [#0] dojo.html Cycles:165 Average:5265.02 Median:5455.73 stddev:587.85 (10.8%) stddev-sans-first:562.12 23:36:32 INFO - PROCESS | 23475 | Values: 2998.5 3030.4 3049.3 3050.6 3072.4 5173.2 5201.2 5263.4 5287.5 5316.1 5199.3 5325.5 5382.5 5405.7 5469.4 4827.7 4870.8 4875.2 4892.3 4952.7 4937.6 4942.6 4985.7 5005.2 5036.7 4707.4 4862.8 4921.3 4926.0 4948.0 4731.0 4772.3 4788.1 4816.4 4888.9 4777.4 4789.1 4796.4 4799.4 4850.8 5249.9 5281.6 5300.9 5307.2 5319.9 5433.8 5515.3 5540.8 5601.2 5606.2 5619.9 5644.3 5668.9 5681.9 5684.5 5273.1 5297.2 5308.3 5310.0 5360.7 5729.3 5764.9 5777.1 5798.5 5810.2 5359.9 5412.9 5473.8 5517.0 5609.4 5637.4 5662.5 5663.7 5702.0 5720.8 5467.8 5511.6 5565.4 5609.6 5613.7 5590.0 5615.9 5639.9 5650.7 5652.0 4273.8 4305.6 4362.5 4384.8 4397.6 3832.5 3911.6 3927.1 3934.6 3962.6 5372.8 5409.2 5448.3 5467.1 5515.8 5485.5 5540.2 5551.5 5582.8 5651.4 5412.3 5415.9 5418.8 5426.5 5488.3 4821.6 4837.9 4844.2 4845.5 4899.1 5706.7 5775.7 5827.3 5847.2 5850.3 5623.1 5641.1 5679.1 5687.1 5771.4 5892.6 5903.2 5910.3 5913.7 5936.2 5570.8 5585.4 5588.8 5618.9 5704.8 5733.6 5740.6 5760.2 5774.5 5826.5 5600.3 5611.6 5619.1 5622.6 5630.6 5406.9 5409.6 5424.7 5438.3 5624.9 5439.3 5439.9 5469.2 5554.8 5565.8 5516.8 5527.3 5538.5 5561.1 5563.2 5313.4 5318.9 5455.7 5464.8 5526.4 23:36:32 INFO - PROCESS | 23475 | 23:36:32 INFO - PROCESS | 23475 | [#1] ext.html Cycles:180 Average:55524.60 Median:231772.18 stddev:105789.71 (45.6%) stddev-sans-first:106005.97 23:36:32 INFO - PROCESS | 23475 | Values: 555.1 573.5 577.6 580.8 598.7 40418.8 42398.0 42435.4 46060.3 46139.0 44420.3 44660.0 44814.3 44914.8 44951.0 8884.3 9029.1 9038.7 9042.6 9051.0 8852.5 8909.4 8912.0 8922.6 8940.0 8868.6 8978.2 8990.0 9001.0 9002.3 8922.2 8968.8 8971.1 8985.1 8989.8 8760.2 8799.8 8808.4 8859.1 8883.0 41376.0 41913.4 42080.4 42280.8 42339.2 3406.6 3436.4 3454.6 3658.2 3796.5 31324.8 31382.2 31536.4 31939.0 33056.0 4215.6 4217.4 4224.1 4300.5 4317.3 243603.0 244044.0 244134.0 244168.0 244512.0 56339.4 56357.2 56481.2 56481.4 56607.9 58916.4 58973.4 59160.0 59175.1 59241.0 15171.6 15444.2 15456.4 15485.8 15594.5 11712.8 11868.5 11897.6 11906.6 11919.1 16162.5 16784.2 16817.2 16897.0 16969.9 6367.6 6393.0 6461.5 6517.6 6630.4 937.6 986.0 992.2 1021.9 1026.7 32362.8 32369.8 32392.4 32447.8 32580.0 1077.2 1125.8 1186.7 1205.5 1220.9 16754.2 16959.6 16973.6 17044.8 17048.8 484361.0 488397.0 490741.0 491275.0 491946.0 56403.7 56430.4 56653.7 56689.0 56765.7 1281.2 1336.1 1349.4 1357.8 1369.5 29515.6 31448.5 31689.6 31716.4 32077.2 49638.5 49649.8 50005.2 50123.7 50142.7 421464.0 424067.0 424100.0 424318.0 424333.0 39973.0 40257.6 41239.2 41321.8 41498.2 44876.0 45686.8 45797.8 46897.8 47007.0 38872.2 39376.4 39386.6 40658.6 41333.8 38837.0 38871.6 39576.0 39807.2 40775.4 39206.4 39856.8 40666.8 40744.2 40892.2 32087.7 35401.6 35817.8 36119.8 36880.3 27602.0 27890.7 28097.7 28176.3 28201.0 23:36:32 INFO - PROCESS | 23475 | 23:36:32 INFO - PROCESS | 23475 | [#2] jquery.html Cycles:180 Average:26180.05 Median:2413.39 stddev:68198.33 (2825.8%) stddev-sans-first:68362.15 23:36:32 INFO - PROCESS | 23475 | Values: 388.8 394.1 397.1 405.7 408.6 14058.4 18807.6 18821.6 19506.3 19525.0 18112.3 18137.1 18204.5 18938.4 19289.9 5740.3 5770.0 5855.9 5927.6 5935.3 5802.7 5831.9 5910.3 5913.8 5937.1 5651.1 5825.8 5838.5 5841.7 5855.4 5591.7 5777.0 5877.9 5885.7 5901.6 5106.5 5118.3 5121.4 5144.6 5164.3 22816.3 23417.5 23700.4 23715.9 23736.1 2325.6 2375.7 2407.4 2419.4 2490.2 14058.6 14334.9 14923.2 14977.9 15424.6 1853.2 1976.3 1982.9 2000.4 2007.6 49507.5 51433.0 77238.0 78864.0 79828.0 10110.7 10154.2 10245.2 10281.5 10495.7 12099.4 13067.1 14631.8 14658.9 14669.1 7468.6 7474.2 7532.0 7785.0 7874.8 7187.8 7458.4 7489.1 7629.6 7668.9 3959.5 4097.4 4106.9 4261.1 4289.8 1948.1 1963.2 2016.5 2044.9 2076.8 876.8 903.9 980.8 1073.8 1098.2 18916.6 19702.9 19818.6 19837.2 20210.2 981.6 983.1 988.9 1009.0 1032.3 10467.7 10970.6 10970.7 11093.8 11141.4 393183.0 411056.0 418053.0 420128.0 421180.0 84471.6 86543.0 86791.6 87865.0 89194.6 975.8 1016.6 1046.2 1051.4 1062.2 16453.8 16716.9 16920.8 17493.6 17635.6 41322.6 41331.8 41711.4 42138.4 42614.8 50903.0 53428.2 54217.5 57785.4 57826.4 7694.7 7817.3 8037.2 8173.0 8257.9 12847.6 13320.6 13358.4 13545.5 13721.2 10989.6 11089.8 11137.0 11337.1 11395.5 11255.2 11646.2 11726.9 11839.3 12236.2 11425.8 11435.9 11501.1 11638.5 11681.6 6934.2 7399.8 7510.8 7916.9 8760.6 10158.4 11107.3 11220.3 11273.9 11558.8 23:36:32 INFO - PROCESS | 23475 | 23:36:32 INFO - PROCESS | 23475 | [#3] mootools.html Cycles:180 Average:5782.05 Median:4759.91 stddev:3388.94 (71.2%) stddev-sans-first:3383.15 23:36:32 INFO - PROCESS | 23475 | Values: 1497.3 1539.6 1690.8 1755.6 1774.9 8468.4 8662.7 9081.1 9156.5 9178.3 9102.6 9274.1 9278.0 9287.1 9298.7 2273.3 2302.5 2307.9 2312.1 2317.9 2309.3 2312.4 2354.1 2363.6 2364.2 2304.9 2307.1 2317.9 2355.2 2356.6 2213.2 2215.0 2215.6 2217.0 2247.9 2214.9 2255.7 2257.1 2268.5 2275.6 9059.2 9100.2 9119.6 9177.3 9197.5 5212.9 5241.7 5266.6 5267.6 5356.1 3310.3 3324.4 3542.9 3553.2 3589.3 1065.5 1090.8 1104.6 1112.2 1113.8 12262.3 12263.1 12350.8 12387.5 12431.6 4263.8 4360.4 4543.1 4552.7 4586.5 9732.9 9769.1 9785.9 9828.7 9844.8 5103.4 5107.0 5144.8 5163.8 5171.4 4323.3 4471.0 4664.0 4706.7 4813.1 3709.2 3767.3 3827.2 3833.4 3963.3 1138.2 1149.4 1153.3 1154.8 1160.4 896.1 903.7 925.3 933.4 941.2 5556.5 5773.2 5859.8 5868.1 5961.8 428.9 448.2 451.5 458.6 463.2 3865.8 3887.9 3892.0 3898.9 3905.5 10879.5 11296.4 11398.3 11483.8 11493.7 11182.4 11282.6 11291.0 11324.7 11336.0 8300.4 8372.7 8384.2 8387.6 8406.7 5516.8 5531.7 5595.6 5672.5 5679.9 10188.0 10197.1 10270.9 10491.8 10501.1 9635.8 9879.1 9992.0 10282.4 10368.4 7075.4 7269.3 7547.0 7756.7 8017.5 8474.5 8785.5 8790.2 8804.5 8873.0 7712.2 7855.5 7877.1 7922.2 8243.7 7449.7 7565.8 7576.6 7693.0 7762.8 6719.3 6855.5 6856.3 6857.5 6868.1 4879.7 4944.7 5001.4 5063.5 5128.8 4875.5 4983.8 5043.0 5056.9 5060.7 23:36:32 INFO - PROCESS | 23475 | 23:36:32 INFO - PROCESS | 23475 | [#4] prototype.html Cycles:180 Average:4649.59 Median:5163.13 stddev:1346.59 (26.1%) stddev-sans-first:1310.32 23:36:32 INFO - PROCESS | 23475 | Values: 306.7 319.2 320.8 323.5 327.0 5246.5 5386.7 5463.8 5472.2 5482.8 5197.6 5310.5 5347.5 5358.3 5368.6 4216.1 4257.0 4291.5 4303.2 4304.2 4216.8 4278.5 4284.5 4293.1 4309.9 4222.1 4232.2 4254.3 4255.9 4283.5 4192.0 4203.5 4208.9 4247.4 4261.9 3702.6 3772.0 3773.6 3811.1 3814.6 5219.6 5240.7 5245.9 5257.0 5263.2 4839.2 4860.5 4867.0 4884.8 4905.9 5553.0 5665.2 5665.9 5671.2 5703.9 4093.4 4094.6 4111.5 4123.0 4159.2 5862.9 5891.3 5904.9 5919.5 5929.6 4120.0 4226.4 4234.7 4242.5 4244.4 4228.9 4235.3 4254.9 4271.7 4285.1 4831.0 4845.4 4845.9 4869.5 4877.4 5520.3 5631.9 5711.7 5732.0 5743.6 1457.6 1487.3 1487.4 1488.6 1494.2 903.6 943.8 948.5 958.6 960.2 4829.6 4879.3 4881.8 4895.8 4910.8 5107.9 5112.8 5140.6 5148.4 5164.9 4717.5 4845.2 4883.9 4887.2 4887.4 2702.9 2721.4 2730.8 2736.8 2738.1 5225.0 5304.1 5311.5 5330.1 5343.4 4921.5 5126.6 5207.0 5214.7 5224.2 5266.3 5291.8 5295.5 5323.6 5342.3 5082.3 5107.7 5123.9 5161.4 5172.4 5054.3 5374.4 5727.5 5737.7 5740.3 6086.5 6171.3 6173.2 6191.9 6231.1 4003.2 4096.3 4103.5 4109.7 4171.0 5785.5 5794.9 5828.4 5833.9 5867.1 5634.9 5693.7 5737.6 5737.7 5767.4 5684.1 5699.7 5701.5 5704.0 5714.9 5570.7 5599.7 5645.7 5648.6 5706.0 5506.6 5652.6 5663.3 5678.5 5757.2 5539.8 5546.6 5550.9 5573.9 5592.6 23:36:32 INFO - PROCESS | 23475 | 23:36:32 INFO - PROCESS | 23475 | [#5] yui.html Cycles:180 Average:21027.78 Median:4476.90 stddev:31325.12 (699.7%) stddev-sans-first:31375.69 23:36:32 INFO - PROCESS | 23475 | Values: 668.4 713.3 720.6 725.4 783.0 13703.4 14647.0 14726.6 14762.9 14845.5 13018.0 13020.9 13092.7 13196.1 14052.1 626.8 649.5 764.1 802.2 807.3 819.5 827.9 827.9 828.6 832.6 881.7 881.9 882.6 883.0 883.1 861.0 861.9 871.9 873.2 878.1 641.3 643.3 643.6 643.7 645.2 14660.3 14732.5 14737.8 14769.3 14783.5 13392.1 13571.6 13625.5 13691.5 13911.9 11161.2 11185.4 11274.9 11323.3 11511.7 3747.7 3799.5 3834.3 3884.1 3925.6 78546.2 81144.6 81561.0 82111.6 82696.6 11237.4 11413.3 11430.3 11464.7 11517.3 21296.3 21400.0 21436.0 21525.0 21555.1 7820.7 7869.3 7978.9 8251.9 8594.6 4460.3 4493.5 4523.4 4630.5 4662.7 3526.5 3631.3 3633.8 3634.1 3641.7 596.4 604.5 604.6 604.9 606.5 708.9 729.5 735.5 740.8 744.2 8604.2 9083.5 9385.3 9777.8 9873.9 580.4 672.4 733.5 739.9 751.1 4423.0 4583.8 4842.7 4877.6 4893.4 72602.6 116080.4 122107.0 123124.0 124220.4 104835.0 106766.0 108038.0 108303.0 111334.0 87643.4 87680.0 90156.6 91534.5 93071.0 8929.1 9277.6 9338.5 9417.2 9421.5 52991.7 53975.0 54229.0 54307.0 55576.2 72344.6 73667.6 80245.6 81398.9 81930.2 11777.0 11821.2 11865.6 12100.9 12211.5 12478.4 12478.6 12744.3 12893.9 13617.7 11069.4 11299.0 11615.2 11866.1 12279.8 11432.7 11584.2 11705.7 11965.9 12390.4 11668.9 12739.7 13069.9 13416.0 13472.1 10347.2 11236.7 11351.5 11478.8 11538.4 10800.8 10901.3 11233.2 11887.9 11966.6 23:36:32 INFO - PROCESS | 23475 | -------- Summary: end -------- 23:36:32 INFO - PROCESS | 23475 | 23:36:33 INFO - TEST-INFO | 23475: exit 0 23:36:33 INFO - TEST-OK | dromaeo_css | took 1115179ms 23:36:33 INFO - TEST-START | kraken 23:36:33 INFO - operating with platform_type : linux_ 23:36:33 INFO - Initialising browser for kraken test... 23:36:33 INFO - TEST-INFO | started process 23841 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsNg4vA/profile http://localhost:54933/getInfo.html) 23:36:38 INFO - PROCESS | 23841 | __metrics Screen width/height:1600/1200 23:36:38 INFO - PROCESS | 23841 | colorDepth:24 23:36:38 INFO - PROCESS | 23841 | Browser inner width/height: 1024/697 23:36:38 INFO - PROCESS | 23841 | __metrics 23:36:38 ERROR - PROCESS | 23841 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 23:36:39 INFO - TEST-INFO | 23841: exit 0 23:36:39 INFO - Browser initialized. 23:36:39 INFO - Running cycle 1/1 for kraken test... 23:36:39 INFO - TEST-INFO | started process 23965 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsNg4vA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:36:51 INFO - PROCESS | 23965 | RSS: Main: 184750080 23:36:51 INFO - PROCESS | 23965 | 23:36:54 INFO - PROCESS | 23965 | Cycle 1(1): loaded http://localhost:54933/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54933/tests/kraken/driver.html?testName=audio-beat-detection) 23:36:55 INFO - PROCESS | 23965 | RSS: Main: 199249920 23:36:55 INFO - PROCESS | 23965 | 23:36:58 INFO - PROCESS | 23965 | Cycle 1(1): loaded http://localhost:54933/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54933/tests/kraken/driver.html?testName=audio-dft) 23:36:58 INFO - PROCESS | 23965 | RSS: Main: 196722688 23:36:58 INFO - PROCESS | 23965 | 23:37:01 INFO - PROCESS | 23965 | Cycle 1(1): loaded http://localhost:54933/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54933/tests/kraken/driver.html?testName=audio-fft) 23:37:02 INFO - PROCESS | 23965 | RSS: Main: 192331776 23:37:02 INFO - PROCESS | 23965 | 23:37:04 INFO - PROCESS | 23965 | Cycle 1(1): loaded http://localhost:54933/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54933/tests/kraken/driver.html?testName=audio-oscillator) 23:37:05 INFO - PROCESS | 23965 | RSS: Main: 192819200 23:37:05 INFO - PROCESS | 23965 | 23:37:07 INFO - PROCESS | 23965 | Cycle 1(1): loaded http://localhost:54933/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54933/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:37:07 INFO - PROCESS | 23965 | RSS: Main: 193699840 23:37:07 INFO - PROCESS | 23965 | 23:37:11 INFO - PROCESS | 23965 | Cycle 1(1): loaded http://localhost:54933/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54933/tests/kraken/driver.html?testName=imaging-darkroom) 23:37:11 INFO - PROCESS | 23965 | RSS: Main: 193327104 23:37:11 INFO - PROCESS | 23965 | 23:37:15 INFO - PROCESS | 23965 | Cycle 1(1): loaded http://localhost:54933/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54933/tests/kraken/driver.html?testName=imaging-desaturate) 23:37:15 INFO - PROCESS | 23965 | RSS: Main: 191365120 23:37:15 INFO - PROCESS | 23965 | 23:37:18 INFO - PROCESS | 23965 | Cycle 1(1): loaded http://localhost:54933/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54933/tests/kraken/driver.html?testName=json-parse-financial) 23:37:19 INFO - PROCESS | 23965 | RSS: Main: 193318912 23:37:19 INFO - PROCESS | 23965 | 23:37:20 INFO - PROCESS | 23965 | Cycle 1(1): loaded http://localhost:54933/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54933/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:37:21 INFO - PROCESS | 23965 | RSS: Main: 193146880 23:37:21 INFO - PROCESS | 23965 | 23:37:23 INFO - PROCESS | 23965 | Cycle 1(1): loaded http://localhost:54933/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54933/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:37:23 INFO - PROCESS | 23965 | RSS: Main: 193392640 23:37:23 INFO - PROCESS | 23965 | 23:37:26 INFO - PROCESS | 23965 | Cycle 1(1): loaded http://localhost:54933/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54933/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:37:26 INFO - PROCESS | 23965 | RSS: Main: 193355776 23:37:26 INFO - PROCESS | 23965 | 23:37:29 INFO - PROCESS | 23965 | Cycle 1(1): loaded http://localhost:54933/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54933/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:37:30 INFO - PROCESS | 23965 | RSS: Main: 193855488 23:37:30 INFO - PROCESS | 23965 | 23:37:32 INFO - PROCESS | 23965 | Cycle 1(1): loaded http://localhost:54933/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54933/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:37:33 INFO - PROCESS | 23965 | RSS: Main: 194170880 23:37:33 INFO - PROCESS | 23965 | 23:37:35 INFO - PROCESS | 23965 | Cycle 1(1): loaded http://localhost:54933/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54933/tests/kraken/driver.html?testName=ai-astar) 23:37:35 INFO - PROCESS | 23965 | RSS: Main: 195428352 23:37:35 INFO - PROCESS | 23965 | 23:37:35 INFO - PROCESS | 23965 | __start_tp_report 23:37:35 INFO - PROCESS | 23965 | _x_x_mozilla_page_load 23:37:35 INFO - PROCESS | 23965 | _x_x_mozilla_page_load_details 23:37:35 INFO - PROCESS | 23965 | |i|pagename|runs| 23:37:35 INFO - PROCESS | 23965 | |0;ai-astar;104;114;113;113;113;112;113;114;116;114 23:37:35 INFO - PROCESS | 23965 | |1;audio-beat-detection;158;124;126;166;129;125;122;124;162;133 23:37:35 INFO - PROCESS | 23965 | |2;audio-dft;162;165;166;175;163;161;162;164;166;161 23:37:35 INFO - PROCESS | 23965 | |3;audio-fft;76;77;76;121;76;75;76;76;103;77 23:37:35 INFO - PROCESS | 23965 | |4;audio-oscillator;84;83;117;82;83;85;102;82;84;110 23:37:35 INFO - PROCESS | 23965 | |5;imaging-gaussian-blur;118;118;117;118;119;119;118;119;118;118 23:37:35 INFO - PROCESS | 23965 | |6;imaging-darkroom;148;147;148;147;147;146;146;147;148;147 23:37:35 INFO - PROCESS | 23965 | |7;imaging-desaturate;96;97;97;96;96;96;96;96;96;97 23:37:35 INFO - PROCESS | 23965 | |8;json-parse-financial;54;59;53;55;57;54;55;56;63;56 23:37:35 INFO - PROCESS | 23965 | |9;json-stringify-tinderbox;63;62;63;63;65;63;62;63;63;63 23:37:35 INFO - PROCESS | 23965 | |10;stanford-crypto-aes;80;90;91;87;82;80;82;81;80;80 23:37:35 INFO - PROCESS | 23965 | |11;stanford-crypto-ccm;140;132;143;129;134;140;144;136;164;137 23:37:35 INFO - PROCESS | 23965 | |12;stanford-crypto-pbkdf2;164;163;165;166;167;164;161;163;162;169 23:37:35 INFO - PROCESS | 23965 | |13;stanford-crypto-sha256-iterative;69;67;72;65;69;66;64;66;65;65 23:37:35 INFO - PROCESS | 23965 | __end_tp_report 23:37:35 INFO - PROCESS | 23965 | __start_cc_report 23:37:35 INFO - PROCESS | 23965 | _x_x_mozilla_cycle_collect,768 23:37:35 INFO - PROCESS | 23965 | __end_cc_report 23:37:35 INFO - PROCESS | 23965 | __startTimestamp1476686255575__endTimestamp 23:37:35 INFO - PROCESS | 23965 | 23:37:35 INFO - PROCESS | 23965 | ------- Summary: start ------- 23:37:35 INFO - PROCESS | 23965 | Number of tests: 14 23:37:35 INFO - PROCESS | 23965 | 23:37:35 INFO - PROCESS | 23965 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.50 stddev:3.20 (2.8%) stddev-sans-first:1.13 23:37:35 INFO - PROCESS | 23965 | Values: 104.0 114.0 113.0 113.0 113.0 112.0 113.0 114.0 116.0 114.0 23:37:35 INFO - PROCESS | 23965 | 23:37:35 INFO - PROCESS | 23965 | [#1] audio-beat-detection Cycles:10 Average:136.90 Median:131.00 stddev:17.69 (13.5%) stddev-sans-first:17.03 23:37:35 INFO - PROCESS | 23965 | Values: 158.0 124.0 126.0 166.0 129.0 125.0 122.0 124.0 162.0 133.0 23:37:35 INFO - PROCESS | 23965 | 23:37:35 INFO - PROCESS | 23965 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.50 stddev:4.14 (2.5%) stddev-sans-first:4.29 23:37:35 INFO - PROCESS | 23965 | Values: 162.0 165.0 166.0 175.0 163.0 161.0 162.0 164.0 166.0 161.0 23:37:35 INFO - PROCESS | 23965 | 23:37:35 INFO - PROCESS | 23965 | [#3] audio-fft Cycles:10 Average:83.30 Median:76.00 stddev:15.72 (20.7%) stddev-sans-first:16.45 23:37:35 INFO - PROCESS | 23965 | Values: 76.0 77.0 76.0 121.0 76.0 75.0 76.0 76.0 103.0 77.0 23:37:35 INFO - PROCESS | 23965 | 23:37:35 INFO - PROCESS | 23965 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:83.00 stddev:13.26 (16.0%) stddev-sans-first:13.80 23:37:35 INFO - PROCESS | 23965 | Values: 84.0 83.0 117.0 82.0 83.0 85.0 102.0 82.0 84.0 110.0 23:37:35 INFO - PROCESS | 23965 | 23:37:35 INFO - PROCESS | 23965 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 23:37:35 INFO - PROCESS | 23965 | Values: 118.0 118.0 117.0 118.0 119.0 119.0 118.0 119.0 118.0 118.0 23:37:35 INFO - PROCESS | 23965 | 23:37:35 INFO - PROCESS | 23965 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 23:37:35 INFO - PROCESS | 23965 | Values: 148.0 147.0 148.0 147.0 147.0 146.0 146.0 147.0 148.0 147.0 23:37:35 INFO - PROCESS | 23965 | 23:37:35 INFO - PROCESS | 23965 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 23:37:35 INFO - PROCESS | 23965 | Values: 96.0 97.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 23:37:35 INFO - PROCESS | 23965 | 23:37:35 INFO - PROCESS | 23965 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:2.94 (5.2%) stddev-sans-first:3.00 23:37:35 INFO - PROCESS | 23965 | Values: 54.0 59.0 53.0 55.0 57.0 54.0 55.0 56.0 63.0 56.0 23:37:35 INFO - PROCESS | 23965 | 23:37:35 INFO - PROCESS | 23965 | [#9] json-stringify-tinderbox Cycles:10 Average:63.00 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 23:37:35 INFO - PROCESS | 23965 | Values: 63.0 62.0 63.0 63.0 65.0 63.0 62.0 63.0 63.0 63.0 23:37:35 INFO - PROCESS | 23965 | 23:37:35 INFO - PROCESS | 23965 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:82.00 stddev:4.35 (5.3%) stddev-sans-first:4.44 23:37:35 INFO - PROCESS | 23965 | Values: 80.0 90.0 91.0 87.0 82.0 80.0 82.0 81.0 80.0 80.0 23:37:35 INFO - PROCESS | 23965 | 23:37:35 INFO - PROCESS | 23965 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:140.00 stddev:9.70 (6.9%) stddev-sans-first:10.29 23:37:35 INFO - PROCESS | 23965 | Values: 140.0 132.0 143.0 129.0 134.0 140.0 144.0 136.0 164.0 137.0 23:37:35 INFO - PROCESS | 23965 | 23:37:35 INFO - PROCESS | 23965 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.40 Median:164.50 stddev:2.41 (1.5%) stddev-sans-first:2.55 23:37:35 INFO - PROCESS | 23965 | Values: 164.0 163.0 165.0 166.0 167.0 164.0 161.0 163.0 162.0 169.0 23:37:35 INFO - PROCESS | 23965 | 23:37:35 INFO - PROCESS | 23965 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:66.50 stddev:2.49 (3.7%) stddev-sans-first:2.51 23:37:35 INFO - PROCESS | 23965 | Values: 69.0 67.0 72.0 65.0 69.0 66.0 64.0 66.0 65.0 65.0 23:37:35 INFO - PROCESS | 23965 | -------- Summary: end -------- 23:37:35 INFO - PROCESS | 23965 | 23:37:35 INFO - PROCESS | 23965 | 23:37:35 INFO - PROCESS | 23965 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 23:37:35 INFO - PROCESS | 23965 | 23:37:35 INFO - PROCESS | 23965 | 23:37:35 INFO - PROCESS | 23965 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 23:37:35 INFO - PROCESS | 23965 | 23:37:35 INFO - PROCESS | 23965 | 23:37:35 INFO - PROCESS | 23965 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 23:37:35 INFO - PROCESS | 23965 | 23:37:35 INFO - PROCESS | 23965 | 23:37:35 INFO - PROCESS | 23965 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000A,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 23:37:35 INFO - PROCESS | 23965 | 23:37:35 INFO - PROCESS | 23965 | 23:37:35 INFO - PROCESS | 23965 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 23:37:35 INFO - PROCESS | 23965 | 23:37:36 INFO - TEST-INFO | 23965: exit 0 23:37:36 INFO - TEST-OK | kraken | took 63438ms 23:37:36 INFO - SUITE-END | took 1178s 23:37:36 INFO - Completed test suite (00:19:38) 23:37:36 INFO - javascript benchmark 23:37:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7122.43180415337, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2998.5052466343054, 3030.378772351668, 3049.268175637846, 3050.6339239291287, 3072.416240914226, 5173.224016397542, 5201.2458193561915, 5263.394709608391, 5287.524122828944, 5316.12283973144, 5199.272101905736, 5325.520703136717, 5382.542483888874, 5405.702686352259, 5469.425710300411, 4827.734474603886, 4870.805167793284, 4875.219964805632, 4892.290617860408, 4952.702837829724, 4937.629677774181, 4942.568053262744, 4985.651004429691, 5005.2492126181, 5036.722980236085, 4707.364505791708, 4862.78117484714, 4921.286413470045, 4926.014797040571, 4947.950520494803, 4731.00648863739, 4772.331873537708, 4788.090262850047, 4816.422029356465, 4888.926666100011, 4777.378940737716, 4789.114013907439, 4796.400449943757, 4799.376081109468, 4850.8059677612855, 5249.895002099975, 5281.603879709037, 5300.946990530084, 5307.150855863043, 5319.867003324909, 5433.782648694048, 5515.283013208297, 5540.806071787509, 5601.243832082698, 5606.187102870061, 5619.859503512404, 5644.322681278273, 5668.914966275509, 5681.914771278434, 5684.488396044335, 5273.077211487975, 5297.231901374279, 5308.336457942796, 5310.044192045391, 5360.65155764874, 5729.312482502127, 5764.942350576441, 5777.104548794943, 5798.507126894261, 5810.244668193108, 5359.866003349947, 5412.891742165135, 5473.8357849264585, 5517.0, 5609.354924183771, 5637.379888212294, 5662.462066103713, 5663.716814159276, 5701.971490142523, 5720.799772008043, 5467.835964921059, 5511.58663100269, 5565.415631358649, 5609.5512359012, 5613.7193140342815, 5589.972050139804, 5615.943840561624, 5639.859003524863, 5650.7174641267775, 5652.0, 4273.829046838092, 4305.590968857953, 4362.541933097043, 4384.758838263926, 4397.560243975641, 3832.463455116286, 3911.5697273299916, 3927.116398810245, 3934.6065393460426, 3962.583928687504, 5372.817980044384, 5409.1615799550345, 5448.291722076105, 5467.125259958388, 5515.779368825202, 5485.533729632946, 5540.2243685884005, 5551.528120109836, 5582.804601838998, 5651.4348565143155, 5412.296401467863, 5415.864603384947, 5418.83743487696, 5426.457354264621, 5488.25908502355, 4821.566059054702, 4837.879053023632, 4844.15227335215, 4845.466998630148, 4899.069176856386, 5706.714664266853, 5775.65346079245, 5827.271591051119, 5847.239858818411, 5850.268716410449, 5623.0721930880945, 5641.12562552805, 5679.119736440858, 5687.118496633028, 5771.3651498335985, 5892.616979896293, 5903.2325797646035, 5910.261217347832, 5913.733881975236, 5936.1689363488285, 5570.805021824217, 5585.441455854382, 5588.776448941997, 5618.88762224745, 5704.828855134353, 5733.627314224562, 5740.598158128891, 5760.222369979999, 5774.538036957118, 5826.533877289722, 5600.27196464457, 5611.6352437091455, 5619.129034999582, 5622.6064175508955, 5630.60585758993, 5406.918896216481, 5409.648372855751, 5424.728763561727, 5438.320209973754, 5624.915626265528, 5439.3200849893765, 5439.864003399946, 5469.15228139639, 5554.777808887761, 5565.805196818092, 5516.779328826802, 5527.336719593513, 5538.47384498472, 5561.138023606348, 5563.193336966036, 5313.415524292247, 5318.946810531846, 5455.727213639223, 5464.808731694372, 5526.364468086061], "value": 5225.6385783932255, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.1478480532382, 573.541167066347, 577.5870252769272, 580.7822066724979, 598.709625831472, 40418.79790601046, 42398.0, 42435.363469547985, 46060.3090953636, 46139.0, 44420.3336949946, 44660.0, 44814.32778508325, 44914.775426122906, 44951.0, 8884.333674974387, 9029.142231487998, 9038.683646072355, 9042.638294468214, 9051.049639787827, 8852.51311177885, 8909.376343655915, 8912.0, 8922.643094276222, 8939.95530022349, 8868.600912958933, 8978.236849867737, 8990.0, 9001.0, 9002.279817614575, 8922.197002269795, 8968.820623587557, 8971.147740964598, 8985.056569060253, 8989.820203595924, 8760.21158095768, 8799.824003519958, 8808.383413161082, 8859.069797671216, 8883.0, 41376.0, 41913.37129943053, 42080.36879446811, 42280.788596056824, 42339.153216935796, 3406.6423025582453, 3436.415809312423, 3454.602720687128, 3658.2317713280245, 3796.544414670257, 31324.843375782973, 31382.215444613837, 31536.369272614418, 31939.0, 33056.0, 4215.620594146541, 4217.36739489076, 4224.070704445017, 4300.548442413564, 4317.330813723878, 243603.0, 244044.0, 244134.0, 244167.99999999822, 244512.0, 56339.43660563342, 56357.15464268039, 56481.15278270829, 56481.43518564762, 56607.92400949881, 58916.41083589195, 58973.41026589679, 59160.0, 59175.112373314434, 59241.0, 15171.620709482131, 15444.15057171844, 15456.38174473031, 15485.767713484307, 15594.53216403487, 11712.824307635392, 11868.465919033664, 11897.643070707893, 11906.642800715992, 11919.106067045006, 16162.515124546282, 16784.244708988124, 16817.243224054946, 16897.0, 16969.915150424167, 6367.649779262185, 6393.0, 6461.483081353575, 6517.641529715911, 6630.436412904957, 937.5827756648363, 985.9605615775289, 992.245893121233, 1021.8875923648393, 1026.6765968719978, 32362.838185809393, 32369.838150809097, 32392.35215295681, 32447.837760811046, 32580.0, 1077.1992818671547, 1125.836753670713, 1186.6736647421856, 1205.5479195301762, 1220.853497580296, 16754.246058927132, 16959.576010599834, 16973.575660608338, 17044.829551704323, 17048.829511704724, 484361.0, 488397.0, 490741.0, 491275.0, 491946.0, 56403.71798140983, 56430.43569564334, 56653.716731416076, 56689.0, 56765.71617141971, 1281.2312612432465, 1336.0580790542645, 1349.38602935666, 1357.8438479574777, 1369.5412036967728, 29515.638748900466, 31448.528272076393, 31689.623278253763, 31716.36567268688, 32077.198070048435, 49638.50361496339, 49649.75175124101, 50005.24992125194, 50123.74938125286, 50142.74928625333, 421464.0, 424067.0, 424100.0, 424318.0, 424333.0, 39973.0, 40257.597424025385, 41239.1752164961, 41321.79339103285, 41498.227703814446, 44876.0, 45686.77156614196, 45797.77101114473, 46897.76551117223, 47007.0, 38872.2225555493, 39376.40935386029, 39386.606133938294, 40658.59341406548, 41333.79333103436, 38837.0, 38871.61128388793, 39576.0, 39807.20385592214, 40775.38836917508, 39206.41190382204, 39856.800715996236, 40666.79666601648, 40744.185116298104, 40892.18215635611, 32087.67912320847, 35401.64598354087, 35817.82091089528, 36119.81940090283, 36880.262394751415, 27602.0, 27890.72109278881, 28097.719022810328, 28176.29559261035, 28201.0], "value": 19681.657599499147, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.8230854960991, 394.0896529017968, 397.0807580451253, 405.67951318458415, 408.5771226780283, 14058.367373468192, 18807.623847523042, 18821.62356752864, 19506.31727889524, 19525.023748812575, 18112.27550897966, 18137.093145342715, 18204.453866383996, 18938.431847044612, 19289.903550482264, 5740.311162660487, 5770.0, 5855.912161317562, 5927.555433342516, 5935.258092738408, 5802.738876750556, 5831.912521312183, 5910.34986151523, 5913.763449462016, 5937.109433584975, 5651.124075768263, 5825.825225243249, 5838.503727183194, 5841.707914604274, 5855.443732845373, 5591.692456914868, 5777.017906955806, 5877.85305367365, 5885.7351419186025, 5901.645901245939, 5106.540411362958, 5118.283440318359, 5121.359830021247, 5144.588432925357, 5164.251183578398, 22816.31551053471, 23417.531649367087, 23700.407489812893, 23715.88142059279, 23736.101111911004, 2325.5930212212793, 2375.70303712036, 2407.4222186675247, 2419.358869899478, 2490.203134996802, 14058.648533786634, 14334.928325358307, 14923.179225142612, 14977.850221497863, 15424.614384640474, 1853.1938606706126, 1976.3082920977686, 1982.8598555830456, 2000.3898810862681, 2007.6185524750251, 49507.50492495101, 51433.0, 77237.99999999943, 78864.0, 79828.0, 10110.69667909964, 10154.187664986783, 10245.180385569136, 10281.53733082013, 10495.737606559896, 12099.395030248452, 13067.085304028627, 14631.780523292158, 14658.853411465749, 14669.119852808866, 7468.626568671545, 7474.215207403253, 7532.0, 7785.0, 7874.763757087297, 7187.7843664690145, 7458.366038886756, 7489.101307843093, 7629.618519074024, 7668.923310766932, 3959.5050618672667, 4097.44684467599, 4106.917861642751, 4261.126469073833, 4289.785510724514, 1948.1330807790398, 1963.2245263120988, 2016.4857961219795, 2044.8568600197843, 2076.781937896499, 876.785187629035, 903.8553831386946, 980.7842274699555, 1073.822819234833, 1098.1708809848674, 18916.62166756657, 19702.931192224896, 19818.60362792736, 19837.20651173937, 20210.191592336436, 981.6417007792247, 983.1151963233148, 988.9406635601887, 1009.0363702663939, 1032.3496197395593, 10467.738306542398, 10970.561177552809, 10970.725731856768, 11093.846023172962, 11141.387223702612, 393183.0, 411056.0, 418053.0, 420128.0, 421180.0, 84471.5776421114, 86543.0, 86791.56604216939, 87865.0, 89194.55402723074, 975.8145952269047, 1016.6492560066765, 1046.199657262195, 1051.369178492898, 1062.176812969939, 16453.8273789699, 16716.916415417843, 16920.830791691926, 17493.562660933578, 17635.647287054442, 41322.58677413187, 41331.7933410331, 41711.374329384475, 42138.367924480546, 42614.78692606517, 50903.0, 53428.19857702215, 54217.45782542282, 57785.42214577801, 57826.4217357821, 7694.653740581575, 7817.296443319901, 8037.23646253605, 8173.0, 8257.876131857907, 12847.614571562868, 13320.600381988555, 13358.398872050975, 13545.525906593222, 13721.17672939587, 10989.560417583207, 11089.778204435705, 11137.0, 11337.149713771665, 11395.487203076047, 11255.212135150789, 11646.184767066563, 11726.88273117258, 11839.28964262147, 12236.204646697935, 11425.771484570429, 11435.885641143816, 11501.137414693763, 11638.476268567765, 11681.649550513499, 6934.202566704894, 7399.8150046249275, 7510.812229694083, 7916.920830791619, 8760.605772740115, 10158.441285729356, 11107.333559986426, 11220.270682405617, 11273.943630281796, 11558.826617600575], "value": 9027.978581805573, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1497.273822196235, 1539.6381850265186, 1690.8140104588501, 1755.6400937807734, 1774.9112544372779, 8468.364872634555, 8662.653493860254, 9081.091890810916, 9156.496392698398, 9178.311626627996, 9102.590383432746, 9274.118958698913, 9277.95361023194, 9287.117723816244, 9298.674546390861, 2273.318004598622, 2302.5164715409783, 2307.896144673494, 2312.075169932024, 2317.9072837086496, 2309.307207837642, 2312.445013196829, 2354.1289722802585, 2363.6336367862923, 2364.1725396111397, 2304.8962796674105, 2307.14635584833, 2317.9304620861317, 2355.187460326185, 2356.552255071531, 2213.1589995801573, 2214.9667754983607, 2215.6233440315186, 2217.0355895185485, 2247.910083596654, 2214.878181700006, 2255.740589832174, 2257.074599414232, 2268.534950335177, 2275.6472746724285, 9059.229965452945, 9100.180983711432, 9119.589618467186, 9177.265818734486, 9197.540122993823, 5212.947870521284, 5241.711705856176, 5266.605004624668, 5267.578593712494, 5356.0894647909945, 3310.2882880180878, 3324.401607710611, 3542.8937131886087, 3553.236054248349, 3589.335972845032, 1065.525841000755, 1090.7709381029993, 1104.6078642082025, 1112.232559533927, 1113.7883802077579, 12262.325572093532, 12263.080268979862, 12350.814737778941, 12387.504499820086, 12431.564895228623, 4263.8081286342185, 4360.389545463638, 4543.136804007228, 4552.72363818091, 4586.472555656075, 9732.90267097334, 9769.120779129913, 9785.853212201822, 9828.705138845846, 9844.80310393788, 5103.438621751604, 5107.0, 5144.819931302386, 5163.7676304566385, 5171.379434467888, 4323.313907576048, 4470.977645111753, 4663.976680116578, 4706.694064885772, 4813.133635945494, 3709.1654377764785, 3767.321882061255, 3827.234553089393, 3833.3674943634546, 3963.2667956428154, 1138.1520767028617, 1149.350616901448, 1153.3310679805693, 1154.7748189103213, 1160.3733983648904, 896.1128482801979, 903.742433406476, 925.3337596930199, 933.3606479561522, 941.152962333905, 5556.472135147154, 5773.191753154561, 5859.794907178229, 5868.119782032644, 5961.821145365646, 428.9319594210394, 448.1753573424914, 451.5078564364858, 458.63767623577667, 463.1986663072903, 3865.8453661853773, 3887.941680874789, 3892.0464486200494, 3898.941515877264, 3905.5313362396696, 10879.456027198608, 11296.435178241056, 11398.259113157617, 11483.827742583868, 11493.655190344303, 11182.440877956069, 11282.605108821315, 11291.0, 11324.716882078013, 11336.0, 8300.377471689648, 8372.706955256537, 8384.16158384169, 8387.62255698495, 8406.663733450716, 5516.834494965157, 5531.695756733418, 5595.63628364155, 5672.4894759471845, 5679.858003549944, 10188.0, 10197.082262596401, 10270.948645256725, 10491.79016419652, 10501.054905058581, 9635.807283854143, 9879.110880020833, 9991.950040249752, 10282.383057016305, 10368.377897326185, 7075.363217310261, 7269.345758881726, 7546.962265188639, 7756.689732410866, 8017.478863873829, 8474.533900635524, 8785.51679657625, 8790.164934331227, 8804.515751633466, 8873.0, 7712.228777122467, 7855.489393189425, 7877.094134174643, 7922.168172342052, 8243.711470098518, 7449.739259125905, 7565.848683026419, 7576.583287919218, 7693.038370203724, 7762.7671169865, 6719.260881302955, 6855.485838562227, 6856.280090590616, 6857.485688573277, 6868.107146070979, 4879.731614761222, 4944.703317800943, 5001.374828146481, 5063.480955713345, 5128.820491282787, 4875.488073752205, 4983.825566105169, 5043.041822053798, 5056.873578160576, 5060.696358218519], "value": 4506.758037720832, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.6519500367083, 319.1590159928588, 320.76904628667364, 323.46789531221157, 326.9901902942911, 5246.504746147349, 5386.703731294777, 5463.803674850213, 5472.2338872557875, 5482.808101716436, 5197.558207552363, 5310.522053015228, 5347.54545863602, 5358.303420555332, 5368.62419630625, 4216.0935398889305, 4256.957430425687, 4291.527931927485, 4303.160883627694, 4304.24675681756, 4216.7680777557225, 4278.529361770203, 4284.485861696601, 4293.141371725652, 4309.935350969738, 4222.0922501662135, 4232.217039847623, 4254.340577210537, 4255.851045213418, 4283.464566929134, 4192.0, 4203.495580530356, 4208.852690155861, 4247.384129301249, 4261.914761704748, 3702.593014654441, 3772.038130276762, 3773.5660399054186, 3811.142492939094, 3814.618538146191, 5219.616801547593, 5240.711760853152, 5245.895082098336, 5257.0, 5263.210518422229, 4839.201531747258, 4860.513948605147, 4866.953604974948, 4884.780184891652, 4905.8773530661665, 5552.972235138839, 5665.2351932489, 5665.915011274834, 5671.249444019647, 5703.9429605704245, 4093.403572606686, 4094.6110119538894, 4111.465509483778, 4122.958770412288, 4159.168166366739, 5862.912056319158, 5891.293044834604, 5904.911426328608, 5919.467247947706, 5929.584929055011, 4120.011197312683, 4226.429432026698, 4234.70357075008, 4242.490901091889, 4244.363345498138, 4228.851990180329, 4235.2588297048505, 4254.936175957363, 4271.658267338606, 4285.121550082225, 4831.0, 4845.442774080955, 4845.854624361275, 4869.464358920516, 4877.3903262092235, 5520.282363292747, 5631.943680563142, 5711.7144142792695, 5732.0, 5743.597948143673, 1457.606446259504, 1487.2861026707242, 1487.4347747855745, 1488.6352843553398, 1494.1856688105008, 903.6295119001178, 943.7593413679468, 948.5020364308793, 958.6387329991429, 960.2270172511196, 4829.589484893823, 4879.267859909752, 4881.755152436106, 4895.80052887045, 4910.772306923269, 5107.923381149286, 5112.846614601568, 5140.614453915971, 5148.3564554430695, 5164.8967020659375, 4717.5282471753235, 4845.248986407112, 4883.853484395474, 4887.193613053877, 4887.36464259644, 2702.8513431761444, 2721.414895797413, 2730.754232119079, 2736.7832056034676, 2738.1374866917254, 5225.047847965887, 5304.135766686023, 5311.49540793624, 5330.120530112566, 5343.358996634772, 4921.50784921505, 5126.641135120581, 5207.010667973073, 5214.74846036956, 5224.164133738584, 5266.289050978069, 5291.841244762663, 5295.523402893758, 5323.627346085892, 5342.305500284938, 5082.3138876252715, 5107.744612769421, 5123.897522049613, 5161.354830646169, 5172.353455818023, 5054.342935418372, 5374.355077390738, 5727.513161381163, 5737.713114344349, 5740.339860916049, 6086.513078953762, 6171.321154673072, 6173.166622505904, 6191.938080619136, 6231.096491008869, 4003.159336539359, 4096.344584866407, 4103.548609652996, 4109.732867363612, 4170.958290417057, 5785.537157027512, 5794.913076303943, 5828.446297601721, 5833.854153646193, 5867.119932010232, 5634.85912852182, 5693.743781529758, 5737.56968227393, 5737.741801618854, 5767.442790446472, 5684.090545512699, 5699.658020518782, 5701.458361455655, 5704.0, 5714.885702285847, 5570.6657600544095, 5599.720013999366, 5645.661260324394, 5648.5763567731765, 5706.001449746194, 5506.5870059746485, 5652.63257888236, 5663.263775709132, 5678.4605462480995, 5757.222774925499, 5539.7784088636, 5546.584006199632, 5550.888982220414, 5573.860653483695, 5592.580556458201], "value": 4217.569604038156, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.4051194436948, 713.2546488919086, 720.6180724216167, 725.4087918346548, 782.996085019575, 13703.38334774935, 14647.0, 14726.63183420415, 14762.852371476269, 14845.480408185716, 13018.0, 13020.869791302084, 13092.672683182926, 13196.076274660778, 14052.086614370084, 626.8307556959618, 649.4674367019046, 764.1098120689418, 802.1777677880191, 807.309750163609, 819.5451524403953, 827.9213474719892, 827.9379046571531, 828.6478246745139, 832.5795473285982, 881.6914080071988, 881.9294456443469, 882.5763633455945, 882.9955850220772, 883.1124719656768, 860.9870851937226, 861.9138086191331, 871.9476831390136, 873.2490058549643, 878.0867897386742, 641.2945759664378, 643.3084434233218, 643.6170478565247, 643.6620774093592, 645.1902861908322, 14660.340284687109, 14732.48436304735, 14737.778933315902, 14769.261536923219, 14783.482578109822, 13392.129511581716, 13571.592852214351, 13625.454981800716, 13691.452341906312, 13911.930440347733, 11161.218714689974, 11185.440727963569, 11274.887251127466, 11323.32060076398, 11511.654650360419, 3747.7001839852746, 3799.468074469549, 3834.2906562286066, 3884.126071633888, 3925.6270654287796, 78546.21453785503, 81144.59427702882, 81561.0, 82111.58944205241, 82696.58651706703, 11237.381943992996, 11413.311544344386, 11430.314181149157, 11464.656060318204, 11517.25137866036, 21296.254631088148, 21400.036998335112, 21436.0, 21525.0, 21555.137794488044, 7820.726274580363, 7869.252421019994, 7978.880316795253, 8251.917480825236, 8594.570271486526, 4460.30865215892, 4493.483249426293, 4523.434570678665, 4630.53694630541, 4662.673612847136, 3526.5239192708655, 3631.328204282216, 3633.7638053526434, 3634.0914771307175, 3641.7268704847243, 596.3589141672719, 604.5194070713793, 604.5526310530264, 604.8639056212405, 606.5026678123984, 708.8653155900363, 729.5330988167577, 735.4961851131885, 740.8294894067361, 744.2026612687214, 8604.182602652863, 9083.45499270046, 9385.343025988115, 9777.755556111011, 9873.851892221623, 580.4195804195804, 672.4116398151617, 733.5378711411777, 739.8594267089236, 751.1474476469137, 4422.977885110554, 4583.770811459413, 4842.7018331947165, 4877.561019508261, 4893.412790465096, 72602.63698681473, 116080.41959790316, 122107.0, 123124.0, 124220.37889810493, 104835.0, 106766.0, 108038.0, 108303.0, 111334.0, 87643.42674299453, 87679.99999999872, 90156.6476502853, 91534.54232728794, 93071.0, 8929.06244844282, 9277.582508786985, 9338.486383248986, 9417.246620270225, 9421.481818500048, 52991.73504132609, 53975.0, 54229.0, 54307.0, 55576.16635750548, 72344.63827680828, 73667.6316618435, 80245.59877200576, 81398.8950828702, 81930.18069819464, 11777.0, 11821.167719003224, 11865.644030679094, 12100.878991209975, 12211.511539538318, 12478.376081195722, 12478.563250286197, 12744.299063551223, 12893.935530322664, 13617.727645446837, 11069.391183484986, 11299.0, 11615.245009074382, 11866.110041746731, 12279.754404911673, 11432.714182145513, 11584.189106762446, 11705.707357316136, 11965.880341196476, 12390.380480975735, 11668.899598072428, 12739.74520509566, 13069.869301306866, 13416.0, 13472.124311919693, 10347.223958203014, 11236.719082023015, 11351.54593816238, 11478.82781758291, 11538.423078846192, 10800.783984320427, 10901.34591924487, 11233.213675042669, 11887.94056029749, 11966.64100076999], "value": 7396.159447955392, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 113.0, 113.0, 113.0, 112.0, 113.0, 114.0, 116.0, 114.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 124.0, 126.0, 166.0, 129.0, 125.0, 122.0, 124.0, 162.0, 133.0], "value": 136.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 166.0, 175.0, 163.0, 161.0, 162.0, 164.0, 166.0, 161.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 121.0, 76.0, 75.0, 76.0, 76.0, 103.0, 77.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 117.0, 82.0, 83.0, 85.0, 102.0, 82.0, 84.0, 110.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 119.0, 119.0, 118.0, 119.0, 118.0, 118.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 147.0, 146.0, 146.0, 147.0, 148.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 59.0, 53.0, 55.0, 57.0, 54.0, 55.0, 56.0, 63.0, 56.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 63.0, 65.0, 63.0, 62.0, 63.0, 63.0, 63.0], "value": 63.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 90.0, 91.0, 87.0, 82.0, 80.0, 82.0, 81.0, 80.0, 80.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 132.0, 143.0, 129.0, 134.0, 140.0, 144.0, 136.0, 164.0, 137.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 165.0, 166.0, 167.0, 164.0, 161.0, 163.0, 162.0, 169.0], "value": 164.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 72.0, 65.0, 69.0, 66.0, 64.0, 66.0, 65.0, 65.0], "value": 66.8, "unit": "score"}]}]} 23:37:36 INFO - Return code: 0 23:37:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:37:36 ERROR - # TBPL SUCCESS # 23:37:36 INFO - Running post-action listener: _resource_record_post_action 23:37:36 INFO - [mozharness: 2016-10-17 06:37:36.895274Z] Finished run-tests step (success) 23:37:36 INFO - Running post-run listener: _resource_record_post_run 23:37:36 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 392974336; Read time: 0; Write time: 338568 23:37:36 INFO - TinderboxPrint: CPU usage
13.5% 23:37:36 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 23:37:36 INFO - TinderboxPrint: I/O write bytes / time
392,974,336 / 338,568 23:37:36 INFO - TinderboxPrint: CPU idle
8,252.1 (86.5%) 23:37:36 INFO - TinderboxPrint: CPU user
1,221.0 (12.8%) 23:37:36 INFO - TinderboxPrint: Swap in / out
0 / 0 23:37:36 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103866368; Read time: 0; Write time: 101100 23:37:36 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 289107968; Read time: 0; Write time: 237468 23:37:37 INFO - Running post-run listener: _upload_blobber_files 23:37:37 INFO - Blob upload gear active. 23:37:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:37:37 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:37:37 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:37:37 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:37:37 INFO - (blobuploader) - INFO - Open directory for files ... 23:37:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:37:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:37:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:37:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:37:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:37:41 INFO - (blobuploader) - INFO - Done attempting. 23:37:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:37:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:37:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:37:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:37:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:37:42 INFO - (blobuploader) - INFO - Done attempting. 23:37:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:37:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:37:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:37:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:37:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:37:43 INFO - (blobuploader) - INFO - Done attempting. 23:37:43 INFO - (blobuploader) - INFO - Iteration through files over. 23:37:43 INFO - Return code: 0 23:37:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:37:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:37:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d8b5cc32a394331e6f641b574361b8143e9e40b2728c442f4b87793b8e7adc36edfdb9347412f095a3e08f905ea7846b715245a24391c2afd02a9a4caeb827d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/226bca20c2bd446c2ef19166fef82410c9881e6c034f115fca20a5d93931a5c181910c7ec6f491e2f913e2f4a454f1d4cc7af5079b0359a6b9b2b5ffb6ffaf09", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14d6842f67c38aa304ca21bdfddd8aca9b00b499b5396d3e78dbaaf3da9079c40523cbf60176a04720f4fd36f59989ebb0ffacd211a4d5ad2a49b4ba09f536cd"} 23:37:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:37:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:37:43 INFO - Contents: 23:37:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d8b5cc32a394331e6f641b574361b8143e9e40b2728c442f4b87793b8e7adc36edfdb9347412f095a3e08f905ea7846b715245a24391c2afd02a9a4caeb827d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/226bca20c2bd446c2ef19166fef82410c9881e6c034f115fca20a5d93931a5c181910c7ec6f491e2f913e2f4a454f1d4cc7af5079b0359a6b9b2b5ffb6ffaf09", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14d6842f67c38aa304ca21bdfddd8aca9b00b499b5396d3e78dbaaf3da9079c40523cbf60176a04720f4fd36f59989ebb0ffacd211a4d5ad2a49b4ba09f536cd"} 23:37:43 INFO - Running post-run listener: copy_logs_to_upload_dir 23:37:43 INFO - Copying logs to upload dir... 23:37:43 INFO - mkdir: /builds/slave/test/build/upload/logs 23:37:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.235332 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-16 23:37:41.997335) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-16 23:37:42.000615) ========= 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=eca2ab57546de7b41f256b19000001ef-1476682536.857499-617807562 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/Fx-Team/sha512/7d8b5cc32a394331e6f641b574361b8143e9e40b2728c442f4b87793b8e7adc36edfdb9347412f095a3e08f905ea7846b715245a24391c2afd02a9a4caeb827d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/226bca20c2bd446c2ef19166fef82410c9881e6c034f115fca20a5d93931a5c181910c7ec6f491e2f913e2f4a454f1d4cc7af5079b0359a6b9b2b5ffb6ffaf09", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14d6842f67c38aa304ca21bdfddd8aca9b00b499b5396d3e78dbaaf3da9079c40523cbf60176a04720f4fd36f59989ebb0ffacd211a4d5ad2a49b4ba09f536cd"} build_url:https://queue.taskcluster.net/v1/task/VlIQuMY_SXCZLfkKOFRPEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011292 build_url: 'https://queue.taskcluster.net/v1/task/VlIQuMY_SXCZLfkKOFRPEg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d8b5cc32a394331e6f641b574361b8143e9e40b2728c442f4b87793b8e7adc36edfdb9347412f095a3e08f905ea7846b715245a24391c2afd02a9a4caeb827d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/226bca20c2bd446c2ef19166fef82410c9881e6c034f115fca20a5d93931a5c181910c7ec6f491e2f913e2f4a454f1d4cc7af5079b0359a6b9b2b5ffb6ffaf09", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14d6842f67c38aa304ca21bdfddd8aca9b00b499b5396d3e78dbaaf3da9079c40523cbf60176a04720f4fd36f59989ebb0ffacd211a4d5ad2a49b4ba09f536cd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-16 23:37:42.025984) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:37:42.026330) ========= 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=eca2ab57546de7b41f256b19000001ef-1476682536.857499-617807562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004384 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:37:42.078030) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-16 23:37:42.078369) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-16 23:37:42.078651) ========= ========= Total master_lag: 0.14 =========