builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-043 starttime: 1476322179.01 results: success (0) buildid: 20161012181942 builduid: 955afc7bc6e84e13a8d57eb8ba2032c0 revision: f90f136b1d034f7165d82bdf9ca5d72519bd598f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 18:29:39.009270) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 18:29:39.009752) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 18:29:39.010034) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 18:29:39.025339) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 18:29:39.025962) ========= 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=d2a8c569965ab8367867b893000001a1-1476322178.597982-1769935299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-12 18:29:39-- 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% 220M=0s 2016-10-12 18:29:39 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092801 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 18:29:39.132813) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 18:29:39.133126) ========= 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=d2a8c569965ab8367867b893000001a1-1476322178.597982-1769935299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014890 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 18:29:39.183725) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 18:29:39.184091) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev f90f136b1d034f7165d82bdf9ca5d72519bd598f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev f90f136b1d034f7165d82bdf9ca5d72519bd598f --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=d2a8c569965ab8367867b893000001a1-1476322178.597982-1769935299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-12 18:29:39,460 truncating revision to first 12 chars 2016-10-12 18:29:39,460 Setting DEBUG logging. 2016-10-12 18:29:39,460 attempt 1/10 2016-10-12 18:29:39,460 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/f90f136b1d03?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-12 18:29:40,691 unpacking tar archive at: autoland-f90f136b1d03/testing/mozharness/ program finished with exit code 0 elapsedTime=1.572472 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 18:29:40.770337) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 18:29:40.770689) ========= script_repo_revision: f90f136b1d034f7165d82bdf9ca5d72519bd598f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 18:29:40.771077) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 18:29:40.771364) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 18:29:40.781615) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-12 18:29:40.782237) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=d2a8c569965ab8367867b893000001a1-1476322178.597982-1769935299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:29:41 INFO - MultiFileLogger online at 20161012 18:29:41 in /builds/slave/test 18:29:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 18:29:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:29:41 INFO - {'append_to_log': False, 18:29:41 INFO - 'base_work_dir': '/builds/slave/test', 18:29:41 INFO - 'blob_upload_branch': 'Autoland', 18:29:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:29:41 INFO - 'branch': 'Autoland', 18:29:41 INFO - 'buildbot_json_path': 'buildprops.json', 18:29:41 INFO - 'config_files': ('talos/linux_config.py',), 18:29:41 INFO - 'default_actions': ('clobber', 18:29:41 INFO - 'read-buildbot-config', 18:29:41 INFO - 'download-and-extract', 18:29:41 INFO - 'populate-webroot', 18:29:41 INFO - 'create-virtualenv', 18:29:41 INFO - 'install', 18:29:41 INFO - 'run-tests'), 18:29:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:29:41 INFO - 'download_minidump_stackwalk': True, 18:29:41 INFO - 'download_symbols': 'ondemand', 18:29:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:29:41 INFO - 'tooltool.py': '/tools/tooltool.py', 18:29:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:29:41 INFO - '/tools/misc-python/virtualenv.py')}, 18:29:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:29:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:29:41 INFO - 'installer_path': 'installer.exe', 18:29:41 INFO - 'log_level': 'info', 18:29:41 INFO - 'log_name': 'talos', 18:29:41 INFO - 'log_to_console': True, 18:29:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:29:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:29:41 INFO - 'opt_config_files': (), 18:29:41 INFO - 'pip_index': False, 18:29:41 INFO - 'sps_profile': False, 18:29:41 INFO - 'sps_profile_interval': 0, 18:29:41 INFO - 'suite': 'dromaeojs-e10s', 18:29:41 INFO - 'system_bits': '32', 18:29:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:29:41 INFO - 'title': 'talos-linux64-ix-043', 18:29:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:29:41 INFO - 'use_talos_json': True, 18:29:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:29:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:29:41 INFO - 'work_dir': 'build'} 18:29:41 INFO - [mozharness: 2016-10-13 01:29:41.157573Z] Running clobber step. 18:29:41 INFO - Running pre-action listener: _resource_record_pre_action 18:29:41 INFO - Running main action method: clobber 18:29:41 INFO - rmtree: /builds/slave/test/build 18:29:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:29:41 INFO - Running post-action listener: _resource_record_post_action 18:29:41 INFO - [mozharness: 2016-10-13 01:29:41.627597Z] Finished clobber step (success) 18:29:41 INFO - [mozharness: 2016-10-13 01:29:41.627697Z] Running read-buildbot-config step. 18:29:41 INFO - Running pre-action listener: _resource_record_pre_action 18:29:41 INFO - Running main action method: read_buildbot_config 18:29:41 INFO - Using buildbot properties: 18:29:41 INFO - { 18:29:41 INFO - "project": "", 18:29:41 INFO - "product": "firefox", 18:29:41 INFO - "script_repo_revision": "production", 18:29:41 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 18:29:41 INFO - "repository": "", 18:29:41 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 18:29:41 INFO - "buildid": "20161012181942", 18:29:41 INFO - "stage_platform": "linux64-pgo", 18:29:41 INFO - "basedir": "/builds/slave/test", 18:29:41 INFO - "buildnumber": 317, 18:29:41 INFO - "platform": "ubuntu64_hw", 18:29:41 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:29:41 INFO - "slavebuilddir": "test", 18:29:41 INFO - "branch": "autoland", 18:29:41 INFO - "revision": "f90f136b1d034f7165d82bdf9ca5d72519bd598f", 18:29:41 INFO - "slavename": "talos-linux64-ix-043", 18:29:41 INFO - "builduid": "955afc7bc6e84e13a8d57eb8ba2032c0", 18:29:41 INFO - "repo_path": "integration/autoland" 18:29:41 INFO - } 18:29:41 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:29:41 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 18:29:41 INFO - Running post-action listener: _resource_record_post_action 18:29:41 INFO - [mozharness: 2016-10-13 01:29:41.630048Z] Finished read-buildbot-config step (success) 18:29:41 INFO - [mozharness: 2016-10-13 01:29:41.630135Z] Running download-and-extract step. 18:29:41 INFO - Running pre-action listener: _resource_record_pre_action 18:29:41 INFO - Running main action method: download_and_extract 18:29:41 INFO - mkdir: /builds/slave/test/build/tests 18:29:41 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')]} 18:29:41 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:29:41 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476311401/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 18:29:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476311401/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 18:29:41 INFO - Downloaded 1361 bytes. 18:29:41 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:29:41 INFO - Using the following test package requirements: 18:29:41 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:29:41 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:41 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:29:41 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:41 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:29:41 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:41 INFO - u'jsshell-linux-x86_64.zip'], 18:29:41 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:41 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:29:41 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:29:41 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:41 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:29:41 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:41 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:29:41 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:41 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:29:41 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:41 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:29:41 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:29:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:29:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:29:41 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:29:41 INFO - Http code: 200 18:29:41 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 18:29:41 INFO - x-amz-cf-id: QP-r5n_le01QpRlhKVzduSJzRBcvN367KkrM1k36DGCxuRupw8TrGg== 18:29:41 INFO - x-amz-replication-status: COMPLETED 18:29:41 INFO - x-amz-version-id: tRELhA3sKiv3ABMUjjrfQVKPUrXnVBMa 18:29:41 INFO - Expected file size: 22117400 18:29:41 INFO - Obtained file size: 22117400 18:29:46 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 18:29:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:29:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:29:46 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:29:46 INFO - Http code: 200 18:29:46 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 18:29:46 INFO - x-amz-cf-id: lESJeBgMiarq2hJaJP113r-A4skzbgC2MNb_SaJBpTbDmAfZ2sXVwA== 18:29:46 INFO - x-amz-replication-status: COMPLETED 18:29:46 INFO - x-amz-version-id: tRELhA3sKiv3ABMUjjrfQVKPUrXnVBMa 18:29:46 INFO - Expected file size: 22117400 18:29:46 INFO - Obtained file size: 22117400 18:29:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:29:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:29:50 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:29:50 INFO - Http code: 200 18:29:50 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 18:29:50 INFO - x-amz-cf-id: DN5bI7QJ7_yRsU50zfqi93BfUZG9Cn1PnETwmZjLHxPI-K8TUwnRPQ== 18:29:50 INFO - x-amz-replication-status: COMPLETED 18:29:50 INFO - x-amz-version-id: k3YKt7_52iosoxVxCNyt..qXQNZ6IBzq 18:29:51 INFO - Expected file size: 14409006 18:29:51 INFO - Obtained file size: 14409006 18:29:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:51 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:29:51 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476311401/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 18:29:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476311401/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 18:29:51 INFO - Downloaded 59776276 bytes. 18:29:51 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:29:51 INFO - mkdir: /builds/slave/test/properties 18:29:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:29:51 INFO - Writing to file /builds/slave/test/properties/build_url 18:29:51 INFO - Contents: 18:29:51 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:29:52 INFO - Running post-action listener: _resource_record_post_action 18:29:52 INFO - Running post-action listener: set_extra_try_arguments 18:29:52 INFO - [mozharness: 2016-10-13 01:29:52.283788Z] Finished download-and-extract step (success) 18:29:52 INFO - [mozharness: 2016-10-13 01:29:52.284014Z] Running populate-webroot step. 18:29:52 INFO - Running pre-action listener: _resource_record_pre_action 18:29:52 INFO - Running main action method: populate_webroot 18:29:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:29:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:29:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:29:52 INFO - '--tppagecycles', 18:29:52 INFO - '7'], 18:29:52 INFO - 'tests': ['tsvgm']}}, 18:29:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:29:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:29:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:29:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:29:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:29:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:29:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:52 INFO - 'talos_options': ['--disable-e10s'], 18:29:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:29:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:29:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:52 INFO - 'talos_options': ['--disable-e10s'], 18:29:52 INFO - 'tests': ['damp', 'tps']}, 18:29:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:52 INFO - 'tests': ['damp', 'tps']}, 18:29:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:29:52 INFO - 'tests': ['dromaeo_dom']}, 18:29:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:29:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:29:52 INFO - 'tests': ['basic_compositor_video']}, 18:29:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:29:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:29:52 INFO - 'tests': ['a11yr', 18:29:52 INFO - 'ts_paint', 18:29:52 INFO - 'tpaint', 18:29:52 INFO - 'sessionrestore', 18:29:52 INFO - 'sessionrestore_no_auto_restore', 18:29:52 INFO - 'tabpaint']}, 18:29:52 INFO - 'other-e10s': {'tests': ['a11yr', 18:29:52 INFO - 'ts_paint', 18:29:52 INFO - 'tpaint', 18:29:52 INFO - 'sessionrestore', 18:29:52 INFO - 'sessionrestore_no_auto_restore', 18:29:52 INFO - 'tabpaint']}, 18:29:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:29:52 INFO - 'ts_paint', 18:29:52 INFO - 'tpaint', 18:29:52 INFO - 'sessionrestore', 18:29:52 INFO - 'sessionrestore_no_auto_restore', 18:29:52 INFO - 'tabpaint']}, 18:29:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:29:52 INFO - 'ts_paint', 18:29:52 INFO - 'tpaint', 18:29:52 INFO - 'sessionrestore', 18:29:52 INFO - 'sessionrestore_no_auto_restore', 18:29:52 INFO - 'tabpaint']}, 18:29:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:29:52 INFO - 'tests': ['a11yr', 18:29:52 INFO - 'ts_paint', 18:29:52 INFO - 'tpaint', 18:29:52 INFO - 'sessionrestore', 18:29:52 INFO - 'sessionrestore_no_auto_restore', 18:29:52 INFO - 'tabpaint']}, 18:29:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:29:52 INFO - 'tests': ['a11yr', 18:29:52 INFO - 'ts_paint', 18:29:52 INFO - 'tpaint', 18:29:52 INFO - 'sessionrestore', 18:29:52 INFO - 'sessionrestore_no_auto_restore', 18:29:52 INFO - 'tabpaint']}, 18:29:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:29:52 INFO - 'tests': ['tsvgx', 18:29:52 INFO - 'tsvgr_opacity', 18:29:52 INFO - 'tart', 18:29:52 INFO - 'tscrollx', 18:29:52 INFO - 'cart']}, 18:29:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:29:52 INFO - 'tsvgr_opacity', 18:29:52 INFO - 'tart', 18:29:52 INFO - 'tscrollx', 18:29:52 INFO - 'cart']}, 18:29:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:52 INFO - 'talos_options': ['--disable-e10s'], 18:29:52 INFO - 'tests': ['tp5o']}, 18:29:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:52 INFO - 'tests': ['tp5o']}, 18:29:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:52 INFO - 'talos_options': ['--disable-e10s', 18:29:52 INFO - '--xperf_path', 18:29:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:29:52 INFO - 'tests': ['tp5n']}, 18:29:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:52 INFO - 'talos_options': ['--xperf_path', 18:29:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:29:52 INFO - 'tests': ['tp5n']}}, 18:29:52 INFO - 'talos.zip': {'path': '', 18:29:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:29:52 INFO - Running post-action listener: _resource_record_post_action 18:29:52 INFO - [mozharness: 2016-10-13 01:29:52.301260Z] Finished populate-webroot step (success) 18:29:52 INFO - [mozharness: 2016-10-13 01:29:52.301348Z] Running create-virtualenv step. 18:29:52 INFO - Running pre-action listener: _resource_record_pre_action 18:29:52 INFO - Running main action method: create_virtualenv 18:29:52 INFO - Creating virtualenv /builds/slave/test/build/venv 18:29:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:29:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:29:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:29:52 INFO - Using real prefix '/usr' 18:29:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:29:52 INFO - Installing distribute.............................................................................................................................................................................................done. 18:29:54 INFO - Installing pip.................done. 18:29:54 INFO - Return code: 0 18:29:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:29:55 INFO - Reading from file tmpfile_stdout 18:29:55 INFO - Output received: 18:29:55 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) 18:29:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:29:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0fa0570f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13757b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404790>, '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 0x1405690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405b20>, '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': 'd2a8c569965ab8367867b893000001a1-1476322178.597982-1769935299', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:29:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:29:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:29:55 INFO - Using env: {'DISPLAY': ':0', 18:29:55 INFO - 'HOME': '/home/cltbld', 18:29:55 INFO - 'LANG': 'en_US.UTF-8', 18:29:55 INFO - 'LANGUAGE': 'en_US:en', 18:29:55 INFO - 'LOGNAME': 'cltbld', 18:29:55 INFO - 'MAIL': '/var/mail/cltbld', 18:29:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:55 INFO - 'MOZ_NO_REMOTE': '1', 18:29:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:55 INFO - 'NO_EM_RESTART': '1', 18:29:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:55 INFO - 'PWD': '/builds/slave/test', 18:29:55 INFO - 'SHELL': '/bin/bash', 18:29:55 INFO - 'SHLVL': '1', 18:29:55 INFO - 'TERM': 'linux', 18:29:55 INFO - 'TMOUT': '86400', 18:29:55 INFO - 'USER': 'cltbld', 18:29:55 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1476322178.597982-1769935299', 18:29:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:55 INFO - '_': '/tools/buildbot/bin/python'} 18:29:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:29:55 INFO - Cleaning up... 18:29:55 INFO - Return code: 0 18:29:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:29:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0fa0570f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13757b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404790>, '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 0x1405690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405b20>, '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': 'd2a8c569965ab8367867b893000001a1-1476322178.597982-1769935299', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:29:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:29:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:29:55 INFO - Using env: {'DISPLAY': ':0', 18:29:55 INFO - 'HOME': '/home/cltbld', 18:29:55 INFO - 'LANG': 'en_US.UTF-8', 18:29:55 INFO - 'LANGUAGE': 'en_US:en', 18:29:55 INFO - 'LOGNAME': 'cltbld', 18:29:55 INFO - 'MAIL': '/var/mail/cltbld', 18:29:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:55 INFO - 'MOZ_NO_REMOTE': '1', 18:29:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:55 INFO - 'NO_EM_RESTART': '1', 18:29:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:55 INFO - 'PWD': '/builds/slave/test', 18:29:55 INFO - 'SHELL': '/bin/bash', 18:29:55 INFO - 'SHLVL': '1', 18:29:55 INFO - 'TERM': 'linux', 18:29:55 INFO - 'TMOUT': '86400', 18:29:55 INFO - 'USER': 'cltbld', 18:29:55 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1476322178.597982-1769935299', 18:29:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:55 INFO - '_': '/tools/buildbot/bin/python'} 18:29:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:55 INFO - Downloading/unpacking psutil>=3.1.1 18:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:29:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:29:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:29:57 INFO - Installing collected packages: psutil 18:29:57 INFO - Running setup.py install for psutil 18:29:57 INFO - building 'psutil._psutil_linux' extension 18:29:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:29:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:29:57 INFO - building 'psutil._psutil_posix' extension 18:29:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:29:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:29:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:29:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:29:58 INFO - Successfully installed psutil 18:29:58 INFO - Cleaning up... 18:29:58 INFO - Return code: 0 18:29:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:29:58 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')]} 18:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:58 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')]} 18:29:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:58 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 0x7f0fa0570f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13757b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404790>, '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 0x1405690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405b20>, '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': 'd2a8c569965ab8367867b893000001a1-1476322178.597982-1769935299', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:29:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:29:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:29:58 INFO - Using env: {'DISPLAY': ':0', 18:29:58 INFO - 'HOME': '/home/cltbld', 18:29:58 INFO - 'LANG': 'en_US.UTF-8', 18:29:58 INFO - 'LANGUAGE': 'en_US:en', 18:29:58 INFO - 'LOGNAME': 'cltbld', 18:29:58 INFO - 'MAIL': '/var/mail/cltbld', 18:29:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:58 INFO - 'MOZ_NO_REMOTE': '1', 18:29:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:58 INFO - 'NO_EM_RESTART': '1', 18:29:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:58 INFO - 'PWD': '/builds/slave/test', 18:29:58 INFO - 'SHELL': '/bin/bash', 18:29:58 INFO - 'SHLVL': '1', 18:29:58 INFO - 'TERM': 'linux', 18:29:58 INFO - 'TMOUT': '86400', 18:29:58 INFO - 'USER': 'cltbld', 18:29:58 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1476322178.597982-1769935299', 18:29:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:58 INFO - '_': '/tools/buildbot/bin/python'} 18:29:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:30:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:30:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:30:00 INFO - Installing collected packages: mozsystemmonitor 18:30:00 INFO - Running setup.py install for mozsystemmonitor 18:30:00 INFO - Successfully installed mozsystemmonitor 18:30:00 INFO - Cleaning up... 18:30:00 INFO - Return code: 0 18:30:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:00 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 0x7f0fa0570f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13757b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404790>, '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 0x1405690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405b20>, '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': 'd2a8c569965ab8367867b893000001a1-1476322178.597982-1769935299', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:30:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:30:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:30:00 INFO - Using env: {'DISPLAY': ':0', 18:30:00 INFO - 'HOME': '/home/cltbld', 18:30:00 INFO - 'LANG': 'en_US.UTF-8', 18:30:00 INFO - 'LANGUAGE': 'en_US:en', 18:30:00 INFO - 'LOGNAME': 'cltbld', 18:30:00 INFO - 'MAIL': '/var/mail/cltbld', 18:30:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:00 INFO - 'MOZ_NO_REMOTE': '1', 18:30:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:00 INFO - 'NO_EM_RESTART': '1', 18:30:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:00 INFO - 'PWD': '/builds/slave/test', 18:30:00 INFO - 'SHELL': '/bin/bash', 18:30:00 INFO - 'SHLVL': '1', 18:30:00 INFO - 'TERM': 'linux', 18:30:00 INFO - 'TMOUT': '86400', 18:30:00 INFO - 'USER': 'cltbld', 18:30:00 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1476322178.597982-1769935299', 18:30:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:00 INFO - '_': '/tools/buildbot/bin/python'} 18:30:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:00 INFO - Downloading/unpacking jsonschema==2.5.1 18:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:30:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:02 INFO - Downloading functools32-3.2.3-2.tar.gz 18:30:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:30:02 INFO - warning: no files found matching '*.txt' 18:30:02 INFO - no previously-included directories found matching 'build' 18:30:02 INFO - no previously-included directories found matching 'dist' 18:30:02 INFO - no previously-included directories found matching '.git*' 18:30:02 INFO - Installing collected packages: jsonschema, functools32 18:30:02 INFO - Running setup.py install for functools32 18:30:03 INFO - warning: no files found matching '*.txt' 18:30:03 INFO - no previously-included directories found matching 'build' 18:30:03 INFO - no previously-included directories found matching 'dist' 18:30:03 INFO - no previously-included directories found matching '.git*' 18:30:03 INFO - Successfully installed jsonschema functools32 18:30:03 INFO - Cleaning up... 18:30:03 INFO - Return code: 0 18:30:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:03 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 0x7f0fa0570f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13757b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404790>, '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 0x1405690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405b20>, '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': 'd2a8c569965ab8367867b893000001a1-1476322178.597982-1769935299', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:30:03 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 18:30:03 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 18:30:03 INFO - Using env: {'DISPLAY': ':0', 18:30:03 INFO - 'HOME': '/home/cltbld', 18:30:03 INFO - 'LANG': 'en_US.UTF-8', 18:30:03 INFO - 'LANGUAGE': 'en_US:en', 18:30:03 INFO - 'LOGNAME': 'cltbld', 18:30:03 INFO - 'MAIL': '/var/mail/cltbld', 18:30:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:03 INFO - 'MOZ_NO_REMOTE': '1', 18:30:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:03 INFO - 'NO_EM_RESTART': '1', 18:30:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:03 INFO - 'PWD': '/builds/slave/test', 18:30:03 INFO - 'SHELL': '/bin/bash', 18:30:03 INFO - 'SHLVL': '1', 18:30:03 INFO - 'TERM': 'linux', 18:30:03 INFO - 'TMOUT': '86400', 18:30:03 INFO - 'USER': 'cltbld', 18:30:03 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1476322178.597982-1769935299', 18:30:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:03 INFO - '_': '/tools/buildbot/bin/python'} 18:30:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:30:03 INFO - Cleaning up... 18:30:03 INFO - Return code: 0 18:30:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:03 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 0x7f0fa0570f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13757b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404790>, '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 0x1405690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405b20>, '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': 'd2a8c569965ab8367867b893000001a1-1476322178.597982-1769935299', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:30:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:30:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:30:03 INFO - Using env: {'DISPLAY': ':0', 18:30:03 INFO - 'HOME': '/home/cltbld', 18:30:03 INFO - 'LANG': 'en_US.UTF-8', 18:30:03 INFO - 'LANGUAGE': 'en_US:en', 18:30:03 INFO - 'LOGNAME': 'cltbld', 18:30:03 INFO - 'MAIL': '/var/mail/cltbld', 18:30:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:03 INFO - 'MOZ_NO_REMOTE': '1', 18:30:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:03 INFO - 'NO_EM_RESTART': '1', 18:30:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:03 INFO - 'PWD': '/builds/slave/test', 18:30:03 INFO - 'SHELL': '/bin/bash', 18:30:03 INFO - 'SHLVL': '1', 18:30:03 INFO - 'TERM': 'linux', 18:30:03 INFO - 'TMOUT': '86400', 18:30:03 INFO - 'USER': 'cltbld', 18:30:03 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1476322178.597982-1769935299', 18:30:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:03 INFO - '_': '/tools/buildbot/bin/python'} 18:30:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:03 INFO - Downloading/unpacking blobuploader==1.2.4 18:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:05 INFO - Downloading blobuploader-1.2.4.tar.gz 18:30:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:30:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:30:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:06 INFO - Downloading docopt-0.6.1.tar.gz 18:30:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:30:06 INFO - Installing collected packages: blobuploader, requests, docopt 18:30:06 INFO - Running setup.py install for blobuploader 18:30:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:30:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:30:06 INFO - Running setup.py install for requests 18:30:06 INFO - Running setup.py install for docopt 18:30:06 INFO - Successfully installed blobuploader requests docopt 18:30:06 INFO - Cleaning up... 18:30:06 INFO - Return code: 0 18:30:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:06 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 0x7f0fa0570f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13757b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404790>, '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 0x1405690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405b20>, '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': 'd2a8c569965ab8367867b893000001a1-1476322178.597982-1769935299', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:30:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:30:06 INFO - Using env: {'DISPLAY': ':0', 18:30:06 INFO - 'HOME': '/home/cltbld', 18:30:06 INFO - 'LANG': 'en_US.UTF-8', 18:30:06 INFO - 'LANGUAGE': 'en_US:en', 18:30:06 INFO - 'LOGNAME': 'cltbld', 18:30:06 INFO - 'MAIL': '/var/mail/cltbld', 18:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:06 INFO - 'MOZ_NO_REMOTE': '1', 18:30:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:06 INFO - 'NO_EM_RESTART': '1', 18:30:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:06 INFO - 'PWD': '/builds/slave/test', 18:30:06 INFO - 'SHELL': '/bin/bash', 18:30:06 INFO - 'SHLVL': '1', 18:30:06 INFO - 'TERM': 'linux', 18:30:06 INFO - 'TMOUT': '86400', 18:30:06 INFO - 'USER': 'cltbld', 18:30:06 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1476322178.597982-1769935299', 18:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:06 INFO - '_': '/tools/buildbot/bin/python'} 18:30:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:30:07 INFO - Running setup.py (path:/tmp/pip-gcwPS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:30:07 INFO - Running setup.py (path:/tmp/pip-Ae5rK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:30:07 INFO - Running setup.py (path:/tmp/pip-aiI_jo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:30:07 INFO - Running setup.py (path:/tmp/pip-kSsVyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:30:07 INFO - Running setup.py (path:/tmp/pip-D4uSkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:30:07 INFO - Running setup.py (path:/tmp/pip-fLfJD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:30:07 INFO - Running setup.py (path:/tmp/pip-dFfcDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:30:07 INFO - Running setup.py (path:/tmp/pip-gHieE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:30:07 INFO - Running setup.py (path:/tmp/pip-2QNWsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:30:07 INFO - Running setup.py (path:/tmp/pip-DodRvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:30:07 INFO - Running setup.py (path:/tmp/pip-evWpDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:30:07 INFO - Running setup.py (path:/tmp/pip-Du3yXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:30:07 INFO - Running setup.py (path:/tmp/pip-S48yTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:30:08 INFO - Running setup.py (path:/tmp/pip-FcFixL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:08 INFO - Running setup.py (path:/tmp/pip-Z1toEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:30:08 INFO - Running setup.py (path:/tmp/pip-AUUpNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:30:08 INFO - Running setup.py (path:/tmp/pip-FmWBKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:30:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:30:08 INFO - Running setup.py install for manifestparser 18:30:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:30:08 INFO - Running setup.py install for mozcrash 18:30:08 INFO - Running setup.py install for mozdebug 18:30:08 INFO - Running setup.py install for mozdevice 18:30:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:30:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:30:08 INFO - Running setup.py install for mozfile 18:30:08 INFO - Running setup.py install for mozhttpd 18:30:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:30:08 INFO - Running setup.py install for mozinfo 18:30:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:30:09 INFO - Running setup.py install for mozInstall 18:30:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:30:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:30:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:30:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:30:09 INFO - Running setup.py install for mozleak 18:30:09 INFO - Running setup.py install for mozlog 18:30:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:30:09 INFO - Running setup.py install for moznetwork 18:30:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:30:09 INFO - Running setup.py install for mozprocess 18:30:09 INFO - Running setup.py install for mozprofile 18:30:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:30:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:30:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:30:09 INFO - Running setup.py install for mozrunner 18:30:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:30:09 INFO - Running setup.py install for mozscreenshot 18:30:09 INFO - Running setup.py install for moztest 18:30:10 INFO - Running setup.py install for mozversion 18:30:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:30:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:30:10 INFO - Cleaning up... 18:30:10 INFO - Return code: 0 18:30:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:30:10 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')]} 18:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:10 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')]} 18:30:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:10 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 0x7f0fa0570f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13757b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404790>, '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 0x1405690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405b20>, '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': 'd2a8c569965ab8367867b893000001a1-1476322178.597982-1769935299', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:30:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:30:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:30:10 INFO - Using env: {'DISPLAY': ':0', 18:30:10 INFO - 'HOME': '/home/cltbld', 18:30:10 INFO - 'LANG': 'en_US.UTF-8', 18:30:10 INFO - 'LANGUAGE': 'en_US:en', 18:30:10 INFO - 'LOGNAME': 'cltbld', 18:30:10 INFO - 'MAIL': '/var/mail/cltbld', 18:30:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:10 INFO - 'MOZ_NO_REMOTE': '1', 18:30:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:10 INFO - 'NO_EM_RESTART': '1', 18:30:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:10 INFO - 'PWD': '/builds/slave/test', 18:30:10 INFO - 'SHELL': '/bin/bash', 18:30:10 INFO - 'SHLVL': '1', 18:30:10 INFO - 'TERM': 'linux', 18:30:10 INFO - 'TMOUT': '86400', 18:30:10 INFO - 'USER': 'cltbld', 18:30:10 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1476322178.597982-1769935299', 18:30:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:10 INFO - '_': '/tools/buildbot/bin/python'} 18:30:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:30:10 INFO - Running setup.py (path:/tmp/pip-xZAvGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:30:10 INFO - Running setup.py (path:/tmp/pip-gpeucl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:30:10 INFO - Running setup.py (path:/tmp/pip-xHW1Yt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:30:10 INFO - Running setup.py (path:/tmp/pip-pknBeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:30:10 INFO - Running setup.py (path:/tmp/pip-thZa_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:30:10 INFO - Running setup.py (path:/tmp/pip-aNvKro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:30:10 INFO - Running setup.py (path:/tmp/pip-OcUZn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:30:10 INFO - Running setup.py (path:/tmp/pip-sHIhzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:30:10 INFO - Running setup.py (path:/tmp/pip-EQtZB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:30:11 INFO - Running setup.py (path:/tmp/pip-LmhwMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:30:11 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)) 18:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:30:11 INFO - Running setup.py (path:/tmp/pip-ATe7WG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:30:11 INFO - Running setup.py (path:/tmp/pip-XKhF2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:30:11 INFO - Running setup.py (path:/tmp/pip-9vsGT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:30:11 INFO - Running setup.py (path:/tmp/pip-X9PTpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:11 INFO - Running setup.py (path:/tmp/pip-DbGiBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:30:11 INFO - Running setup.py (path:/tmp/pip-rcAAP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:30:11 INFO - Running setup.py (path:/tmp/pip-Dx3eH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:30:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:13 INFO - Downloading blessings-1.6.tar.gz 18:30:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:30:13 INFO - Installing collected packages: blessings 18:30:13 INFO - Running setup.py install for blessings 18:30:13 INFO - Successfully installed blessings 18:30:13 INFO - Cleaning up... 18:30:13 INFO - Return code: 0 18:30:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:30:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:30:13 INFO - Reading from file tmpfile_stdout 18:30:13 INFO - Current package versions: 18:30:13 INFO - argparse == 1.2.1 18:30:13 INFO - blessings == 1.6 18:30:13 INFO - blobuploader == 1.2.4 18:30:13 INFO - docopt == 0.6.1 18:30:13 INFO - functools32 == 3.2.3-2 18:30:13 INFO - jsonschema == 2.5.1 18:30:13 INFO - manifestparser == 1.1 18:30:13 INFO - mozInstall == 1.12 18:30:13 INFO - mozcrash == 0.17 18:30:13 INFO - mozdebug == 0.1 18:30:13 INFO - mozdevice == 0.48 18:30:13 INFO - mozfile == 1.2 18:30:13 INFO - mozhttpd == 0.7 18:30:13 INFO - mozinfo == 0.9 18:30:13 INFO - mozleak == 0.1 18:30:13 INFO - mozlog == 3.4 18:30:13 INFO - moznetwork == 0.27 18:30:13 INFO - mozprocess == 0.23 18:30:13 INFO - mozprofile == 0.28 18:30:13 INFO - mozrunner == 6.12 18:30:13 INFO - mozscreenshot == 0.1 18:30:13 INFO - mozsystemmonitor == 0.3 18:30:13 INFO - moztest == 0.7 18:30:13 INFO - mozversion == 1.4 18:30:13 INFO - psutil == 3.1.1 18:30:13 INFO - requests == 1.2.3 18:30:13 INFO - wsgiref == 0.1.2 18:30:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:30:13 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')]} 18:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:13 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')]} 18:30:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:13 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 0x7f0fa0570f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13757b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404790>, '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 0x1405690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405b20>, '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': 'd2a8c569965ab8367867b893000001a1-1476322178.597982-1769935299', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:30:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:30:13 INFO - Using env: {'DISPLAY': ':0', 18:30:13 INFO - 'HOME': '/home/cltbld', 18:30:13 INFO - 'LANG': 'en_US.UTF-8', 18:30:13 INFO - 'LANGUAGE': 'en_US:en', 18:30:13 INFO - 'LOGNAME': 'cltbld', 18:30:13 INFO - 'MAIL': '/var/mail/cltbld', 18:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:13 INFO - 'MOZ_NO_REMOTE': '1', 18:30:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:13 INFO - 'NO_EM_RESTART': '1', 18:30:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:13 INFO - 'PWD': '/builds/slave/test', 18:30:14 INFO - 'SHELL': '/bin/bash', 18:30:14 INFO - 'SHLVL': '1', 18:30:14 INFO - 'TERM': 'linux', 18:30:14 INFO - 'TMOUT': '86400', 18:30:14 INFO - 'USER': 'cltbld', 18:30:14 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1476322178.597982-1769935299', 18:30:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:14 INFO - '_': '/tools/buildbot/bin/python'} 18:30:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:30:14 INFO - Cleaning up... 18:30:14 INFO - Return code: 0 18:30:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:30:14 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')]} 18:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:14 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')]} 18:30:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:14 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 0x7f0fa0570f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13757b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1404790>, '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 0x1405690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405b20>, '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': 'd2a8c569965ab8367867b893000001a1-1476322178.597982-1769935299', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:30:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:30:14 INFO - Using env: {'DISPLAY': ':0', 18:30:14 INFO - 'HOME': '/home/cltbld', 18:30:14 INFO - 'LANG': 'en_US.UTF-8', 18:30:14 INFO - 'LANGUAGE': 'en_US:en', 18:30:14 INFO - 'LOGNAME': 'cltbld', 18:30:14 INFO - 'MAIL': '/var/mail/cltbld', 18:30:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:14 INFO - 'MOZ_NO_REMOTE': '1', 18:30:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:14 INFO - 'NO_EM_RESTART': '1', 18:30:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:14 INFO - 'PWD': '/builds/slave/test', 18:30:14 INFO - 'SHELL': '/bin/bash', 18:30:14 INFO - 'SHLVL': '1', 18:30:14 INFO - 'TERM': 'linux', 18:30:14 INFO - 'TMOUT': '86400', 18:30:14 INFO - 'USER': 'cltbld', 18:30:14 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1476322178.597982-1769935299', 18:30:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:14 INFO - '_': '/tools/buildbot/bin/python'} 18:30:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:30:14 INFO - Cleaning up... 18:30:14 INFO - Return code: 0 18:30:14 INFO - Running post-action listener: _resource_record_post_action 18:30:14 INFO - Running post-action listener: _start_resource_monitoring 18:30:14 INFO - Starting resource monitoring. 18:30:14 INFO - [mozharness: 2016-10-13 01:30:14.493947Z] Finished create-virtualenv step (success) 18:30:14 INFO - [mozharness: 2016-10-13 01:30:14.494454Z] Running install step. 18:30:14 INFO - Running pre-action listener: _resource_record_pre_action 18:30:14 INFO - Running main action method: install 18:30:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:30:14 INFO - Reading from file tmpfile_stdout 18:30:14 INFO - Detecting whether we're running mozinstall >=1.0... 18:30:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:30:14 INFO - Reading from file tmpfile_stdout 18:30:14 INFO - Output received: 18:30:14 INFO - Usage: mozinstall [options] installer 18:30:14 INFO - Options: 18:30:14 INFO - -h, --help show this help message and exit 18:30:14 INFO - -d DEST, --destination=DEST 18:30:14 INFO - Directory to install application into. [default: 18:30:14 INFO - "/builds/slave/test"] 18:30:14 INFO - --app=APP Application being installed. [default: firefox] 18:30:14 INFO - mkdir: /builds/slave/test/build/application 18:30:14 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'] 18:30:14 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 18:30:31 INFO - Reading from file tmpfile_stdout 18:30:31 INFO - Output received: 18:30:31 INFO - /builds/slave/test/build/application/firefox/firefox 18:30:31 INFO - Running post-action listener: _resource_record_post_action 18:30:31 INFO - [mozharness: 2016-10-13 01:30:31.818790Z] Finished install step (success) 18:30:31 INFO - [mozharness: 2016-10-13 01:30:31.819064Z] Running run-tests step. 18:30:31 INFO - Running pre-action listener: _resource_record_pre_action 18:30:31 INFO - Running main action method: run_tests 18:30:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:30:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:30:31 INFO - Python 2.7.3 18:30:31 INFO - Return code: 0 18:30:31 INFO - grabbing minidump binary from tooltool 18:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:31 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 0x1404790>, '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 0x1405690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:30:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:30:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:30:31 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:30:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:30:31 INFO - Return code: 0 18:30:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:30:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:30:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:30:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:30:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:30:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:30:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:30:31 INFO - Using env: {'DISPLAY': ':0', 18:30:31 INFO - 'HOME': '/home/cltbld', 18:30:31 INFO - 'LANG': 'en_US.UTF-8', 18:30:31 INFO - 'LANGUAGE': 'en_US:en', 18:30:31 INFO - 'LOGNAME': 'cltbld', 18:30:31 INFO - 'MAIL': '/var/mail/cltbld', 18:30:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:30:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:30:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:31 INFO - 'MOZ_NO_REMOTE': '1', 18:30:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:30:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:31 INFO - 'NO_EM_RESTART': '1', 18:30:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:31 INFO - 'PWD': '/builds/slave/test', 18:30:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:30:31 INFO - 'SHELL': '/bin/bash', 18:30:31 INFO - 'SHLVL': '1', 18:30:31 INFO - 'TERM': 'linux', 18:30:31 INFO - 'TMOUT': '86400', 18:30:31 INFO - 'USER': 'cltbld', 18:30:31 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1476322178.597982-1769935299', 18:30:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:31 INFO - '_': '/tools/buildbot/bin/python'} 18:30:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:30:32 INFO - mozversion application_buildid: 20161012153001 18:30:32 INFO - mozversion application_changeset: f90f136b1d034f7165d82bdf9ca5d72519bd598f 18:30:32 INFO - mozversion application_display_name: Nightly 18:30:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:30:32 INFO - mozversion application_name: Firefox 18:30:32 INFO - mozversion application_remotingname: firefox 18:30:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 18:30:32 INFO - mozversion application_vendor: Mozilla 18:30:32 INFO - mozversion application_version: 52.0a1 18:30:32 INFO - mozversion platform_buildid: 20161012153001 18:30:32 INFO - mozversion platform_changeset: f90f136b1d034f7165d82bdf9ca5d72519bd598f 18:30:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 18:30:32 INFO - mozversion platform_version: 52.0a1 18:30:32 INFO - using testdate: 1476322232 18:30:32 INFO - actual date: 1476322232 18:30:32 INFO - starting webserver on 'localhost:45584' 18:30:32 INFO - SUITE-START | Running 2 tests 18:30:32 INFO - TEST-START | dromaeo_css 18:30:32 INFO - operating with platform_type : linux_ 18:30:32 INFO - Initialising browser for dromaeo_css test... 18:30:32 INFO - TEST-INFO | started process 20157 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps3BkII/profile http://localhost:45584/getInfo.html) 18:30:37 INFO - PROCESS | 20157 | __metrics Screen width/height:1600/1200 18:30:37 INFO - PROCESS | 20157 | colorDepth:24 18:30:37 INFO - PROCESS | 20157 | Browser inner width/height: 1024/697 18:30:37 INFO - PROCESS | 20157 | __metrics 18:30:37 ERROR - PROCESS | 20157 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 18:30:38 INFO - TEST-INFO | 20157: exit 0 18:30:38 INFO - Browser initialized. 18:30:38 INFO - Running cycle 1/1 for dromaeo_css test... 18:30:38 INFO - TEST-INFO | started process 20282 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps3BkII/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:30:50 INFO - PROCESS | 20282 | RSS: Main: 184475648 18:30:50 INFO - PROCESS | 20282 | 18:31:40 INFO - PROCESS | 20282 | 1476322300510 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:33:52 INFO - PROCESS | 20282 | Cycle 1(1): loaded http://localhost:45584/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45584/tests/dromaeo/cssquery-ext.html) 18:33:53 INFO - PROCESS | 20282 | RSS: Main: 199385088 18:33:53 INFO - PROCESS | 20282 | 18:36:56 INFO - PROCESS | 20282 | Cycle 1(1): loaded http://localhost:45584/tests/dromaeo/cssquery-ext.html (next: http://localhost:45584/tests/dromaeo/cssquery-jquery.html) 18:36:56 INFO - PROCESS | 20282 | RSS: Main: 198688768 18:36:56 INFO - PROCESS | 20282 | 18:39:58 INFO - PROCESS | 20282 | Cycle 1(1): loaded http://localhost:45584/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45584/tests/dromaeo/cssquery-mootools.html) 18:39:59 INFO - PROCESS | 20282 | RSS: Main: 199815168 18:39:59 INFO - PROCESS | 20282 | 18:43:01 INFO - PROCESS | 20282 | Cycle 1(1): loaded http://localhost:45584/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45584/tests/dromaeo/cssquery-prototype.html) 18:43:01 INFO - PROCESS | 20282 | RSS: Main: 194195456 18:43:01 INFO - PROCESS | 20282 | 18:46:04 INFO - PROCESS | 20282 | Cycle 1(1): loaded http://localhost:45584/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45584/tests/dromaeo/cssquery-yui.html) 18:46:04 INFO - PROCESS | 20282 | RSS: Main: 197812224 18:46:04 INFO - PROCESS | 20282 | 18:49:08 INFO - PROCESS | 20282 | Cycle 1(1): loaded http://localhost:45584/tests/dromaeo/cssquery-yui.html (next: http://localhost:45584/tests/dromaeo/cssquery-dojo.html) 18:49:08 INFO - PROCESS | 20282 | RSS: Main: 198176768 18:49:08 INFO - PROCESS | 20282 | 18:49:08 INFO - PROCESS | 20282 | __start_tp_report 18:49:08 INFO - PROCESS | 20282 | _x_x_mozilla_page_load 18:49:08 INFO - PROCESS | 20282 | _x_x_mozilla_page_load_details 18:49:08 INFO - PROCESS | 20282 | |i|pagename|runs| 18:49:08 INFO - PROCESS | 20282 | |0;dojo.html;2991;3011.8945836895705;3012.834294113823;3028.6668466468686;3074.0470454159213;5258.579313654908;5298.284731561238;5338.926871741085;5364.088105022146;5446.373667028293;5320.787168513255;5375.193720941861;5454.781808727656;5457.399686034533;5484.890302193964;4746.999999999992;4829.034193161364;4834.97582512087;4854.117224737249;4888.755562221892;4777.187878060738;4806.255030470265;4845.878853028685;4862.343583616202;4890.119778439879;4627.421572303462;4825.396825396825;4834.154023045988;4864.416270047599;4955.504449555034;4658.604018658418;4663.347131401607;4707.435107787088;4765.952340476586;4832.758362081917;4718;4726.6927649703;4745.715257084586;4768.022555376139;4807.759612019385;5249.790008399659;5295.947040529622;5334.786608535654;5340.25236466895;5412.025835349636;5506.752196151183;5547.140193270049;5576.386597474315;5644.238027866268;5656.858578535528;5718.7426565804635;5738.540916726652;5749.913751293734;5798.565107616945;5826.912596311059;5274.340707411574;5284.837335786159;5286.365636123652;5305.336832895888;5336.91994620081;5579.9163012554845;5624.91562626561;5741.339745929188;5827.621204621686;5883.294004719461;5525.419830917776;5589.972050139723;5591.189277554732;5633.605647604711;5642.153676948491;5621.8594535136135;5656.2929633795775;5666.150077488327;5675.858103547362;5680.971595141998;5277.313949186658;5442.292501974718;5590.273264475673;5660.660360378391;5674.914876276859;5667.518260947865;5685.545156387479;5695.7152142392715;5704.201411802351;5793.507551858055;4337.175936572041;4338.0890013097605;4348.630366418826;4377.0808130293;4406.140802543473;3780.3951367781024;3792.1088544192094;3815.637514436124;3861.9806900965878;3925.2738243424487;5328.440513746078;5345.492178243138;5350.3312085989255;5405.4324295949145;5420.728963551806;5715.342735585461;5722.256106706185;5725.1698503716725;5729.54163666914;5730.3410107838135;5305.893882122413;5408.134698448308;5413.160960051198;5425.050616142159;5481.534069604048;4865.927011094836;4884.218525036048;4886.511348865085;4899.2896030075435;4946.826861059845;5833.212516310244;5869.266341707286;5911.645301281937;5932.703364831741;5994.190784244071;5550.084236100998;5632.605717599728;5684.971575142264;5719.399463056319;5732.197492350991;5877.059670452878;5881.73532191061;5949.345571986992;5990.550708696778;5995.310539288038;5561.888762224652;5578.191162281528;5611.1022236443605;5615.354234262949;5640.464155905182;5466.863328416822;5526.80656177048;5732.140178973021;5736.110902810071;5784.334801497882;5453.345598528202;5491.972540137273;5535.944640553704;5565.30433695788;5638.4925356718095;5536.252605898152;5581.860453488695;5582.7766889323975;5585.581081418829;5590.329160500766;5335;5337.919931200958;5436.103042997861;5505.421930697219;5534.08687566547;5520.227168196376;5590.329160500766;5603.131514615241;5615.915761263666;5646;5505.3393592767525;5507.614466987273;5507.972460137674;5517.751701173537;5526.80656177048 18:49:08 INFO - PROCESS | 20282 | |1;ext.html;554.2988120028165;569.0212833925647;572.0189874365464;581.5405829394779;583.2592607388617;41268.79365603172;42090;42155.99999999996;46285.768571157096;46335.30497042547;44284.77857610708;44704.55295447045;44815.32777008339;44824.55175448245;44957.77521112398;8572.399932004762;8711.695090671796;8739.213470787628;8820.823583528325;8830.161134692225;8544.70093546726;8636.438631488933;8660.393772435931;8665.913340866573;8685.739427817176;8668.60991255395;8693.174148455919;8718.825623487526;8735.257503112243;8783.429077109968;8579.227869491744;8628.39601227908;8662.090480499552;8728.214460698568;8730.956345218297;8641.567921603895;8641.697540586112;8655;8687.478751274944;8693.652253909837;41220.58779412197;41250.38124428136;41442.37836432456;41497.377539336936;41518.58481415177;3529.770564913298;3923.8234279457492;3929.7249192556533;3984.063745019918;4043.636072753437;30435.847820760977;30579.69420305813;30584;30890.227744306347;31952.145312903758;4065.2193460082112;4167.437395951538;4180.561041090672;4286.699931004831;4413.536578659258;330050;332725;334433;336576;338504;55003.724981374835;55134.17298740522;55553.72223138859;55779.442205578234;55906.44093559094;58211;58343.70828145917;58573.414265857646;58584.67691538558;58819.70590147022;14257.215853128178;14510.637234069232;14547.709045819025;14593.92703036478;14653.92673036628;11409.087273018138;11591.478383472764;11602.94198529002;11628.592999244986;11632.360220187971;14684.706305873822;15812.130332831804;15855.445059423095;15976.360945562048;16087.195640217942;5724.599278050497;5757.539396848242;5760.74076666551;5816.272965879265;5916.674582897982;857.7083791510792;930.776613612728;976.1361195342173;993.294760719897;1112.3715100967927;28410;31133.844330778655;31687.93546937006;31827.204319891724;31841.681583183872;1064.2231171245035;1070.3898777696638;1074.382230217628;1107.2968664897849;1149.8735139134687;15342.30959606798;16245.700343972454;16296.755548666779;16333.673326533402;16346.673066538602;525589;529132;529618;532138;533317;53638.463615364126;54240.72879635577;54248.728756355966;54249;54296;1270.9809352859716;1316.4010375279224;1319.6568892087935;1320.1419077599637;1326.781081121604;28365;30025.849870750506;30193.245168870955;30275.394492110474;30903.381932361677;47663.76168119276;48319;48378.75810620924;48438.5156148434;48614.27078593753;446571;447909;449930;450146;451055;26971.358866552764;27454.97995220484;27671.861640691666;27824;27864.86067569649;44734.3289850659;45141.32288015748;46207;46539.301910472044;46575.76712116418;38029;38911.41632875452;39466.605333946296;39483.60516394799;40371.79814101028;38195.809020954715;39041.2191756169;39427.40858887062;39431.211375772895;39543;37623.623763762014;38197.80901095477;38812;38850.6114938847;39582;32883.671163289015;34577.39786347967;35034.82482587571;37810.43284350792;38429.231415370974;26729.25790389386;26847.328816779736;26913.73086269112;26989;27316.897786345246 18:49:08 INFO - PROCESS | 20282 | |2;jquery.html;382.4282697367438;383.71103385600765;391.6299097353001;392.4682055814372;411.0443219514629;17501.474955751317;18354.724679129824;18916.716249256257;18924.959127248014;19521.414357569294;16989.320427182898;17302.221400036997;17307.307707691678;17860.106994650247;18288;5485.917711234335;5501.752421141038;5678.772849086053;5705.857353566153;5738.971305143468;5546.556275497971;5669.914951275734;5678.914816277759;5685.232493613371;5689.772409103631;5423.864403389907;5577.8047768327915;5626.2967129108865;5640;5645.350784659755;5552.639078459887;5602.271704678406;5607.551395888319;5612.102063669814;5621.7189140542805;5006.849794506171;5008.84973450797;5019.096562618727;5291.603129765244;5297.973510132463;12993.805092923614;13253.271070091141;13263.933680331633;13452.730945381038;13522.391492382769;2210.9889450552646;2253.2226381898217;2295.36877358726;2309.919152829643;2333.0900948630047;9724.95137524308;10278.33190842593;10333.58665653373;11360.261582997162;13265.27041012744;1841.5212044868297;1886.76415448069;1887.4337698690338;1909.102721720789;1940.7574053243345;74691.25308746897;78368;79643;80295.19704802935;81986.18013819846;10291.228157888188;10380.792384152275;10497.168533485376;10765.084967777826;10771.6229931952;14767.630809229855;14812.629684257765;14887.553373398816;14899.77650335246;14913.478028269175;7448.4041276697735;7702.807429814299;7763.805904852424;8029.7189598363775;8054.114047454776;7381.66782494789;7384.187739348775;7385.741499047615;7558.773236802905;7681.270279323456;4426.712263702849;4439.778011099432;4533.116042371772;4534.455865296186;4646.326282688991;1814.4284550366592;1912.8565357597956;1919.7408349872867;1967.9606407871763;1988.1351612048804;871.7559083456642;911.7492689510306;914.1224424552371;951.7715748220377;964.8552717092352;17950.461486155436;18458;19095.61808763817;19157.521061973563;19158.61682766337;945.857632462473;947.8199142162968;950.1733491861986;968.8837339519303;998.4758002048837;9429.434233945847;10412.947935260276;10492.475376231157;10721.195910306758;10753.892461075446;504203;509025;515419;517351;518742;74158;78174.609126954;78319.2168078312;83730;93845;1015.7003683913116;1024.8411496218248;1079.8920107989295;1085.5006696919347;1087.5160553553592;16464.09447480352;16851.91574042171;17505.474835754947;17580.472585822445;17895.19471623806;39155.6084439152;39384.6061539381;39472.81581552558;39475;40048.39927401033;54576;57494.42505575058;58317;60497.665630280455;60534;8046.356291496783;8236.629351679068;8264.421490495608;8385.119562445856;8511.404201705822;12195.207311524722;12451.75096498083;12813.359332033548;13166.934165329112;13201.669958251121;10330.845037324296;10937.507812148631;10969.670909872717;11174.161937854857;11263.887361126612;10400.947995259976;10501.737456563647;10839.512221950188;11127;11143.108551315712;11095.778084438105;11177.776444470903;11194;11296.378699171624;11405.828912566152;8114.107448180814;8295.585220738818;8311.958440208002;8406.537640429835;8565.871511927451;10353.327033742782;10612.681619551426;10676.46617669129;10915.23593348458;11012.889871101186 18:49:08 INFO - PROCESS | 20282 | |3;mootools.html;1410.273709039844;1441.841397446281;1535.6468012357157;1751.1769468349871;1753.5440785395801;8140.715074972377;8516.489010659365;8810.559472026396;8823.691170809023;8832.867506987384;8440.32477401808;8561.44350617211;8570.57147142642;8576.828463430727;8581.270591999672;2201.922932697356;2213.457702862801;2218.800307972282;2228.92198773043;2235.642297232443;2183.6287831068757;2193.4426557144448;2253.8309626777977;2261.412032871457;2278.1115365007577;2180.869147851126;2182.7053347798083;2195.6706494025866;2201.7027701260286;2222.5999320122373;2165.069020321261;2181.9672704909517;2196.176433837311;2200.185931205448;2215.268961242794;2172.880491572963;2187.8796666183352;2198.032760679183;2200.713907192071;2213.457702862809;8568.528730919797;8621.439606425625;8635.654573817039;8649.740507784776;8894.555272236426;5057.797688092509;5221.242919776611;5227.424983251839;5228.947710522884;5233;3041.863116159778;3224.193951512122;3251.5122731590213;3266.9183270418193;3273.8363081845814;966.9033096690345;1017.6183931025865;1022.5050875862871;1030.103809685571;1054;11901.464434100486;11912.702182445422;11933.94033029838;11973.580924667594;12002.879971200264;4190.51809041964;4331.805068771912;4373.956260437355;4435.183658376889;4496.842610508616;9658.323917325719;9678.467684277291;9708.126268635857;9723.65967191145;9777.951110244403;5055.570276526463;5066.923996140061;5070.721110338893;5074.188129899198;5077.873053173626;4197.748135111903;4498.752568608758;4686.906261874743;4746.59653929413;4747.715137091785;3657.085728567858;3722.4230244312175;3747.9505738393295;3753.6058713834655;3804.486394336729;1112.1769890281296;1115.6095366621616;1117.899389054989;1128.328644456547;1129.9717507062226;828.556722153645;898.7842917699836;922.257582645963;944.7260294514514;956.2254573795248;5544.473275038865;5576.776928922879;5740.483356497935;5805.796797112081;5934;425.7488082031616;435.9476862776487;436.4478934148305;443.28188334897027;444.7087157911573;3734.589195188527;3853.171568112813;3859.1702783901596;3866.5940076292145;3869.941950870739;10354;10763.569457221623;10778.89221107779;10857.837132443019;10916.290441121302;10757.246992710436;10781.299215550964;10807.78384432307;10836.512356943957;10855;7958.243966823143;8026.398020148512;8070.838583228303;8146.103928567972;8174.713885013996;5691.914621280601;5697.572682048946;5765.798197063083;5837.328707198726;5915.940840591539;9662.613495460102;9809.460479673686;9812.705618831162;9833.655822046194;10011.799764004825;9856.408615483095;9911.30620856562;9971.05274998874;10152.340097893613;10187.694369168938;6454.1609590752905;6923.169219693669;7120.60836653989;7146.071010768567;7176.605286709281;8443.36674749384;8465.153484651732;8473.449225800303;8500;8510.617022234139;7199.1001124859395;7401.1488678802625;7550.282723141293;7625.199354067743;7769.7669069928;7179.8564028720175;7511.51175173612;7527.096748390229;7628.122765881994;7698;6427.839304017437;6534.607923524603;6553.344665533408;6558.245801732862;6567.2447668518735;4861.4895435980125;4895.192293271571;5001.874953126201;5011.473795251592;5213.504717051874;4695.530446955414;4806.759662016815;4838.588719958843;4960.727160006234;5001.899962000813 18:49:08 INFO - PROCESS | 20282 | |4;prototype.html;314.6381661089748;330.3393213572854;334.8426239667356;340.2327750921671;340.55217389133287;5310.999999999995;5481.780728770849;5507.614466987313;5542.251796007537;5556.972215138919;5440.347158341005;5449.455054494549;5451.591130665196;5472.589555783312;5538.47384498472;4255;4258.936115958263;4263.829446822124;4274.38021486885;4288.828446862121;3967.9088250731133;4177.227212965611;4235.174141042498;4264.8507302244425;4284.314509678452;4165.083681590046;4180.6237438630515;4182.79086045698;4187.81154848031;4188.5392606813375;4181.686373521983;4188.81150348232;4192.826008717564;4206;4235.724677895927;3601.5858176309534;3711.406175011985;3716.2753263113705;3722.571904231021;3735.794531300777;5296.761645725952;5315.362156541201;5319.5478384337375;5336.279602253724;5375.569954403638;4879.926801097987;4892.21724524078;4895.412550493964;4901.240307752304;4902.2156454967035;5623.76633435772;5747.626404283708;5750.079987202028;5750.6262092963825;5752.338481074688;4064.248114098901;4069.348904175318;4074.633283004544;4083.795810209507;4097.405876147972;5685.800996965087;5777.133429985536;6002.249718785152;6014.3985601439945;6057.363976782419;4081.387791831249;4156.168766246763;4162.895927601834;4176.352665336878;4179.519355274121;4235.618794308527;4236.76697781625;4237.660987121023;4239.194553034913;4251.489821221473;4791.856244312677;4851.830185943475;4868.805247790119;4872.78072486739;4893.580861550182;5731.8567035824435;5737.713114344266;5737.885242295214;5758.712064396847;5766;1448.5726710620393;1466.662667586461;1473.1750219876903;1473.6978919321514;1475.6384685751846;899.4430409096908;943.1087622196958;946.7207173883721;958.1951161024773;966.429806414219;4826.624412042551;4857.951420485821;4858.979614281041;4861.222204447272;4873.830280732599;5117.032121369597;5130.846074617767;5170.870728231825;5223.503767142115;5240.659357141773;4494.977525112419;4805.303231031551;4858.854234372974;4869.561739443467;4930.556249937523;2703.5539136042335;2717.8233414827973;2743.547314693093;2747.244507760342;2749.721379558475;5297.708626025528;5320.600954928396;5348.197770334403;5379.515843574019;5381.4349493303425;5212.247182028933;5214.348206474191;5556.91664625031;6025.276966764016;6040.637561746309;6127.111568822495;6173.259208894961;6182.721777520022;6188.783392581238;6245.219347581461;5616.803411880564;5958.791442299672;5970.492508136857;5982.965791630866;6025.246844144482;5897.5281977440845;5908.291005079246;5930.169776231245;5947.851303717442;5986.730597123227;5966.731497082555;6147.354527774519;6179.320274769681;6214.5028397728975;6284.748610055546;4168.708190426641;4220.95779042218;4250.936235956525;4253.404523366669;4265.829366825292;5757.596968212352;5950.940490595039;5962.25471816023;5967.612105213321;6075.817725468243;5764.654120752768;5770.3652598215;5771.989901767258;5802.912956305743;5808.39011903744;5771.797987070432;5798.666306749556;5815.41845815415;5843.386444423274;5855.443732845373;5394.78420863161;5690.146478028329;5708.628939118944;5743.74153163117;5779.335376431764;5839.678817664899;5853.2976042875125;5861.743228856835;5869.7945571904775;5878.030125029322;5450.31871016123;5662.188099808021;5727.828165155052;5745.798897038583;5759.481646651821 18:49:08 INFO - PROCESS | 20282 | |5;yui.html;711.0720509734796;759.4531937005357;789.7157023471552;819.0989911097797;832.5961908474391;13761.793573096398;14548.92725536371;14670.413183472674;14760.188189649565;14770.187639679827;13749.58751237462;13774.173549587033;13882.722345553082;13904.0962337448;13916.582502524916;779.2324560308092;796.24356860982;798.3174385900058;804.3565147881701;804.388664614894;777.5062835099695;793.1077537770009;797.5693125712108;813.4915677701437;813.8250276190618;843.3464065349342;844.2359664503604;846.4371193156575;846.7163500227431;847.6990668312752;843.2200214801314;843.3590471241839;843.4096132707068;843.6161546496329;844.3582877013453;611.7583554495949;616.1589430427434;616.2112496005076;616.4267231474727;616.4913945994527;15048.699026019527;15237;15237;15258.084514929029;15260.160691161982;14502.927485362612;14733.55799326022;14787.186704731235;14880.181590012546;15004.474843380538;11641.76716465666;11685.47415366302;11711.88288117125;11874.52501899923;12381.195222310522;3775.169462718198;3801.030737162006;3928.2339943710986;4010.47863777707;4017.959820401817;79386.20613793904;79981.60009199975;80528.38943221161;80874;81590.59204703997;10800.567977280822;11313;11331.150163737753;11531.48108335127;11604.477798499087;21391.67912481314;21572.56854862894;21596.56806863854;21621.67567486489;21697.13211471555;7644.579548124907;7856.764297071097;8336.374771892133;8383.748487545383;8419.158084191655;4123.484564429446;4220.345846393752;4269.786510674454;4320.697551171451;4341.218580655449;3388.0852169913987;3471.6181220065773;3486.8953931381593;3492.5983511895947;3503.9299214016087;557.5177471487216;569.1974316214119;571.2801869644278;597.3638075449633;599.3706608061605;601.5127746525328;620.1565870416231;648.8086014625696;731.294300999538;743.5427212264418;9281.860772088425;9403.34176607631;9755.36590121654;9767.725373785252;9797.118259356692;574.7586013874183;580.2091937779295;633.5058654249692;649.3344322069917;728.8724473217165;4321.330193819963;4331.523532411432;4586.174488592085;4677.134730074879;4720.716756994591;70578.29421705718;70668;71608.64195678988;125801.37099314445;126729;103659;111062.44468777605;111343;112675.43662281636;115136.42431787787;57310.42689573051;85206.57396712976;88606.55696721475;92362;95466;8320.916790832256;8669.739907802776;8741.256993155654;8774.605142768463;8854.291656667323;38053.61946380611;47588.52411475979;51626;52391.21413178729;54208;73240;75070.6246468786;75421;77656;78518.60740696489;10694.251402401756;10874.510647020745;10947.482079122006;11116.277441966246;11173.944130279297;12244.265344079384;13166;13549.187048777105;13893.166410015432;14102.858971410154;11989.820152697543;12522.624321270376;12654.987600992083;12979.610611681665;12989.740205196033;12526.006669653223;12768.489260429478;13102.868971310547;13133.474661013452;13202.669933251362;12044.819327710267;12517.93741031289;12818.487260509848;12959.870401295866;13522.25627590492;9515.191208747057;9657.696211011704;9793.559289831832;9914.256430767577;9920.00799920031;9496.14534691881;10168.084872361524;10242.795144097225;10311.896881031395;10339.586416543254 18:49:08 INFO - PROCESS | 20282 | __end_tp_report 18:49:08 INFO - PROCESS | 20282 | __start_cc_report 18:49:08 INFO - PROCESS | 20282 | _x_x_mozilla_cycle_collect,325 18:49:08 INFO - PROCESS | 20282 | __end_cc_report 18:49:08 INFO - PROCESS | 20282 | __startTimestamp1476323348292__endTimestamp 18:49:08 INFO - PROCESS | 20282 | 18:49:08 INFO - PROCESS | 20282 | ------- Summary: start ------- 18:49:08 INFO - PROCESS | 20282 | Number of tests: 6 18:49:08 INFO - PROCESS | 20282 | 18:49:08 INFO - PROCESS | 20282 | [#0] dojo.html Cycles:165 Average:5271.53 Median:5491.97 stddev:612.50 (11.2%) stddev-sans-first:587.67 18:49:08 INFO - PROCESS | 20282 | Values: 2991.0 3011.9 3012.8 3028.7 3074.0 5258.6 5298.3 5338.9 5364.1 5446.4 5320.8 5375.2 5454.8 5457.4 5484.9 4747.0 4829.0 4835.0 4854.1 4888.8 4777.2 4806.3 4845.9 4862.3 4890.1 4627.4 4825.4 4834.2 4864.4 4955.5 4658.6 4663.3 4707.4 4766.0 4832.8 4718.0 4726.7 4745.7 4768.0 4807.8 5249.8 5295.9 5334.8 5340.3 5412.0 5506.8 5547.1 5576.4 5644.2 5656.9 5718.7 5738.5 5749.9 5798.6 5826.9 5274.3 5284.8 5286.4 5305.3 5336.9 5579.9 5624.9 5741.3 5827.6 5883.3 5525.4 5590.0 5591.2 5633.6 5642.2 5621.9 5656.3 5666.2 5675.9 5681.0 5277.3 5442.3 5590.3 5660.7 5674.9 5667.5 5685.5 5695.7 5704.2 5793.5 4337.2 4338.1 4348.6 4377.1 4406.1 3780.4 3792.1 3815.6 3862.0 3925.3 5328.4 5345.5 5350.3 5405.4 5420.7 5715.3 5722.3 5725.2 5729.5 5730.3 5305.9 5408.1 5413.2 5425.1 5481.5 4865.9 4884.2 4886.5 4899.3 4946.8 5833.2 5869.3 5911.6 5932.7 5994.2 5550.1 5632.6 5685.0 5719.4 5732.2 5877.1 5881.7 5949.3 5990.6 5995.3 5561.9 5578.2 5611.1 5615.4 5640.5 5466.9 5526.8 5732.1 5736.1 5784.3 5453.3 5492.0 5535.9 5565.3 5638.5 5536.3 5581.9 5582.8 5585.6 5590.3 5335.0 5337.9 5436.1 5505.4 5534.1 5520.2 5590.3 5603.1 5615.9 5646.0 5505.3 5507.6 5508.0 5517.8 5526.8 18:49:08 INFO - PROCESS | 20282 | 18:49:08 INFO - PROCESS | 20282 | [#1] ext.html Cycles:180 Average:58992.81 Median:41469.88 stddev:118190.73 (285.0%) stddev-sans-first:118440.85 18:49:08 INFO - PROCESS | 20282 | Values: 554.3 569.0 572.0 581.5 583.3 41268.8 42090.0 42156.0 46285.8 46335.3 44284.8 44704.6 44815.3 44824.6 44957.8 8572.4 8711.7 8739.2 8820.8 8830.2 8544.7 8636.4 8660.4 8665.9 8685.7 8668.6 8693.2 8718.8 8735.3 8783.4 8579.2 8628.4 8662.1 8728.2 8731.0 8641.6 8641.7 8655.0 8687.5 8693.7 41220.6 41250.4 41442.4 41497.4 41518.6 3529.8 3923.8 3929.7 3984.1 4043.6 30435.8 30579.7 30584.0 30890.2 31952.1 4065.2 4167.4 4180.6 4286.7 4413.5 330050.0 332725.0 334433.0 336576.0 338504.0 55003.7 55134.2 55553.7 55779.4 55906.4 58211.0 58343.7 58573.4 58584.7 58819.7 14257.2 14510.6 14547.7 14593.9 14653.9 11409.1 11591.5 11602.9 11628.6 11632.4 14684.7 15812.1 15855.4 15976.4 16087.2 5724.6 5757.5 5760.7 5816.3 5916.7 857.7 930.8 976.1 993.3 1112.4 28410.0 31133.8 31687.9 31827.2 31841.7 1064.2 1070.4 1074.4 1107.3 1149.9 15342.3 16245.7 16296.8 16333.7 16346.7 525589.0 529132.0 529618.0 532138.0 533317.0 53638.5 54240.7 54248.7 54249.0 54296.0 1271.0 1316.4 1319.7 1320.1 1326.8 28365.0 30025.8 30193.2 30275.4 30903.4 47663.8 48319.0 48378.8 48438.5 48614.3 446571.0 447909.0 449930.0 450146.0 451055.0 26971.4 27455.0 27671.9 27824.0 27864.9 44734.3 45141.3 46207.0 46539.3 46575.8 38029.0 38911.4 39466.6 39483.6 40371.8 38195.8 39041.2 39427.4 39431.2 39543.0 37623.6 38197.8 38812.0 38850.6 39582.0 32883.7 34577.4 35034.8 37810.4 38429.2 26729.3 26847.3 26913.7 26989.0 27316.9 18:49:08 INFO - PROCESS | 20282 | 18:49:08 INFO - PROCESS | 20282 | [#2] jquery.html Cycles:180 Average:28709.27 Median:19773.62 stddev:84318.68 (426.4%) stddev-sans-first:84528.39 18:49:08 INFO - PROCESS | 20282 | Values: 382.4 383.7 391.6 392.5 411.0 17501.5 18354.7 18916.7 18925.0 19521.4 16989.3 17302.2 17307.3 17860.1 18288.0 5485.9 5501.8 5678.8 5705.9 5739.0 5546.6 5669.9 5678.9 5685.2 5689.8 5423.9 5577.8 5626.3 5640.0 5645.4 5552.6 5602.3 5607.6 5612.1 5621.7 5006.8 5008.8 5019.1 5291.6 5298.0 12993.8 13253.3 13263.9 13452.7 13522.4 2211.0 2253.2 2295.4 2309.9 2333.1 9725.0 10278.3 10333.6 11360.3 13265.3 1841.5 1886.8 1887.4 1909.1 1940.8 74691.3 78368.0 79643.0 80295.2 81986.2 10291.2 10380.8 10497.2 10765.1 10771.6 14767.6 14812.6 14887.6 14899.8 14913.5 7448.4 7702.8 7763.8 8029.7 8054.1 7381.7 7384.2 7385.7 7558.8 7681.3 4426.7 4439.8 4533.1 4534.5 4646.3 1814.4 1912.9 1919.7 1968.0 1988.1 871.8 911.7 914.1 951.8 964.9 17950.5 18458.0 19095.6 19157.5 19158.6 945.9 947.8 950.2 968.9 998.5 9429.4 10412.9 10492.5 10721.2 10753.9 504203.0 509025.0 515419.0 517351.0 518742.0 74158.0 78174.6 78319.2 83730.0 93845.0 1015.7 1024.8 1079.9 1085.5 1087.5 16464.1 16851.9 17505.5 17580.5 17895.2 39155.6 39384.6 39472.8 39475.0 40048.4 54576.0 57494.4 58317.0 60497.7 60534.0 8046.4 8236.6 8264.4 8385.1 8511.4 12195.2 12451.8 12813.4 13166.9 13201.7 10330.8 10937.5 10969.7 11174.2 11263.9 10400.9 10501.7 10839.5 11127.0 11143.1 11095.8 11177.8 11194.0 11296.4 11405.8 8114.1 8295.6 8312.0 8406.5 8565.9 10353.3 10612.7 10676.5 10915.2 11012.9 18:49:08 INFO - PROCESS | 20282 | 18:49:08 INFO - PROCESS | 20282 | [#3] mootools.html Cycles:180 Average:5594.37 Median:4878.34 stddev:3257.31 (66.8%) stddev-sans-first:3251.28 18:49:08 INFO - PROCESS | 20282 | Values: 1410.3 1441.8 1535.6 1751.2 1753.5 8140.7 8516.5 8810.6 8823.7 8832.9 8440.3 8561.4 8570.6 8576.8 8581.3 2201.9 2213.5 2218.8 2228.9 2235.6 2183.6 2193.4 2253.8 2261.4 2278.1 2180.9 2182.7 2195.7 2201.7 2222.6 2165.1 2182.0 2196.2 2200.2 2215.3 2172.9 2187.9 2198.0 2200.7 2213.5 8568.5 8621.4 8635.7 8649.7 8894.6 5057.8 5221.2 5227.4 5228.9 5233.0 3041.9 3224.2 3251.5 3266.9 3273.8 966.9 1017.6 1022.5 1030.1 1054.0 11901.5 11912.7 11933.9 11973.6 12002.9 4190.5 4331.8 4374.0 4435.2 4496.8 9658.3 9678.5 9708.1 9723.7 9778.0 5055.6 5066.9 5070.7 5074.2 5077.9 4197.7 4498.8 4686.9 4746.6 4747.7 3657.1 3722.4 3748.0 3753.6 3804.5 1112.2 1115.6 1117.9 1128.3 1130.0 828.6 898.8 922.3 944.7 956.2 5544.5 5576.8 5740.5 5805.8 5934.0 425.7 435.9 436.4 443.3 444.7 3734.6 3853.2 3859.2 3866.6 3869.9 10354.0 10763.6 10778.9 10857.8 10916.3 10757.2 10781.3 10807.8 10836.5 10855.0 7958.2 8026.4 8070.8 8146.1 8174.7 5691.9 5697.6 5765.8 5837.3 5915.9 9662.6 9809.5 9812.7 9833.7 10011.8 9856.4 9911.3 9971.1 10152.3 10187.7 6454.2 6923.2 7120.6 7146.1 7176.6 8443.4 8465.2 8473.4 8500.0 8510.6 7199.1 7401.1 7550.3 7625.2 7769.8 7179.9 7511.5 7527.1 7628.1 7698.0 6427.8 6534.6 6553.3 6558.2 6567.2 4861.5 4895.2 5001.9 5011.5 5213.5 4695.5 4806.8 4838.6 4960.7 5001.9 18:49:08 INFO - PROCESS | 20282 | 18:49:08 INFO - PROCESS | 20282 | [#4] prototype.html Cycles:180 Average:4745.01 Median:5317.45 stddev:1419.12 (26.7%) stddev-sans-first:1383.59 18:49:08 INFO - PROCESS | 20282 | Values: 314.6 330.3 334.8 340.2 340.6 5311.0 5481.8 5507.6 5542.3 5557.0 5440.3 5449.5 5451.6 5472.6 5538.5 4255.0 4258.9 4263.8 4274.4 4288.8 3967.9 4177.2 4235.2 4264.9 4284.3 4165.1 4180.6 4182.8 4187.8 4188.5 4181.7 4188.8 4192.8 4206.0 4235.7 3601.6 3711.4 3716.3 3722.6 3735.8 5296.8 5315.4 5319.5 5336.3 5375.6 4879.9 4892.2 4895.4 4901.2 4902.2 5623.8 5747.6 5750.1 5750.6 5752.3 4064.2 4069.3 4074.6 4083.8 4097.4 5685.8 5777.1 6002.2 6014.4 6057.4 4081.4 4156.2 4162.9 4176.4 4179.5 4235.6 4236.8 4237.7 4239.2 4251.5 4791.9 4851.8 4868.8 4872.8 4893.6 5731.9 5737.7 5737.9 5758.7 5766.0 1448.6 1466.7 1473.2 1473.7 1475.6 899.4 943.1 946.7 958.2 966.4 4826.6 4858.0 4859.0 4861.2 4873.8 5117.0 5130.8 5170.9 5223.5 5240.7 4495.0 4805.3 4858.9 4869.6 4930.6 2703.6 2717.8 2743.5 2747.2 2749.7 5297.7 5320.6 5348.2 5379.5 5381.4 5212.2 5214.3 5556.9 6025.3 6040.6 6127.1 6173.3 6182.7 6188.8 6245.2 5616.8 5958.8 5970.5 5983.0 6025.2 5897.5 5908.3 5930.2 5947.9 5986.7 5966.7 6147.4 6179.3 6214.5 6284.7 4168.7 4221.0 4250.9 4253.4 4265.8 5757.6 5950.9 5962.3 5967.6 6075.8 5764.7 5770.4 5772.0 5802.9 5808.4 5771.8 5798.7 5815.4 5843.4 5855.4 5394.8 5690.1 5708.6 5743.7 5779.3 5839.7 5853.3 5861.7 5869.8 5878.0 5450.3 5662.2 5727.8 5745.8 5759.5 18:49:08 INFO - PROCESS | 20282 | 18:49:08 INFO - PROCESS | 20282 | [#5] yui.html Cycles:180 Average:20212.56 Median:4698.93 stddev:29770.28 (633.6%) stddev-sans-first:29817.78 18:49:08 INFO - PROCESS | 20282 | Values: 711.1 759.5 789.7 819.1 832.6 13761.8 14548.9 14670.4 14760.2 14770.2 13749.6 13774.2 13882.7 13904.1 13916.6 779.2 796.2 798.3 804.4 804.4 777.5 793.1 797.6 813.5 813.8 843.3 844.2 846.4 846.7 847.7 843.2 843.4 843.4 843.6 844.4 611.8 616.2 616.2 616.4 616.5 15048.7 15237.0 15237.0 15258.1 15260.2 14502.9 14733.6 14787.2 14880.2 15004.5 11641.8 11685.5 11711.9 11874.5 12381.2 3775.2 3801.0 3928.2 4010.5 4018.0 79386.2 79981.6 80528.4 80874.0 81590.6 10800.6 11313.0 11331.2 11531.5 11604.5 21391.7 21572.6 21596.6 21621.7 21697.1 7644.6 7856.8 8336.4 8383.7 8419.2 4123.5 4220.3 4269.8 4320.7 4341.2 3388.1 3471.6 3486.9 3492.6 3503.9 557.5 569.2 571.3 597.4 599.4 601.5 620.2 648.8 731.3 743.5 9281.9 9403.3 9755.4 9767.7 9797.1 574.8 580.2 633.5 649.3 728.9 4321.3 4331.5 4586.2 4677.1 4720.7 70578.3 70668.0 71608.6 125801.4 126729.0 103659.0 111062.4 111343.0 112675.4 115136.4 57310.4 85206.6 88606.6 92362.0 95466.0 8320.9 8669.7 8741.3 8774.6 8854.3 38053.6 47588.5 51626.0 52391.2 54208.0 73240.0 75070.6 75421.0 77656.0 78518.6 10694.3 10874.5 10947.5 11116.3 11173.9 12244.3 13166.0 13549.2 13893.2 14102.9 11989.8 12522.6 12655.0 12979.6 12989.7 12526.0 12768.5 13102.9 13133.5 13202.7 12044.8 12517.9 12818.5 12959.9 13522.3 9515.2 9657.7 9793.6 9914.3 9920.0 9496.1 10168.1 10242.8 10311.9 10339.6 18:49:08 INFO - PROCESS | 20282 | -------- Summary: end -------- 18:49:08 INFO - PROCESS | 20282 | 18:49:09 INFO - TEST-INFO | 20282: exit 0 18:49:09 INFO - TEST-OK | dromaeo_css | took 1117205ms 18:49:09 INFO - TEST-START | kraken 18:49:09 INFO - operating with platform_type : linux_ 18:49:09 INFO - Initialising browser for kraken test... 18:49:09 INFO - TEST-INFO | started process 20642 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEo7qaG/profile http://localhost:45584/getInfo.html) 18:49:13 INFO - PROCESS | 20642 | __metrics Screen width/height:1600/1200 18:49:13 INFO - PROCESS | 20642 | colorDepth:24 18:49:13 INFO - PROCESS | 20642 | Browser inner width/height: 1024/697 18:49:13 INFO - PROCESS | 20642 | __metrics 18:49:14 ERROR - PROCESS | 20642 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 18:49:15 INFO - TEST-INFO | 20642: exit 0 18:49:15 INFO - Browser initialized. 18:49:15 INFO - Running cycle 1/1 for kraken test... 18:49:15 INFO - TEST-INFO | started process 20765 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEo7qaG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:49:27 INFO - PROCESS | 20765 | RSS: Main: 185139200 18:49:27 INFO - PROCESS | 20765 | 18:49:30 INFO - PROCESS | 20765 | Cycle 1(1): loaded http://localhost:45584/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45584/tests/kraken/driver.html?testName=audio-beat-detection) 18:49:31 INFO - PROCESS | 20765 | RSS: Main: 199208960 18:49:31 INFO - PROCESS | 20765 | 18:49:33 INFO - PROCESS | 20765 | Cycle 1(1): loaded http://localhost:45584/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45584/tests/kraken/driver.html?testName=audio-dft) 18:49:34 INFO - PROCESS | 20765 | RSS: Main: 196894720 18:49:34 INFO - PROCESS | 20765 | 18:49:37 INFO - PROCESS | 20765 | Cycle 1(1): loaded http://localhost:45584/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45584/tests/kraken/driver.html?testName=audio-fft) 18:49:38 INFO - PROCESS | 20765 | RSS: Main: 192081920 18:49:38 INFO - PROCESS | 20765 | 18:49:40 INFO - PROCESS | 20765 | Cycle 1(1): loaded http://localhost:45584/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45584/tests/kraken/driver.html?testName=audio-oscillator) 18:49:40 INFO - PROCESS | 20765 | RSS: Main: 192802816 18:49:40 INFO - PROCESS | 20765 | 18:49:42 INFO - PROCESS | 20765 | Cycle 1(1): loaded http://localhost:45584/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45584/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:49:43 INFO - PROCESS | 20765 | RSS: Main: 193253376 18:49:43 INFO - PROCESS | 20765 | 18:49:46 INFO - PROCESS | 20765 | Cycle 1(1): loaded http://localhost:45584/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45584/tests/kraken/driver.html?testName=imaging-darkroom) 18:49:47 INFO - PROCESS | 20765 | RSS: Main: 193159168 18:49:47 INFO - PROCESS | 20765 | 18:49:50 INFO - PROCESS | 20765 | Cycle 1(1): loaded http://localhost:45584/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45584/tests/kraken/driver.html?testName=imaging-desaturate) 18:49:51 INFO - PROCESS | 20765 | RSS: Main: 191758336 18:49:51 INFO - PROCESS | 20765 | 18:49:54 INFO - PROCESS | 20765 | Cycle 1(1): loaded http://localhost:45584/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45584/tests/kraken/driver.html?testName=json-parse-financial) 18:49:54 INFO - PROCESS | 20765 | RSS: Main: 192995328 18:49:54 INFO - PROCESS | 20765 | 18:49:56 INFO - PROCESS | 20765 | Cycle 1(1): loaded http://localhost:45584/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45584/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:49:57 INFO - PROCESS | 20765 | RSS: Main: 192950272 18:49:57 INFO - PROCESS | 20765 | 18:49:58 INFO - PROCESS | 20765 | Cycle 1(1): loaded http://localhost:45584/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45584/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:49:59 INFO - PROCESS | 20765 | RSS: Main: 193257472 18:49:59 INFO - PROCESS | 20765 | 18:50:01 INFO - PROCESS | 20765 | Cycle 1(1): loaded http://localhost:45584/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45584/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:50:02 INFO - PROCESS | 20765 | RSS: Main: 193212416 18:50:02 INFO - PROCESS | 20765 | 18:50:05 INFO - PROCESS | 20765 | Cycle 1(1): loaded http://localhost:45584/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45584/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:50:05 INFO - PROCESS | 20765 | RSS: Main: 194203648 18:50:05 INFO - PROCESS | 20765 | 18:50:08 INFO - PROCESS | 20765 | Cycle 1(1): loaded http://localhost:45584/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45584/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:50:09 INFO - PROCESS | 20765 | RSS: Main: 194228224 18:50:09 INFO - PROCESS | 20765 | 18:50:11 INFO - PROCESS | 20765 | Cycle 1(1): loaded http://localhost:45584/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45584/tests/kraken/driver.html?testName=ai-astar) 18:50:11 INFO - PROCESS | 20765 | RSS: Main: 195047424 18:50:11 INFO - PROCESS | 20765 | 18:50:11 INFO - PROCESS | 20765 | __start_tp_report 18:50:11 INFO - PROCESS | 20765 | _x_x_mozilla_page_load 18:50:11 INFO - PROCESS | 20765 | _x_x_mozilla_page_load_details 18:50:11 INFO - PROCESS | 20765 | |i|pagename|runs| 18:50:11 INFO - PROCESS | 20765 | |0;ai-astar;106;114;113;112;112;112;113;113;112;110 18:50:11 INFO - PROCESS | 20765 | |1;audio-beat-detection;162;129;126;176;127;131;126;128;155;127 18:50:11 INFO - PROCESS | 20765 | |2;audio-dft;162;163;163;164;164;163;164;161;165;163 18:50:11 INFO - PROCESS | 20765 | |3;audio-fft;76;78;77;108;78;76;77;75;109;76 18:50:11 INFO - PROCESS | 20765 | |4;audio-oscillator;82;82;112;82;83;83;103;84;83;111 18:50:11 INFO - PROCESS | 20765 | |5;imaging-gaussian-blur;118;117;118;118;119;118;118;119;118;119 18:50:11 INFO - PROCESS | 20765 | |6;imaging-darkroom;148;147;149;146;146;146;147;146;147;147 18:50:11 INFO - PROCESS | 20765 | |7;imaging-desaturate;97;96;96;95;95;96;97;96;96;97 18:50:11 INFO - PROCESS | 20765 | |8;json-parse-financial;55;60;58;56;57;55;55;57;56;55 18:50:11 INFO - PROCESS | 20765 | |9;json-stringify-tinderbox;64;61;61;61;62;62;62;61;62;60 18:50:11 INFO - PROCESS | 20765 | |10;stanford-crypto-aes;82;80;83;84;87;81;80;83;81;79 18:50:11 INFO - PROCESS | 20765 | |11;stanford-crypto-ccm;140;151;146;134;138;131;138;131;189;146 18:50:11 INFO - PROCESS | 20765 | |12;stanford-crypto-pbkdf2;167;172;167;168;167;174;167;166;176;168 18:50:11 INFO - PROCESS | 20765 | |13;stanford-crypto-sha256-iterative;68;66;69;66;66;66;69;67;70;70 18:50:11 INFO - PROCESS | 20765 | __end_tp_report 18:50:11 INFO - PROCESS | 20765 | __start_cc_report 18:50:11 INFO - PROCESS | 20765 | _x_x_mozilla_cycle_collect,804 18:50:11 INFO - PROCESS | 20765 | __end_cc_report 18:50:11 INFO - PROCESS | 20765 | __startTimestamp1476323411286__endTimestamp 18:50:11 INFO - PROCESS | 20765 | 18:50:11 INFO - PROCESS | 20765 | ------- Summary: start ------- 18:50:11 INFO - PROCESS | 20765 | Number of tests: 14 18:50:11 INFO - PROCESS | 20765 | 18:50:11 INFO - PROCESS | 20765 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.50 stddev:2.26 (2.0%) stddev-sans-first:1.12 18:50:11 INFO - PROCESS | 20765 | Values: 106.0 114.0 113.0 112.0 112.0 112.0 113.0 113.0 112.0 110.0 18:50:11 INFO - PROCESS | 20765 | 18:50:11 INFO - PROCESS | 20765 | [#1] audio-beat-detection Cycles:10 Average:138.70 Median:130.00 stddev:18.45 (14.2%) stddev-sans-first:17.54 18:50:11 INFO - PROCESS | 20765 | Values: 162.0 129.0 126.0 176.0 127.0 131.0 126.0 128.0 155.0 127.0 18:50:11 INFO - PROCESS | 20765 | 18:50:11 INFO - PROCESS | 20765 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:1.14 (0.7%) stddev-sans-first:1.12 18:50:11 INFO - PROCESS | 20765 | Values: 162.0 163.0 163.0 164.0 164.0 163.0 164.0 161.0 165.0 163.0 18:50:11 INFO - PROCESS | 20765 | 18:50:11 INFO - PROCESS | 20765 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.50 stddev:13.47 (17.6%) stddev-sans-first:14.05 18:50:11 INFO - PROCESS | 20765 | Values: 76.0 78.0 77.0 108.0 78.0 76.0 77.0 75.0 109.0 76.0 18:50:11 INFO - PROCESS | 20765 | 18:50:11 INFO - PROCESS | 20765 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:82.50 stddev:12.76 (15.5%) stddev-sans-first:13.16 18:50:11 INFO - PROCESS | 20765 | Values: 82.0 82.0 112.0 82.0 83.0 83.0 103.0 84.0 83.0 111.0 18:50:11 INFO - PROCESS | 20765 | 18:50:11 INFO - PROCESS | 20765 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 18:50:11 INFO - PROCESS | 20765 | Values: 118.0 117.0 118.0 118.0 119.0 118.0 118.0 119.0 118.0 119.0 18:50:11 INFO - PROCESS | 20765 | 18:50:11 INFO - PROCESS | 20765 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:0.97 18:50:11 INFO - PROCESS | 20765 | Values: 148.0 147.0 149.0 146.0 146.0 146.0 147.0 146.0 147.0 147.0 18:50:11 INFO - PROCESS | 20765 | 18:50:11 INFO - PROCESS | 20765 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 18:50:11 INFO - PROCESS | 20765 | Values: 97.0 96.0 96.0 95.0 95.0 96.0 97.0 96.0 96.0 97.0 18:50:11 INFO - PROCESS | 20765 | 18:50:11 INFO - PROCESS | 20765 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.50 stddev:1.65 (2.9%) stddev-sans-first:1.67 18:50:11 INFO - PROCESS | 20765 | Values: 55.0 60.0 58.0 56.0 57.0 55.0 55.0 57.0 56.0 55.0 18:50:11 INFO - PROCESS | 20765 | 18:50:11 INFO - PROCESS | 20765 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:1.07 (1.7%) stddev-sans-first:0.71 18:50:11 INFO - PROCESS | 20765 | Values: 64.0 61.0 61.0 61.0 62.0 62.0 62.0 61.0 62.0 60.0 18:50:11 INFO - PROCESS | 20765 | 18:50:11 INFO - PROCESS | 20765 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.50 stddev:2.36 (2.9%) stddev-sans-first:2.50 18:50:11 INFO - PROCESS | 20765 | Values: 82.0 80.0 83.0 84.0 87.0 81.0 80.0 83.0 81.0 79.0 18:50:11 INFO - PROCESS | 20765 | 18:50:11 INFO - PROCESS | 20765 | [#11] stanford-crypto-ccm Cycles:10 Average:144.40 Median:143.00 stddev:17.02 (11.9%) stddev-sans-first:17.98 18:50:11 INFO - PROCESS | 20765 | Values: 140.0 151.0 146.0 134.0 138.0 131.0 138.0 131.0 189.0 146.0 18:50:11 INFO - PROCESS | 20765 | 18:50:11 INFO - PROCESS | 20765 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.20 Median:168.00 stddev:3.49 (2.1%) stddev-sans-first:3.61 18:50:11 INFO - PROCESS | 20765 | Values: 167.0 172.0 167.0 168.0 167.0 174.0 167.0 166.0 176.0 168.0 18:50:11 INFO - PROCESS | 20765 | 18:50:11 INFO - PROCESS | 20765 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.50 stddev:1.70 (2.5%) stddev-sans-first:1.80 18:50:11 INFO - PROCESS | 20765 | Values: 68.0 66.0 69.0 66.0 66.0 66.0 69.0 67.0 70.0 70.0 18:50:11 INFO - PROCESS | 20765 | -------- Summary: end -------- 18:50:11 INFO - PROCESS | 20765 | 18:50:11 INFO - PROCESS | 20765 | 18:50:11 INFO - PROCESS | 20765 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 18:50:11 INFO - PROCESS | 20765 | 18:50:11 INFO - PROCESS | 20765 | 18:50:11 INFO - PROCESS | 20765 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 18:50:11 INFO - PROCESS | 20765 | 18:50:11 INFO - PROCESS | 20765 | 18:50:11 INFO - PROCESS | 20765 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 18:50:11 INFO - PROCESS | 20765 | 18:50:11 INFO - PROCESS | 20765 | 18:50:11 INFO - PROCESS | 20765 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000A,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 18:50:11 INFO - PROCESS | 20765 | 18:50:11 INFO - PROCESS | 20765 | 18:50:11 INFO - PROCESS | 20765 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 18:50:11 INFO - PROCESS | 20765 | 18:50:12 INFO - TEST-INFO | 20765: exit 0 18:50:12 INFO - TEST-OK | kraken | took 63107ms 18:50:12 INFO - SUITE-END | took 1180s 18:50:12 INFO - Completed test suite (00:19:40) 18:50:12 INFO - javascript benchmark 18:50:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7028.137103011817, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2991.0, 3011.8945836895705, 3012.834294113823, 3028.6668466468686, 3074.0470454159213, 5258.579313654908, 5298.284731561238, 5338.926871741085, 5364.088105022146, 5446.373667028293, 5320.787168513255, 5375.193720941861, 5454.781808727656, 5457.399686034533, 5484.890302193964, 4746.999999999992, 4829.034193161364, 4834.97582512087, 4854.117224737249, 4888.755562221892, 4777.187878060738, 4806.255030470265, 4845.878853028685, 4862.343583616202, 4890.119778439879, 4627.421572303462, 4825.396825396825, 4834.154023045988, 4864.416270047599, 4955.504449555034, 4658.604018658418, 4663.347131401607, 4707.435107787088, 4765.952340476586, 4832.758362081917, 4718.0, 4726.6927649703, 4745.715257084586, 4768.022555376139, 4807.759612019385, 5249.790008399659, 5295.947040529622, 5334.786608535654, 5340.25236466895, 5412.025835349636, 5506.752196151183, 5547.140193270049, 5576.386597474315, 5644.238027866268, 5656.858578535528, 5718.7426565804635, 5738.540916726652, 5749.913751293734, 5798.565107616945, 5826.912596311059, 5274.340707411574, 5284.837335786159, 5286.365636123652, 5305.336832895888, 5336.91994620081, 5579.9163012554845, 5624.91562626561, 5741.339745929188, 5827.621204621686, 5883.294004719461, 5525.419830917776, 5589.972050139723, 5591.189277554732, 5633.605647604711, 5642.153676948491, 5621.8594535136135, 5656.2929633795775, 5666.150077488327, 5675.858103547362, 5680.971595141998, 5277.313949186658, 5442.292501974718, 5590.273264475673, 5660.660360378391, 5674.914876276859, 5667.518260947865, 5685.545156387479, 5695.7152142392715, 5704.201411802351, 5793.507551858055, 4337.175936572041, 4338.0890013097605, 4348.630366418826, 4377.0808130293, 4406.140802543473, 3780.3951367781024, 3792.1088544192094, 3815.637514436124, 3861.9806900965878, 3925.2738243424487, 5328.440513746078, 5345.492178243138, 5350.3312085989255, 5405.4324295949145, 5420.728963551806, 5715.342735585461, 5722.256106706185, 5725.1698503716725, 5729.54163666914, 5730.3410107838135, 5305.893882122413, 5408.134698448308, 5413.160960051198, 5425.050616142159, 5481.534069604048, 4865.927011094836, 4884.218525036048, 4886.511348865085, 4899.2896030075435, 4946.826861059845, 5833.212516310244, 5869.266341707286, 5911.645301281937, 5932.703364831741, 5994.190784244071, 5550.084236100998, 5632.605717599728, 5684.971575142264, 5719.399463056319, 5732.197492350991, 5877.059670452878, 5881.73532191061, 5949.345571986992, 5990.550708696778, 5995.310539288038, 5561.888762224652, 5578.191162281528, 5611.1022236443605, 5615.354234262949, 5640.464155905182, 5466.863328416822, 5526.80656177048, 5732.140178973021, 5736.110902810071, 5784.334801497882, 5453.345598528202, 5491.972540137273, 5535.944640553704, 5565.30433695788, 5638.4925356718095, 5536.252605898152, 5581.860453488695, 5582.7766889323975, 5585.581081418829, 5590.329160500766, 5335.0, 5337.919931200958, 5436.103042997861, 5505.421930697219, 5534.08687566547, 5520.227168196376, 5590.329160500766, 5603.131514615241, 5615.915761263666, 5646.0, 5505.3393592767525, 5507.614466987273, 5507.972460137674, 5517.751701173537, 5526.80656177048], "value": 5229.100622697921, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.2988120028165, 569.0212833925647, 572.0189874365464, 581.5405829394779, 583.2592607388617, 41268.79365603172, 42090.0, 42155.99999999996, 46285.768571157096, 46335.30497042547, 44284.77857610708, 44704.55295447045, 44815.32777008339, 44824.55175448245, 44957.77521112398, 8572.399932004762, 8711.695090671796, 8739.213470787628, 8820.823583528325, 8830.161134692225, 8544.70093546726, 8636.438631488933, 8660.393772435931, 8665.913340866573, 8685.739427817176, 8668.60991255395, 8693.174148455919, 8718.825623487526, 8735.257503112243, 8783.429077109968, 8579.227869491744, 8628.39601227908, 8662.090480499552, 8728.214460698568, 8730.956345218297, 8641.567921603895, 8641.697540586112, 8655.0, 8687.478751274944, 8693.652253909837, 41220.58779412197, 41250.38124428136, 41442.37836432456, 41497.377539336936, 41518.58481415177, 3529.770564913298, 3923.8234279457492, 3929.7249192556533, 3984.063745019918, 4043.636072753437, 30435.847820760977, 30579.69420305813, 30584.0, 30890.227744306347, 31952.145312903758, 4065.2193460082112, 4167.437395951538, 4180.561041090672, 4286.699931004831, 4413.536578659258, 330050.0, 332725.0, 334433.0, 336576.0, 338504.0, 55003.724981374835, 55134.17298740522, 55553.72223138859, 55779.442205578234, 55906.44093559094, 58211.0, 58343.70828145917, 58573.414265857646, 58584.67691538558, 58819.70590147022, 14257.215853128178, 14510.637234069232, 14547.709045819025, 14593.92703036478, 14653.92673036628, 11409.087273018138, 11591.478383472764, 11602.94198529002, 11628.592999244986, 11632.360220187971, 14684.706305873822, 15812.130332831804, 15855.445059423095, 15976.360945562048, 16087.195640217942, 5724.599278050497, 5757.539396848242, 5760.74076666551, 5816.272965879265, 5916.674582897982, 857.7083791510792, 930.776613612728, 976.1361195342173, 993.294760719897, 1112.3715100967927, 28410.0, 31133.844330778655, 31687.93546937006, 31827.204319891724, 31841.681583183872, 1064.2231171245035, 1070.3898777696638, 1074.382230217628, 1107.2968664897849, 1149.8735139134687, 15342.30959606798, 16245.700343972454, 16296.755548666779, 16333.673326533402, 16346.673066538602, 525589.0, 529132.0, 529618.0, 532138.0, 533317.0, 53638.463615364126, 54240.72879635577, 54248.728756355966, 54249.0, 54296.0, 1270.9809352859716, 1316.4010375279224, 1319.6568892087935, 1320.1419077599637, 1326.781081121604, 28365.0, 30025.849870750506, 30193.245168870955, 30275.394492110474, 30903.381932361677, 47663.76168119276, 48319.0, 48378.75810620924, 48438.5156148434, 48614.27078593753, 446571.0, 447909.0, 449930.0, 450146.0, 451055.0, 26971.358866552764, 27454.97995220484, 27671.861640691666, 27824.0, 27864.86067569649, 44734.3289850659, 45141.32288015748, 46207.0, 46539.301910472044, 46575.76712116418, 38029.0, 38911.41632875452, 39466.605333946296, 39483.60516394799, 40371.79814101028, 38195.809020954715, 39041.2191756169, 39427.40858887062, 39431.211375772895, 39543.0, 37623.623763762014, 38197.80901095477, 38812.0, 38850.6114938847, 39582.0, 32883.671163289015, 34577.39786347967, 35034.82482587571, 37810.43284350792, 38429.231415370974, 26729.25790389386, 26847.328816779736, 26913.73086269112, 26989.0, 27316.897786345246], "value": 19270.22561493476, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.4282697367438, 383.71103385600765, 391.6299097353001, 392.4682055814372, 411.0443219514629, 17501.474955751317, 18354.724679129824, 18916.716249256257, 18924.959127248014, 19521.414357569294, 16989.320427182898, 17302.221400036997, 17307.307707691678, 17860.106994650247, 18288.0, 5485.917711234335, 5501.752421141038, 5678.772849086053, 5705.857353566153, 5738.971305143468, 5546.556275497971, 5669.914951275734, 5678.914816277759, 5685.232493613371, 5689.772409103631, 5423.864403389907, 5577.8047768327915, 5626.2967129108865, 5640.0, 5645.350784659755, 5552.639078459887, 5602.271704678406, 5607.551395888319, 5612.102063669814, 5621.7189140542805, 5006.849794506171, 5008.84973450797, 5019.096562618727, 5291.603129765244, 5297.973510132463, 12993.805092923614, 13253.271070091141, 13263.933680331633, 13452.730945381038, 13522.391492382769, 2210.9889450552646, 2253.2226381898217, 2295.36877358726, 2309.919152829643, 2333.0900948630047, 9724.95137524308, 10278.33190842593, 10333.58665653373, 11360.261582997162, 13265.27041012744, 1841.5212044868297, 1886.76415448069, 1887.4337698690338, 1909.102721720789, 1940.7574053243345, 74691.25308746897, 78368.0, 79643.0, 80295.19704802935, 81986.18013819846, 10291.228157888188, 10380.792384152275, 10497.168533485376, 10765.084967777826, 10771.6229931952, 14767.630809229855, 14812.629684257765, 14887.553373398816, 14899.77650335246, 14913.478028269175, 7448.4041276697735, 7702.807429814299, 7763.805904852424, 8029.7189598363775, 8054.114047454776, 7381.66782494789, 7384.187739348775, 7385.741499047615, 7558.773236802905, 7681.270279323456, 4426.712263702849, 4439.778011099432, 4533.116042371772, 4534.455865296186, 4646.326282688991, 1814.4284550366592, 1912.8565357597956, 1919.7408349872867, 1967.9606407871763, 1988.1351612048804, 871.7559083456642, 911.7492689510306, 914.1224424552371, 951.7715748220377, 964.8552717092352, 17950.461486155436, 18458.0, 19095.61808763817, 19157.521061973563, 19158.61682766337, 945.857632462473, 947.8199142162968, 950.1733491861986, 968.8837339519303, 998.4758002048837, 9429.434233945847, 10412.947935260276, 10492.475376231157, 10721.195910306758, 10753.892461075446, 504203.0, 509025.0, 515419.0, 517351.0, 518742.0, 74158.0, 78174.609126954, 78319.2168078312, 83730.0, 93845.0, 1015.7003683913116, 1024.8411496218248, 1079.8920107989295, 1085.5006696919347, 1087.5160553553592, 16464.09447480352, 16851.91574042171, 17505.474835754947, 17580.472585822445, 17895.19471623806, 39155.6084439152, 39384.6061539381, 39472.81581552558, 39475.0, 40048.39927401033, 54576.0, 57494.42505575058, 58317.0, 60497.665630280455, 60534.0, 8046.356291496783, 8236.629351679068, 8264.421490495608, 8385.119562445856, 8511.404201705822, 12195.207311524722, 12451.75096498083, 12813.359332033548, 13166.934165329112, 13201.669958251121, 10330.845037324296, 10937.507812148631, 10969.670909872717, 11174.161937854857, 11263.887361126612, 10400.947995259976, 10501.737456563647, 10839.512221950188, 11127.0, 11143.108551315712, 11095.778084438105, 11177.776444470903, 11194.0, 11296.378699171624, 11405.828912566152, 8114.107448180814, 8295.585220738818, 8311.958440208002, 8406.537640429835, 8565.871511927451, 10353.327033742782, 10612.681619551426, 10676.46617669129, 10915.23593348458, 11012.889871101186], "value": 8797.014007196563, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1410.273709039844, 1441.841397446281, 1535.6468012357157, 1751.1769468349871, 1753.5440785395801, 8140.715074972377, 8516.489010659365, 8810.559472026396, 8823.691170809023, 8832.867506987384, 8440.32477401808, 8561.44350617211, 8570.57147142642, 8576.828463430727, 8581.270591999672, 2201.922932697356, 2213.457702862801, 2218.800307972282, 2228.92198773043, 2235.642297232443, 2183.6287831068757, 2193.4426557144448, 2253.8309626777977, 2261.412032871457, 2278.1115365007577, 2180.869147851126, 2182.7053347798083, 2195.6706494025866, 2201.7027701260286, 2222.5999320122373, 2165.069020321261, 2181.9672704909517, 2196.176433837311, 2200.185931205448, 2215.268961242794, 2172.880491572963, 2187.8796666183352, 2198.032760679183, 2200.713907192071, 2213.457702862809, 8568.528730919797, 8621.439606425625, 8635.654573817039, 8649.740507784776, 8894.555272236426, 5057.797688092509, 5221.242919776611, 5227.424983251839, 5228.947710522884, 5233.0, 3041.863116159778, 3224.193951512122, 3251.5122731590213, 3266.9183270418193, 3273.8363081845814, 966.9033096690345, 1017.6183931025865, 1022.5050875862871, 1030.103809685571, 1054.0, 11901.464434100486, 11912.702182445422, 11933.94033029838, 11973.580924667594, 12002.879971200264, 4190.51809041964, 4331.805068771912, 4373.956260437355, 4435.183658376889, 4496.842610508616, 9658.323917325719, 9678.467684277291, 9708.126268635857, 9723.65967191145, 9777.951110244403, 5055.570276526463, 5066.923996140061, 5070.721110338893, 5074.188129899198, 5077.873053173626, 4197.748135111903, 4498.752568608758, 4686.906261874743, 4746.59653929413, 4747.715137091785, 3657.085728567858, 3722.4230244312175, 3747.9505738393295, 3753.6058713834655, 3804.486394336729, 1112.1769890281296, 1115.6095366621616, 1117.899389054989, 1128.328644456547, 1129.9717507062226, 828.556722153645, 898.7842917699836, 922.257582645963, 944.7260294514514, 956.2254573795248, 5544.473275038865, 5576.776928922879, 5740.483356497935, 5805.796797112081, 5934.0, 425.7488082031616, 435.9476862776487, 436.4478934148305, 443.28188334897027, 444.7087157911573, 3734.589195188527, 3853.171568112813, 3859.1702783901596, 3866.5940076292145, 3869.941950870739, 10354.0, 10763.569457221623, 10778.89221107779, 10857.837132443019, 10916.290441121302, 10757.246992710436, 10781.299215550964, 10807.78384432307, 10836.512356943957, 10855.0, 7958.243966823143, 8026.398020148512, 8070.838583228303, 8146.103928567972, 8174.713885013996, 5691.914621280601, 5697.572682048946, 5765.798197063083, 5837.328707198726, 5915.940840591539, 9662.613495460102, 9809.460479673686, 9812.705618831162, 9833.655822046194, 10011.799764004825, 9856.408615483095, 9911.30620856562, 9971.05274998874, 10152.340097893613, 10187.694369168938, 6454.1609590752905, 6923.169219693669, 7120.60836653989, 7146.071010768567, 7176.605286709281, 8443.36674749384, 8465.153484651732, 8473.449225800303, 8500.0, 8510.617022234139, 7199.1001124859395, 7401.1488678802625, 7550.282723141293, 7625.199354067743, 7769.7669069928, 7179.8564028720175, 7511.51175173612, 7527.096748390229, 7628.122765881994, 7698.0, 6427.839304017437, 6534.607923524603, 6553.344665533408, 6558.245801732862, 6567.2447668518735, 4861.4895435980125, 4895.192293271571, 5001.874953126201, 5011.473795251592, 5213.504717051874, 4695.530446955414, 4806.759662016815, 4838.588719958843, 4960.727160006234, 5001.899962000813], "value": 4364.445710750226, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.6381661089748, 330.3393213572854, 334.8426239667356, 340.2327750921671, 340.55217389133287, 5310.999999999995, 5481.780728770849, 5507.614466987313, 5542.251796007537, 5556.972215138919, 5440.347158341005, 5449.455054494549, 5451.591130665196, 5472.589555783312, 5538.47384498472, 4255.0, 4258.936115958263, 4263.829446822124, 4274.38021486885, 4288.828446862121, 3967.9088250731133, 4177.227212965611, 4235.174141042498, 4264.8507302244425, 4284.314509678452, 4165.083681590046, 4180.6237438630515, 4182.79086045698, 4187.81154848031, 4188.5392606813375, 4181.686373521983, 4188.81150348232, 4192.826008717564, 4206.0, 4235.724677895927, 3601.5858176309534, 3711.406175011985, 3716.2753263113705, 3722.571904231021, 3735.794531300777, 5296.761645725952, 5315.362156541201, 5319.5478384337375, 5336.279602253724, 5375.569954403638, 4879.926801097987, 4892.21724524078, 4895.412550493964, 4901.240307752304, 4902.2156454967035, 5623.76633435772, 5747.626404283708, 5750.079987202028, 5750.6262092963825, 5752.338481074688, 4064.248114098901, 4069.348904175318, 4074.633283004544, 4083.795810209507, 4097.405876147972, 5685.800996965087, 5777.133429985536, 6002.249718785152, 6014.3985601439945, 6057.363976782419, 4081.387791831249, 4156.168766246763, 4162.895927601834, 4176.352665336878, 4179.519355274121, 4235.618794308527, 4236.76697781625, 4237.660987121023, 4239.194553034913, 4251.489821221473, 4791.856244312677, 4851.830185943475, 4868.805247790119, 4872.78072486739, 4893.580861550182, 5731.8567035824435, 5737.713114344266, 5737.885242295214, 5758.712064396847, 5766.0, 1448.5726710620393, 1466.662667586461, 1473.1750219876903, 1473.6978919321514, 1475.6384685751846, 899.4430409096908, 943.1087622196958, 946.7207173883721, 958.1951161024773, 966.429806414219, 4826.624412042551, 4857.951420485821, 4858.979614281041, 4861.222204447272, 4873.830280732599, 5117.032121369597, 5130.846074617767, 5170.870728231825, 5223.503767142115, 5240.659357141773, 4494.977525112419, 4805.303231031551, 4858.854234372974, 4869.561739443467, 4930.556249937523, 2703.5539136042335, 2717.8233414827973, 2743.547314693093, 2747.244507760342, 2749.721379558475, 5297.708626025528, 5320.600954928396, 5348.197770334403, 5379.515843574019, 5381.4349493303425, 5212.247182028933, 5214.348206474191, 5556.91664625031, 6025.276966764016, 6040.637561746309, 6127.111568822495, 6173.259208894961, 6182.721777520022, 6188.783392581238, 6245.219347581461, 5616.803411880564, 5958.791442299672, 5970.492508136857, 5982.965791630866, 6025.246844144482, 5897.5281977440845, 5908.291005079246, 5930.169776231245, 5947.851303717442, 5986.730597123227, 5966.731497082555, 6147.354527774519, 6179.320274769681, 6214.5028397728975, 6284.748610055546, 4168.708190426641, 4220.95779042218, 4250.936235956525, 4253.404523366669, 4265.829366825292, 5757.596968212352, 5950.940490595039, 5962.25471816023, 5967.612105213321, 6075.817725468243, 5764.654120752768, 5770.3652598215, 5771.989901767258, 5802.912956305743, 5808.39011903744, 5771.797987070432, 5798.666306749556, 5815.41845815415, 5843.386444423274, 5855.443732845373, 5394.78420863161, 5690.146478028329, 5708.628939118944, 5743.74153163117, 5779.335376431764, 5839.678817664899, 5853.2976042875125, 5861.743228856835, 5869.7945571904775, 5878.030125029322, 5450.31871016123, 5662.188099808021, 5727.828165155052, 5745.798897038583, 5759.481646651821], "value": 4291.539955424869, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.0720509734796, 759.4531937005357, 789.7157023471552, 819.0989911097797, 832.5961908474391, 13761.793573096398, 14548.92725536371, 14670.413183472674, 14760.188189649565, 14770.187639679827, 13749.58751237462, 13774.173549587033, 13882.722345553082, 13904.0962337448, 13916.582502524916, 779.2324560308092, 796.24356860982, 798.3174385900058, 804.3565147881701, 804.388664614894, 777.5062835099695, 793.1077537770009, 797.5693125712108, 813.4915677701437, 813.8250276190618, 843.3464065349342, 844.2359664503604, 846.4371193156575, 846.7163500227431, 847.6990668312752, 843.2200214801314, 843.3590471241839, 843.4096132707068, 843.6161546496329, 844.3582877013453, 611.7583554495949, 616.1589430427434, 616.2112496005076, 616.4267231474727, 616.4913945994527, 15048.699026019527, 15237.0, 15237.0, 15258.084514929029, 15260.160691161982, 14502.927485362612, 14733.55799326022, 14787.186704731235, 14880.181590012546, 15004.474843380538, 11641.76716465666, 11685.47415366302, 11711.88288117125, 11874.52501899923, 12381.195222310522, 3775.169462718198, 3801.030737162006, 3928.2339943710986, 4010.47863777707, 4017.959820401817, 79386.20613793904, 79981.60009199975, 80528.38943221161, 80874.0, 81590.59204703997, 10800.567977280822, 11313.0, 11331.150163737753, 11531.48108335127, 11604.477798499087, 21391.67912481314, 21572.56854862894, 21596.56806863854, 21621.67567486489, 21697.13211471555, 7644.579548124907, 7856.764297071097, 8336.374771892133, 8383.748487545383, 8419.158084191655, 4123.484564429446, 4220.345846393752, 4269.786510674454, 4320.697551171451, 4341.218580655449, 3388.0852169913987, 3471.6181220065773, 3486.8953931381593, 3492.5983511895947, 3503.9299214016087, 557.5177471487216, 569.1974316214119, 571.2801869644278, 597.3638075449633, 599.3706608061605, 601.5127746525328, 620.1565870416231, 648.8086014625696, 731.294300999538, 743.5427212264418, 9281.860772088425, 9403.34176607631, 9755.36590121654, 9767.725373785252, 9797.118259356692, 574.7586013874183, 580.2091937779295, 633.5058654249692, 649.3344322069917, 728.8724473217165, 4321.330193819963, 4331.523532411432, 4586.174488592085, 4677.134730074879, 4720.716756994591, 70578.29421705718, 70668.0, 71608.64195678988, 125801.37099314445, 126729.0, 103659.0, 111062.44468777605, 111343.0, 112675.43662281636, 115136.42431787787, 57310.42689573051, 85206.57396712976, 88606.55696721475, 92362.0, 95466.0, 8320.916790832256, 8669.739907802776, 8741.256993155654, 8774.605142768463, 8854.291656667323, 38053.61946380611, 47588.52411475979, 51626.0, 52391.21413178729, 54208.0, 73240.0, 75070.6246468786, 75421.0, 77656.0, 78518.60740696489, 10694.251402401756, 10874.510647020745, 10947.482079122006, 11116.277441966246, 11173.944130279297, 12244.265344079384, 13166.0, 13549.187048777105, 13893.166410015432, 14102.858971410154, 11989.820152697543, 12522.624321270376, 12654.987600992083, 12979.610611681665, 12989.740205196033, 12526.006669653223, 12768.489260429478, 13102.868971310547, 13133.474661013452, 13202.669933251362, 12044.819327710267, 12517.93741031289, 12818.487260509848, 12959.870401295866, 13522.25627590492, 9515.191208747057, 9657.696211011704, 9793.559289831832, 9914.256430767577, 9920.00799920031, 9496.14534691881, 10168.084872361524, 10242.795144097225, 10311.896881031395, 10339.586416543254], "value": 7257.804811909933, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1529.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 113.0, 112.0, 112.0, 112.0, 113.0, 113.0, 112.0, 110.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 129.0, 126.0, 176.0, 127.0, 131.0, 126.0, 128.0, 155.0, 127.0], "value": 138.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 164.0, 164.0, 163.0, 164.0, 161.0, 165.0, 163.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 77.0, 108.0, 78.0, 76.0, 77.0, 75.0, 109.0, 76.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 112.0, 82.0, 83.0, 83.0, 103.0, 84.0, 83.0, 111.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 119.0, 118.0, 118.0, 119.0, 118.0, 119.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 149.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 95.0, 95.0, 96.0, 97.0, 96.0, 96.0, 97.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 60.0, 58.0, 56.0, 57.0, 55.0, 55.0, 57.0, 56.0, 55.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 61.0, 61.0, 62.0, 62.0, 62.0, 61.0, 62.0, 60.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 83.0, 84.0, 87.0, 81.0, 80.0, 83.0, 81.0, 79.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 151.0, 146.0, 134.0, 138.0, 131.0, 138.0, 131.0, 189.0, 146.0], "value": 144.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 172.0, 167.0, 168.0, 167.0, 174.0, 167.0, 166.0, 176.0, 168.0], "value": 169.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 69.0, 66.0, 66.0, 66.0, 69.0, 67.0, 70.0, 70.0], "value": 67.7, "unit": "score"}]}]} 18:50:12 INFO - Return code: 0 18:50:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:50:12 ERROR - # TBPL SUCCESS # 18:50:12 INFO - Running post-action listener: _resource_record_post_action 18:50:12 INFO - [mozharness: 2016-10-13 01:50:12.577390Z] Finished run-tests step (success) 18:50:12 INFO - Running post-run listener: _resource_record_post_run 18:50:12 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 8192; Write bytes: 398589952; Read time: 84; Write time: 232264 18:50:12 INFO - TinderboxPrint: CPU usage
13.4% 18:50:12 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 84 18:50:12 INFO - TinderboxPrint: I/O write bytes / time
398,589,952 / 232,264 18:50:12 INFO - TinderboxPrint: CPU idle
8,270.0 (86.6%) 18:50:12 INFO - TinderboxPrint: CPU user
1,220.8 (12.8%) 18:50:12 INFO - TinderboxPrint: Swap in / out
0 / 0 18:50:12 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 104185856; Read time: 0; Write time: 82084 18:50:12 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290492416; Read time: 68; Write time: 149240 18:50:13 INFO - Running post-run listener: _upload_blobber_files 18:50:13 INFO - Blob upload gear active. 18:50:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:50:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:50:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:50:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:50:13 INFO - (blobuploader) - INFO - Open directory for files ... 18:50:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:50:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:50:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:50:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:14 INFO - (blobuploader) - INFO - Done attempting. 18:50:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:50:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:50:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:50:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:18 INFO - (blobuploader) - INFO - Done attempting. 18:50:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:50:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:50:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:50:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:19 INFO - (blobuploader) - INFO - Done attempting. 18:50:19 INFO - (blobuploader) - INFO - Iteration through files over. 18:50:19 INFO - Return code: 0 18:50:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:50:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:50:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ee2f7b5b2fc281ae6bf98187b5a00f765d956ddff66cdc270c8f1c5ff6434f8113f5f30d3d56720fcd48eaab50c2d1bd7f55c5362c4705502d46528ab7389114", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a89b4c596249825db753e23724b42b1253b78f929b2fb38654c70e4e21488a925744ca16d44f94a2cf87d02197674a1f194f5a545d6b9646236430ff34ee6158", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2db620588b3847a03d2d31c48ce68a898dfa7318fc1cf3f49e296528daafbee4cbfd0dd675b10d84019c11ce2f84529f55e575ecbd0be7ff085106d24d661a46"} 18:50:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:50:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:50:19 INFO - Contents: 18:50:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ee2f7b5b2fc281ae6bf98187b5a00f765d956ddff66cdc270c8f1c5ff6434f8113f5f30d3d56720fcd48eaab50c2d1bd7f55c5362c4705502d46528ab7389114", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a89b4c596249825db753e23724b42b1253b78f929b2fb38654c70e4e21488a925744ca16d44f94a2cf87d02197674a1f194f5a545d6b9646236430ff34ee6158", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2db620588b3847a03d2d31c48ce68a898dfa7318fc1cf3f49e296528daafbee4cbfd0dd675b10d84019c11ce2f84529f55e575ecbd0be7ff085106d24d661a46"} 18:50:19 INFO - Running post-run listener: copy_logs_to_upload_dir 18:50:19 INFO - Copying logs to upload dir... 18:50:19 INFO - mkdir: /builds/slave/test/build/upload/logs 18:50:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.492365 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-12 18:50:19.285445) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 18:50:19.289104) ========= 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=d2a8c569965ab8367867b893000001a1-1476322178.597982-1769935299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ee2f7b5b2fc281ae6bf98187b5a00f765d956ddff66cdc270c8f1c5ff6434f8113f5f30d3d56720fcd48eaab50c2d1bd7f55c5362c4705502d46528ab7389114", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a89b4c596249825db753e23724b42b1253b78f929b2fb38654c70e4e21488a925744ca16d44f94a2cf87d02197674a1f194f5a545d6b9646236430ff34ee6158", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2db620588b3847a03d2d31c48ce68a898dfa7318fc1cf3f49e296528daafbee4cbfd0dd675b10d84019c11ce2f84529f55e575ecbd0be7ff085106d24d661a46"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011413 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ee2f7b5b2fc281ae6bf98187b5a00f765d956ddff66cdc270c8f1c5ff6434f8113f5f30d3d56720fcd48eaab50c2d1bd7f55c5362c4705502d46528ab7389114", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a89b4c596249825db753e23724b42b1253b78f929b2fb38654c70e4e21488a925744ca16d44f94a2cf87d02197674a1f194f5a545d6b9646236430ff34ee6158", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2db620588b3847a03d2d31c48ce68a898dfa7318fc1cf3f49e296528daafbee4cbfd0dd675b10d84019c11ce2f84529f55e575ecbd0be7ff085106d24d661a46"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 18:50:19.314704) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 18:50:19.315022) ========= 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=d2a8c569965ab8367867b893000001a1-1476322178.597982-1769935299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004646 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 18:50:19.400684) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 18:50:19.400990) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 18:50:19.401267) ========= ========= Total master_lag: 0.17 =========