builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1480270416.13 results: success (0) buildid: 20161127073101 builduid: fef01765e8594684b4172d498c862315 revision: 05328d3102efd4d5fc0696489734d7771d24459f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-27 10:13:36.131961) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-27 10:13:36.132627) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-27 10:13:36.132979) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-27 10:13:36.148798) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 10:13:36.149253) ========= 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=4300f881736b422476174874000001bc-1480267606.920969-302350423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-27 10:13:36-- 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% 50.1M=0s 2016-11-27 10:13:36 (50.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125218 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 10:13:36.289947) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 10:13:36.290288) ========= 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=4300f881736b422476174874000001bc-1480267606.920969-302350423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016371 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 10:13:36.339432) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-27 10:13:36.339811) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 05328d3102efd4d5fc0696489734d7771d24459f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 05328d3102efd4d5fc0696489734d7771d24459f --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=4300f881736b422476174874000001bc-1480267606.920969-302350423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-27 10:13:37,057 truncating revision to first 12 chars 2016-11-27 10:13:37,057 Setting DEBUG logging. 2016-11-27 10:13:37,057 attempt 1/10 2016-11-27 10:13:37,057 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/05328d3102ef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-27 10:13:37,957 unpacking tar archive at: mozilla-central-05328d3102ef/testing/mozharness/ program finished with exit code 0 elapsedTime=1.213725 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-27 10:13:37.567041) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-27 10:13:37.567363) ========= script_repo_revision: 05328d3102efd4d5fc0696489734d7771d24459f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-27 10:13:37.567816) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-27 10:13:37.568126) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-27 10:13:37.580897) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-11-27 10:13:37.581229) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=4300f881736b422476174874000001bc-1480267606.920969-302350423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:13:38 INFO - MultiFileLogger online at 20161127 10:13:38 in /builds/slave/test 10:13:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:13:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:13:38 INFO - {'append_to_log': False, 10:13:38 INFO - 'base_work_dir': '/builds/slave/test', 10:13:38 INFO - 'blob_upload_branch': 'Firefox', 10:13:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:13:38 INFO - 'branch': 'Firefox', 10:13:38 INFO - 'buildbot_json_path': 'buildprops.json', 10:13:38 INFO - 'config_files': ('talos/linux_config.py',), 10:13:38 INFO - 'default_actions': ('clobber', 10:13:38 INFO - 'read-buildbot-config', 10:13:38 INFO - 'download-and-extract', 10:13:38 INFO - 'populate-webroot', 10:13:38 INFO - 'create-virtualenv', 10:13:38 INFO - 'install', 10:13:38 INFO - 'run-tests'), 10:13:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:13:38 INFO - 'download_minidump_stackwalk': True, 10:13:38 INFO - 'download_symbols': 'ondemand', 10:13:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:13:38 INFO - 'tooltool.py': '/tools/tooltool.py', 10:13:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:13:38 INFO - '/tools/misc-python/virtualenv.py')}, 10:13:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:13:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:13:38 INFO - 'installer_path': 'installer.exe', 10:13:38 INFO - 'log_level': 'info', 10:13:38 INFO - 'log_name': 'talos', 10:13:38 INFO - 'log_to_console': True, 10:13:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:13:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:13:38 INFO - 'opt_config_files': (), 10:13:38 INFO - 'pip_index': False, 10:13:38 INFO - 'sps_profile': False, 10:13:38 INFO - 'sps_profile_interval': 0, 10:13:38 INFO - 'suite': 'dromaeojs', 10:13:38 INFO - 'system_bits': '32', 10:13:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:13:38 INFO - 'title': 'talos-linux64-ix-045', 10:13:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:13:38 INFO - 'use_talos_json': True, 10:13:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:13:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:13:38 INFO - 'work_dir': 'build'} 10:13:38 INFO - [mozharness: 2016-11-27 18:13:38.402868Z] Running clobber step. 10:13:38 INFO - Running pre-action listener: _resource_record_pre_action 10:13:38 INFO - Running main action method: clobber 10:13:38 INFO - rmtree: /builds/slave/test/build 10:13:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:13:38 INFO - Running post-action listener: _resource_record_post_action 10:13:38 INFO - [mozharness: 2016-11-27 18:13:38.858572Z] Finished clobber step (success) 10:13:38 INFO - [mozharness: 2016-11-27 18:13:38.858672Z] Running read-buildbot-config step. 10:13:38 INFO - Running pre-action listener: _resource_record_pre_action 10:13:38 INFO - Running main action method: read_buildbot_config 10:13:38 INFO - Using buildbot properties: 10:13:38 INFO - { 10:13:38 INFO - "project": "", 10:13:38 INFO - "product": "firefox", 10:13:38 INFO - "script_repo_revision": "production", 10:13:38 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:13:38 INFO - "repository": "", 10:13:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:13:38 INFO - "buildid": "20161127073101", 10:13:38 INFO - "pgo_build": "True", 10:13:38 INFO - "basedir": "/builds/slave/test", 10:13:38 INFO - "buildnumber": 106, 10:13:38 INFO - "slavename": "talos-linux64-ix-045", 10:13:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:13:38 INFO - "platform": "ubuntu64_hw", 10:13:38 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:13:38 INFO - "branch": "mozilla-central", 10:13:38 INFO - "repo_path": "mozilla-central", 10:13:38 INFO - "revision": "05328d3102efd4d5fc0696489734d7771d24459f", 10:13:38 INFO - "stage_platform": "linux64-pgo", 10:13:38 INFO - "builduid": "fef01765e8594684b4172d498c862315", 10:13:38 INFO - "slavebuilddir": "test" 10:13:38 INFO - } 10:13:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/WJfaXgl1QsWK2H_Uf6uSGQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 10:13:38 INFO - Running post-action listener: _resource_record_post_action 10:13:38 INFO - [mozharness: 2016-11-27 18:13:38.861098Z] Finished read-buildbot-config step (success) 10:13:38 INFO - [mozharness: 2016-11-27 18:13:38.861186Z] Running download-and-extract step. 10:13:38 INFO - Running pre-action listener: _resource_record_pre_action 10:13:38 INFO - Running main action method: download_and_extract 10:13:38 INFO - mkdir: /builds/slave/test/build/tests 10:13:38 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')]} 10:13:38 INFO - trying https://queue.taskcluster.net/v1/task/WJfaXgl1QsWK2H_Uf6uSGQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 10:13:38 INFO - Downloading https://queue.taskcluster.net/v1/task/WJfaXgl1QsWK2H_Uf6uSGQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 10:13:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WJfaXgl1QsWK2H_Uf6uSGQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:13:39 INFO - Downloaded 1361 bytes. 10:13:39 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 10:13:39 INFO - Using the following test package requirements: 10:13:39 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 10:13:39 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:39 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:13:39 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:39 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:13:39 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:39 INFO - u'jsshell-linux-x86_64.zip'], 10:13:39 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:39 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:13:39 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 10:13:39 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:39 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:13:39 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:39 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:13:39 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:39 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:13:39 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:39 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:13:39 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:13:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WJfaXgl1QsWK2H_Uf6uSGQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 10:13:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WJfaXgl1QsWK2H_Uf6uSGQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:13:39 INFO - Fetch https://queue.taskcluster.net/v1/task/WJfaXgl1QsWK2H_Uf6uSGQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:13:39 INFO - Http code: 200 10:13:39 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 10:13:39 INFO - x-amz-cf-id: 2M34M9nat-WcSP0Xs45Ll4fx-9ps2MwHJegnYX_OUSwMRg48rCUbTg== 10:13:39 INFO - x-amz-version-id: 0LDZgK3JfChcwenlhU0eAk7QZHGtsVb_ 10:13:40 INFO - Expected file size: 21780746 10:13:40 INFO - Obtained file size: 21780746 10:13:44 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:13:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WJfaXgl1QsWK2H_Uf6uSGQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 10:13:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WJfaXgl1QsWK2H_Uf6uSGQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:13:44 INFO - Fetch https://queue.taskcluster.net/v1/task/WJfaXgl1QsWK2H_Uf6uSGQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:13:44 INFO - Http code: 200 10:13:44 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 10:13:44 INFO - x-amz-cf-id: d0X1yH_9Pl1s9vMHXeyRkE7NdC-gXQ2Pt52CdG4Y3hWk1pyqfdIfLA== 10:13:44 INFO - x-amz-version-id: 0LDZgK3JfChcwenlhU0eAk7QZHGtsVb_ 10:13:45 INFO - Expected file size: 21780746 10:13:45 INFO - Obtained file size: 21780746 10:13:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WJfaXgl1QsWK2H_Uf6uSGQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 10:13:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WJfaXgl1QsWK2H_Uf6uSGQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:13:49 INFO - Fetch https://queue.taskcluster.net/v1/task/WJfaXgl1QsWK2H_Uf6uSGQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:13:50 INFO - Http code: 200 10:13:50 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 10:13:50 INFO - x-amz-cf-id: 7zDmS1VuEKqMH5otBg9CCA9yQeNssXoV7JlYzv47dKVzRWHX_WFW_Q== 10:13:50 INFO - x-amz-version-id: egHr.uazF6WEZQcb2QEF9YxeY4aFKUse 10:13:50 INFO - Expected file size: 14409702 10:13:50 INFO - Obtained file size: 14409702 10:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:51 INFO - trying https://queue.taskcluster.net/v1/task/WJfaXgl1QsWK2H_Uf6uSGQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:13:51 INFO - Downloading https://queue.taskcluster.net/v1/task/WJfaXgl1QsWK2H_Uf6uSGQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:13:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WJfaXgl1QsWK2H_Uf6uSGQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:13:52 INFO - Downloaded 59805208 bytes. 10:13:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WJfaXgl1QsWK2H_Uf6uSGQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:13:52 INFO - mkdir: /builds/slave/test/properties 10:13:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:13:52 INFO - Writing to file /builds/slave/test/properties/build_url 10:13:52 INFO - Contents: 10:13:52 INFO - build_url:https://queue.taskcluster.net/v1/task/WJfaXgl1QsWK2H_Uf6uSGQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:13:53 INFO - Running post-action listener: _resource_record_post_action 10:13:53 INFO - Running post-action listener: set_extra_try_arguments 10:13:53 INFO - [mozharness: 2016-11-27 18:13:53.235022Z] Finished download-and-extract step (success) 10:13:53 INFO - [mozharness: 2016-11-27 18:13:53.235248Z] Running populate-webroot step. 10:13:53 INFO - Running pre-action listener: _resource_record_pre_action 10:13:53 INFO - Running main action method: populate_webroot 10:13:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:13:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:13:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:13:53 INFO - '--tppagecycles', 10:13:53 INFO - '7'], 10:13:53 INFO - 'tests': ['tsvgm']}}, 10:13:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:13:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:13:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:13:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:13:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:13:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:13:53 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:13:53 INFO - 'talos_options': ['--disable-e10s'], 10:13:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:13:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:13:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:13:53 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:13:53 INFO - 'talos_options': ['--disable-e10s'], 10:13:53 INFO - 'tests': ['damp', 'tps']}, 10:13:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:13:53 INFO - 'tests': ['damp', 'tps']}, 10:13:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:13:53 INFO - 'tests': ['dromaeo_dom']}, 10:13:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:13:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:13:53 INFO - 'tests': ['basic_compositor_video']}, 10:13:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:13:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:13:53 INFO - 'tests': ['a11yr', 10:13:53 INFO - 'ts_paint', 10:13:53 INFO - 'tpaint', 10:13:53 INFO - 'sessionrestore', 10:13:53 INFO - 'sessionrestore_no_auto_restore', 10:13:53 INFO - 'tabpaint']}, 10:13:53 INFO - 'other-e10s': {'tests': ['a11yr', 10:13:53 INFO - 'ts_paint', 10:13:53 INFO - 'tpaint', 10:13:53 INFO - 'sessionrestore', 10:13:53 INFO - 'sessionrestore_no_auto_restore', 10:13:53 INFO - 'tabpaint']}, 10:13:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:13:53 INFO - 'ts_paint', 10:13:53 INFO - 'tpaint', 10:13:53 INFO - 'sessionrestore', 10:13:53 INFO - 'sessionrestore_no_auto_restore', 10:13:53 INFO - 'tabpaint']}, 10:13:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:13:53 INFO - 'ts_paint', 10:13:53 INFO - 'tpaint', 10:13:53 INFO - 'sessionrestore', 10:13:53 INFO - 'sessionrestore_no_auto_restore', 10:13:53 INFO - 'tabpaint']}, 10:13:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:13:53 INFO - 'tests': ['a11yr', 10:13:53 INFO - 'ts_paint', 10:13:53 INFO - 'tpaint', 10:13:53 INFO - 'sessionrestore', 10:13:53 INFO - 'sessionrestore_no_auto_restore', 10:13:53 INFO - 'tabpaint']}, 10:13:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:13:53 INFO - 'tests': ['a11yr', 10:13:53 INFO - 'ts_paint', 10:13:53 INFO - 'tpaint', 10:13:53 INFO - 'sessionrestore', 10:13:53 INFO - 'sessionrestore_no_auto_restore', 10:13:53 INFO - 'tabpaint']}, 10:13:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:13:53 INFO - 'tests': ['tsvgx', 10:13:53 INFO - 'tsvgr_opacity', 10:13:53 INFO - 'tart', 10:13:53 INFO - 'tscrollx', 10:13:53 INFO - 'cart', 10:13:53 INFO - 'tsvg_static']}, 10:13:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:13:53 INFO - 'tsvgr_opacity', 10:13:53 INFO - 'tart', 10:13:53 INFO - 'tscrollx', 10:13:53 INFO - 'cart', 10:13:53 INFO - 'tsvg_static']}, 10:13:53 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:13:53 INFO - 'talos_options': ['--disable-e10s'], 10:13:53 INFO - 'tests': ['tp5o']}, 10:13:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:13:53 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:13:53 INFO - 'talos_options': ['--disable-e10s', 10:13:53 INFO - '--xperf_path', 10:13:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:13:53 INFO - 'tests': ['tp5n']}, 10:13:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:13:53 INFO - 'talos_options': ['--xperf_path', 10:13:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:13:53 INFO - 'tests': ['tp5n']}}, 10:13:53 INFO - 'talos.zip': {'path': '', 10:13:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:13:53 INFO - Running post-action listener: _resource_record_post_action 10:13:53 INFO - [mozharness: 2016-11-27 18:13:53.253863Z] Finished populate-webroot step (success) 10:13:53 INFO - [mozharness: 2016-11-27 18:13:53.253958Z] Running create-virtualenv step. 10:13:53 INFO - Running pre-action listener: _resource_record_pre_action 10:13:53 INFO - Running main action method: create_virtualenv 10:13:53 INFO - Creating virtualenv /builds/slave/test/build/venv 10:13:53 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 10:13:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:13:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:13:53 INFO - Using real prefix '/usr' 10:13:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:13:53 INFO - Installing distribute.............................................................................................................................................................................................done. 10:13:55 INFO - Installing pip.................done. 10:13:55 INFO - Return code: 0 10:13:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:13:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:13:56 INFO - Reading from file tmpfile_stdout 10:13:56 INFO - Output received: 10:13:56 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) 10:13:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f47d742fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2232b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ce130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245cfc0>, '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 0x245dec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245e350>, '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': '4300f881736b422476174874000001bc-1480267606.920969-302350423', '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 10:13:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:13:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:13:56 INFO - Using env: {'DISPLAY': ':0', 10:13:56 INFO - 'HOME': '/home/cltbld', 10:13:56 INFO - 'LANG': 'en_US.UTF-8', 10:13:56 INFO - 'LANGUAGE': 'en_US:en', 10:13:56 INFO - 'LOGNAME': 'cltbld', 10:13:56 INFO - 'MAIL': '/var/mail/cltbld', 10:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:56 INFO - 'MOZ_NO_REMOTE': '1', 10:13:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:56 INFO - 'NO_EM_RESTART': '1', 10:13:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:56 INFO - 'PWD': '/builds/slave/test', 10:13:56 INFO - 'SHELL': '/bin/bash', 10:13:56 INFO - 'SHLVL': '1', 10:13:56 INFO - 'TERM': 'linux', 10:13:56 INFO - 'TMOUT': '86400', 10:13:56 INFO - 'USER': 'cltbld', 10:13:56 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1480267606.920969-302350423', 10:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:56 INFO - '_': '/tools/buildbot/bin/python'} 10:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:56 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 10:13:56 INFO - Cleaning up... 10:13:56 INFO - Return code: 0 10:13:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f47d742fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2232b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ce130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245cfc0>, '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 0x245dec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245e350>, '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': '4300f881736b422476174874000001bc-1480267606.920969-302350423', '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 10:13:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:13:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:13:56 INFO - Using env: {'DISPLAY': ':0', 10:13:56 INFO - 'HOME': '/home/cltbld', 10:13:56 INFO - 'LANG': 'en_US.UTF-8', 10:13:56 INFO - 'LANGUAGE': 'en_US:en', 10:13:56 INFO - 'LOGNAME': 'cltbld', 10:13:56 INFO - 'MAIL': '/var/mail/cltbld', 10:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:56 INFO - 'MOZ_NO_REMOTE': '1', 10:13:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:56 INFO - 'NO_EM_RESTART': '1', 10:13:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:56 INFO - 'PWD': '/builds/slave/test', 10:13:56 INFO - 'SHELL': '/bin/bash', 10:13:56 INFO - 'SHLVL': '1', 10:13:56 INFO - 'TERM': 'linux', 10:13:56 INFO - 'TMOUT': '86400', 10:13:56 INFO - 'USER': 'cltbld', 10:13:56 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1480267606.920969-302350423', 10:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:56 INFO - '_': '/tools/buildbot/bin/python'} 10:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:56 INFO - Downloading/unpacking psutil>=3.1.1 10:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:13:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:13:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:13:58 INFO - Installing collected packages: psutil 10:13:58 INFO - Running setup.py install for psutil 10:13:58 INFO - building 'psutil._psutil_linux' extension 10:13:58 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 10:13:58 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 10:13:58 INFO - building 'psutil._psutil_posix' extension 10:13:58 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 10:13:59 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 10:13:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:13:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:13:59 INFO - Successfully installed psutil 10:13:59 INFO - Cleaning up... 10:13:59 INFO - Return code: 0 10:13:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:59 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 0x7f47d742fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2232b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ce130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245cfc0>, '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 0x245dec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245e350>, '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': '4300f881736b422476174874000001bc-1480267606.920969-302350423', '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 10:13:59 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 10:13:59 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 10:13:59 INFO - Using env: {'DISPLAY': ':0', 10:13:59 INFO - 'HOME': '/home/cltbld', 10:13:59 INFO - 'LANG': 'en_US.UTF-8', 10:13:59 INFO - 'LANGUAGE': 'en_US:en', 10:13:59 INFO - 'LOGNAME': 'cltbld', 10:13:59 INFO - 'MAIL': '/var/mail/cltbld', 10:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:59 INFO - 'MOZ_NO_REMOTE': '1', 10:13:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:59 INFO - 'NO_EM_RESTART': '1', 10:13:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:59 INFO - 'PWD': '/builds/slave/test', 10:13:59 INFO - 'SHELL': '/bin/bash', 10:13:59 INFO - 'SHLVL': '1', 10:13:59 INFO - 'TERM': 'linux', 10:13:59 INFO - 'TMOUT': '86400', 10:13:59 INFO - 'USER': 'cltbld', 10:13:59 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1480267606.920969-302350423', 10:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:59 INFO - '_': '/tools/buildbot/bin/python'} 10:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:14:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:14:01 INFO - Installing collected packages: mozsystemmonitor 10:14:01 INFO - Running setup.py install for mozsystemmonitor 10:14:01 INFO - Successfully installed mozsystemmonitor 10:14:01 INFO - Cleaning up... 10:14:01 INFO - Return code: 0 10:14:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:01 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 0x7f47d742fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2232b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ce130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245cfc0>, '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 0x245dec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245e350>, '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': '4300f881736b422476174874000001bc-1480267606.920969-302350423', '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 10:14:01 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 10:14:01 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 10:14:01 INFO - Using env: {'DISPLAY': ':0', 10:14:01 INFO - 'HOME': '/home/cltbld', 10:14:01 INFO - 'LANG': 'en_US.UTF-8', 10:14:01 INFO - 'LANGUAGE': 'en_US:en', 10:14:01 INFO - 'LOGNAME': 'cltbld', 10:14:01 INFO - 'MAIL': '/var/mail/cltbld', 10:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:01 INFO - 'MOZ_NO_REMOTE': '1', 10:14:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:01 INFO - 'NO_EM_RESTART': '1', 10:14:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:01 INFO - 'PWD': '/builds/slave/test', 10:14:01 INFO - 'SHELL': '/bin/bash', 10:14:01 INFO - 'SHLVL': '1', 10:14:01 INFO - 'TERM': 'linux', 10:14:01 INFO - 'TMOUT': '86400', 10:14:01 INFO - 'USER': 'cltbld', 10:14:01 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1480267606.920969-302350423', 10:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:01 INFO - '_': '/tools/buildbot/bin/python'} 10:14:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:01 INFO - Downloading/unpacking jsonschema==2.5.1 10:14:01 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 10:14:01 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 10:14:01 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 10:14:01 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 10:14:01 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 10:14:01 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 10:14:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:14:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14:03 INFO - Downloading functools32-3.2.3-2.tar.gz 10:14:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:14:04 INFO - warning: no files found matching '*.txt' 10:14:04 INFO - no previously-included directories found matching 'build' 10:14:04 INFO - no previously-included directories found matching 'dist' 10:14:04 INFO - no previously-included directories found matching '.git*' 10:14:04 INFO - Installing collected packages: jsonschema, functools32 10:14:04 INFO - Running setup.py install for functools32 10:14:04 INFO - warning: no files found matching '*.txt' 10:14:04 INFO - no previously-included directories found matching 'build' 10:14:04 INFO - no previously-included directories found matching 'dist' 10:14:04 INFO - no previously-included directories found matching '.git*' 10:14:04 INFO - Successfully installed jsonschema functools32 10:14:04 INFO - Cleaning up... 10:14:04 INFO - Return code: 0 10:14:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:04 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 0x7f47d742fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2232b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ce130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245cfc0>, '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 0x245dec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245e350>, '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': '4300f881736b422476174874000001bc-1480267606.920969-302350423', '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 10:14:04 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 10:14:04 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 10:14:04 INFO - Using env: {'DISPLAY': ':0', 10:14:04 INFO - 'HOME': '/home/cltbld', 10:14:04 INFO - 'LANG': 'en_US.UTF-8', 10:14:04 INFO - 'LANGUAGE': 'en_US:en', 10:14:04 INFO - 'LOGNAME': 'cltbld', 10:14:04 INFO - 'MAIL': '/var/mail/cltbld', 10:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:04 INFO - 'MOZ_NO_REMOTE': '1', 10:14:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:04 INFO - 'NO_EM_RESTART': '1', 10:14:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:04 INFO - 'PWD': '/builds/slave/test', 10:14:04 INFO - 'SHELL': '/bin/bash', 10:14:04 INFO - 'SHLVL': '1', 10:14:04 INFO - 'TERM': 'linux', 10:14:04 INFO - 'TMOUT': '86400', 10:14:04 INFO - 'USER': 'cltbld', 10:14:04 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1480267606.920969-302350423', 10:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:04 INFO - '_': '/tools/buildbot/bin/python'} 10:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:14:04 INFO - Cleaning up... 10:14:04 INFO - Return code: 0 10:14:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:04 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 0x7f47d742fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2232b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ce130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245cfc0>, '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 0x245dec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245e350>, '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': '4300f881736b422476174874000001bc-1480267606.920969-302350423', '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 10:14:04 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 10:14:04 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 10:14:04 INFO - Using env: {'DISPLAY': ':0', 10:14:04 INFO - 'HOME': '/home/cltbld', 10:14:04 INFO - 'LANG': 'en_US.UTF-8', 10:14:04 INFO - 'LANGUAGE': 'en_US:en', 10:14:04 INFO - 'LOGNAME': 'cltbld', 10:14:04 INFO - 'MAIL': '/var/mail/cltbld', 10:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:04 INFO - 'MOZ_NO_REMOTE': '1', 10:14:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:04 INFO - 'NO_EM_RESTART': '1', 10:14:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:04 INFO - 'PWD': '/builds/slave/test', 10:14:04 INFO - 'SHELL': '/bin/bash', 10:14:04 INFO - 'SHLVL': '1', 10:14:04 INFO - 'TERM': 'linux', 10:14:04 INFO - 'TMOUT': '86400', 10:14:04 INFO - 'USER': 'cltbld', 10:14:04 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1480267606.920969-302350423', 10:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:04 INFO - '_': '/tools/buildbot/bin/python'} 10:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:04 INFO - Downloading/unpacking blobuploader==1.2.4 10:14:04 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 10:14:04 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 10:14:04 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 10:14:04 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 10:14:04 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 10:14:04 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 10:14:06 INFO - Downloading blobuploader-1.2.4.tar.gz 10:14:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:14:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:14:06 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 10:14: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 10:14:06 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 10:14:06 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 10:14:06 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 10:14: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 10:14:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:14:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:14:07 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 10:14:07 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 10:14:07 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 10:14:07 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 10:14:07 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 10:14:07 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 10:14:07 INFO - Downloading docopt-0.6.1.tar.gz 10:14:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:14:07 INFO - Installing collected packages: blobuploader, requests, docopt 10:14:07 INFO - Running setup.py install for blobuploader 10:14:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:14:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:14:07 INFO - Running setup.py install for requests 10:14:07 INFO - Running setup.py install for docopt 10:14:07 INFO - Successfully installed blobuploader requests docopt 10:14:07 INFO - Cleaning up... 10:14:08 INFO - Return code: 0 10:14:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:08 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 0x7f47d742fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2232b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ce130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245cfc0>, '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 0x245dec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245e350>, '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': '4300f881736b422476174874000001bc-1480267606.920969-302350423', '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 10:14:08 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 10:14:08 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 10:14:08 INFO - Using env: {'DISPLAY': ':0', 10:14:08 INFO - 'HOME': '/home/cltbld', 10:14:08 INFO - 'LANG': 'en_US.UTF-8', 10:14:08 INFO - 'LANGUAGE': 'en_US:en', 10:14:08 INFO - 'LOGNAME': 'cltbld', 10:14:08 INFO - 'MAIL': '/var/mail/cltbld', 10:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:08 INFO - 'MOZ_NO_REMOTE': '1', 10:14:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:08 INFO - 'NO_EM_RESTART': '1', 10:14:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:08 INFO - 'PWD': '/builds/slave/test', 10:14:08 INFO - 'SHELL': '/bin/bash', 10:14:08 INFO - 'SHLVL': '1', 10:14:08 INFO - 'TERM': 'linux', 10:14:08 INFO - 'TMOUT': '86400', 10:14:08 INFO - 'USER': 'cltbld', 10:14:08 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1480267606.920969-302350423', 10:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:08 INFO - '_': '/tools/buildbot/bin/python'} 10:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:14:08 INFO - Running setup.py (path:/tmp/pip-1VmTeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:14:08 INFO - Running setup.py (path:/tmp/pip-dkfItk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:14:08 INFO - Running setup.py (path:/tmp/pip-3W4gKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:14:08 INFO - Running setup.py (path:/tmp/pip-1ow63w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:14:08 INFO - Running setup.py (path:/tmp/pip-ctk9q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:14:08 INFO - Running setup.py (path:/tmp/pip-JOO1Kh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:14:08 INFO - Running setup.py (path:/tmp/pip-6ujXVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:14:08 INFO - Running setup.py (path:/tmp/pip-BcPdcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:14:08 INFO - Running setup.py (path:/tmp/pip-837IeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:14:08 INFO - Running setup.py (path:/tmp/pip-pjKDmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:14:09 INFO - Running setup.py (path:/tmp/pip-r9hys6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:14:09 INFO - Running setup.py (path:/tmp/pip-XpxA3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:14:09 INFO - Running setup.py (path:/tmp/pip-l1sUzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:14:09 INFO - Running setup.py (path:/tmp/pip-ir_Oqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:09 INFO - Running setup.py (path:/tmp/pip-TBaq5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:14:09 INFO - Running setup.py (path:/tmp/pip-Dwyx4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:14:09 INFO - Running setup.py (path:/tmp/pip-oaSAtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:14:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:14:09 INFO - Running setup.py install for manifestparser 10:14:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:14:09 INFO - Running setup.py install for mozcrash 10:14:09 INFO - Running setup.py install for mozdebug 10:14:09 INFO - Running setup.py install for mozdevice 10:14:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:14:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:14:09 INFO - Running setup.py install for mozfile 10:14:10 INFO - Running setup.py install for mozhttpd 10:14:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:14:10 INFO - Running setup.py install for mozinfo 10:14:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:14:10 INFO - Running setup.py install for mozInstall 10:14:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:14:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:14:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:14:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:14:10 INFO - Running setup.py install for mozleak 10:14:10 INFO - Running setup.py install for mozlog 10:14:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:14:10 INFO - Running setup.py install for moznetwork 10:14:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:14:10 INFO - Running setup.py install for mozprocess 10:14:10 INFO - Running setup.py install for mozprofile 10:14:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:14:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:14:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:14:10 INFO - Running setup.py install for mozrunner 10:14:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:14:10 INFO - Running setup.py install for mozscreenshot 10:14:11 INFO - Running setup.py install for moztest 10:14:11 INFO - Running setup.py install for mozversion 10:14:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:14:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:14:11 INFO - Cleaning up... 10:14:11 INFO - Return code: 0 10:14:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:11 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 0x7f47d742fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2232b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ce130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245cfc0>, '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 0x245dec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245e350>, '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': '4300f881736b422476174874000001bc-1480267606.920969-302350423', '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 10:14:11 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 10:14:11 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 10:14:11 INFO - Using env: {'DISPLAY': ':0', 10:14:11 INFO - 'HOME': '/home/cltbld', 10:14:11 INFO - 'LANG': 'en_US.UTF-8', 10:14:11 INFO - 'LANGUAGE': 'en_US:en', 10:14:11 INFO - 'LOGNAME': 'cltbld', 10:14:11 INFO - 'MAIL': '/var/mail/cltbld', 10:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:11 INFO - 'MOZ_NO_REMOTE': '1', 10:14:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:11 INFO - 'NO_EM_RESTART': '1', 10:14:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:11 INFO - 'PWD': '/builds/slave/test', 10:14:11 INFO - 'SHELL': '/bin/bash', 10:14:11 INFO - 'SHLVL': '1', 10:14:11 INFO - 'TERM': 'linux', 10:14:11 INFO - 'TMOUT': '86400', 10:14:11 INFO - 'USER': 'cltbld', 10:14:11 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1480267606.920969-302350423', 10:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:11 INFO - '_': '/tools/buildbot/bin/python'} 10:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:14:11 INFO - Running setup.py (path:/tmp/pip-SOgZPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:14:11 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)) 10:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:14:11 INFO - Running setup.py (path:/tmp/pip-dcp7NV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:14:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:14:11 INFO - Running setup.py (path:/tmp/pip-atF2CO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:14:11 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)) 10:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:14:11 INFO - Running setup.py (path:/tmp/pip-CwvvD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:14:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 10:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:14:11 INFO - Running setup.py (path:/tmp/pip-wfSA2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:14:11 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)) 10:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:14:11 INFO - Running setup.py (path:/tmp/pip-wmW_D8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:14:11 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)) 10:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:14:11 INFO - Running setup.py (path:/tmp/pip-b8Fsq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:14:12 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)) 10:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:14:12 INFO - Running setup.py (path:/tmp/pip-LaO1UE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:14:12 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)) 10:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:14:12 INFO - Running setup.py (path:/tmp/pip-IQceHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:14:12 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)) 10:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:14:12 INFO - Running setup.py (path:/tmp/pip-r3WVzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:14:12 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)) 10:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:14:12 INFO - Running setup.py (path:/tmp/pip-p4eK5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:14:12 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)) 10:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:14:12 INFO - Running setup.py (path:/tmp/pip-E6S8bH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:14:12 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)) 10:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:14:12 INFO - Running setup.py (path:/tmp/pip-KaU_Jo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:14:12 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)) 10:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:14:12 INFO - Running setup.py (path:/tmp/pip-poVq7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:12 INFO - Running setup.py (path:/tmp/pip-1s8WMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:12 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)) 10:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:14:12 INFO - Running setup.py (path:/tmp/pip-ZIy2gA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:14:12 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)) 10:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:14:12 INFO - Running setup.py (path:/tmp/pip-UcBk9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:14:12 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)) 10:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:14:12 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)) 10:14:12 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:14:12 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:14:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:14:12 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 10:14:12 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 10:14:12 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 10:14:12 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 10:14:12 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 10:14:12 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 10:14:14 INFO - Downloading blessings-1.6.tar.gz 10:14:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:14:14 INFO - Installing collected packages: blessings 10:14:14 INFO - Running setup.py install for blessings 10:14:14 INFO - Successfully installed blessings 10:14:14 INFO - Cleaning up... 10:14:14 INFO - Return code: 0 10:14:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:14:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:14:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:14:15 INFO - Reading from file tmpfile_stdout 10:14:15 INFO - Current package versions: 10:14:15 INFO - argparse == 1.2.1 10:14:15 INFO - blessings == 1.6 10:14:15 INFO - blobuploader == 1.2.4 10:14:15 INFO - docopt == 0.6.1 10:14:15 INFO - functools32 == 3.2.3-2 10:14:15 INFO - jsonschema == 2.5.1 10:14:15 INFO - manifestparser == 1.1 10:14:15 INFO - mozInstall == 1.12 10:14:15 INFO - mozcrash == 1.0 10:14:15 INFO - mozdebug == 0.1 10:14:15 INFO - mozdevice == 0.49 10:14:15 INFO - mozfile == 1.2 10:14:15 INFO - mozhttpd == 0.7 10:14:15 INFO - mozinfo == 0.9 10:14:15 INFO - mozleak == 0.1 10:14:15 INFO - mozlog == 3.4 10:14:15 INFO - moznetwork == 0.27 10:14:15 INFO - mozprocess == 0.23 10:14:15 INFO - mozprofile == 0.28 10:14:15 INFO - mozrunner == 6.13 10:14:15 INFO - mozscreenshot == 0.1 10:14:15 INFO - mozsystemmonitor == 0.3 10:14:15 INFO - moztest == 0.7 10:14:15 INFO - mozversion == 1.4 10:14:15 INFO - psutil == 3.1.1 10:14:15 INFO - requests == 1.2.3 10:14:15 INFO - wsgiref == 0.1.2 10:14:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:15 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 0x7f47d742fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2232b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ce130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245cfc0>, '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 0x245dec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245e350>, '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': '4300f881736b422476174874000001bc-1480267606.920969-302350423', '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 10:14:15 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 10:14:15 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 10:14:15 INFO - Using env: {'DISPLAY': ':0', 10:14:15 INFO - 'HOME': '/home/cltbld', 10:14:15 INFO - 'LANG': 'en_US.UTF-8', 10:14:15 INFO - 'LANGUAGE': 'en_US:en', 10:14:15 INFO - 'LOGNAME': 'cltbld', 10:14:15 INFO - 'MAIL': '/var/mail/cltbld', 10:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:15 INFO - 'MOZ_NO_REMOTE': '1', 10:14:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:15 INFO - 'NO_EM_RESTART': '1', 10:14:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:15 INFO - 'PWD': '/builds/slave/test', 10:14:15 INFO - 'SHELL': '/bin/bash', 10:14:15 INFO - 'SHLVL': '1', 10:14:15 INFO - 'TERM': 'linux', 10:14:15 INFO - 'TMOUT': '86400', 10:14:15 INFO - 'USER': 'cltbld', 10:14:15 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1480267606.920969-302350423', 10:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:15 INFO - '_': '/tools/buildbot/bin/python'} 10:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:15 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)) 10:14:15 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)) 10:14:15 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)) 10:14:15 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)) 10:14:15 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)) 10:14:15 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)) 10:14:15 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)) 10:14:15 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)) 10:14:15 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)) 10:14:15 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)) 10:14:15 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)) 10:14:15 INFO - Cleaning up... 10:14:15 INFO - Return code: 0 10:14:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:15 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 0x7f47d742fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2232b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ce130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245cfc0>, '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 0x245dec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245e350>, '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': '4300f881736b422476174874000001bc-1480267606.920969-302350423', '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 10:14:15 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 10:14:15 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 10:14:15 INFO - Using env: {'DISPLAY': ':0', 10:14:15 INFO - 'HOME': '/home/cltbld', 10:14:15 INFO - 'LANG': 'en_US.UTF-8', 10:14:15 INFO - 'LANGUAGE': 'en_US:en', 10:14:15 INFO - 'LOGNAME': 'cltbld', 10:14:15 INFO - 'MAIL': '/var/mail/cltbld', 10:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:15 INFO - 'MOZ_NO_REMOTE': '1', 10:14:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:15 INFO - 'NO_EM_RESTART': '1', 10:14:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:15 INFO - 'PWD': '/builds/slave/test', 10:14:15 INFO - 'SHELL': '/bin/bash', 10:14:15 INFO - 'SHLVL': '1', 10:14:15 INFO - 'TERM': 'linux', 10:14:15 INFO - 'TMOUT': '86400', 10:14:15 INFO - 'USER': 'cltbld', 10:14:15 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1480267606.920969-302350423', 10:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:15 INFO - '_': '/tools/buildbot/bin/python'} 10:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:14:15 INFO - Cleaning up... 10:14:15 INFO - Return code: 0 10:14:15 INFO - Running post-action listener: _resource_record_post_action 10:14:15 INFO - Running post-action listener: _start_resource_monitoring 10:14:15 INFO - Starting resource monitoring. 10:14:15 INFO - [mozharness: 2016-11-27 18:14:15.632547Z] Finished create-virtualenv step (success) 10:14:15 INFO - [mozharness: 2016-11-27 18:14:15.633020Z] Running install step. 10:14:15 INFO - Running pre-action listener: _resource_record_pre_action 10:14:15 INFO - Running main action method: install 10:14:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:14:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:14:15 INFO - Reading from file tmpfile_stdout 10:14:15 INFO - Detecting whether we're running mozinstall >=1.0... 10:14:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:14:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:14:15 INFO - Reading from file tmpfile_stdout 10:14:15 INFO - Output received: 10:14:15 INFO - Usage: mozinstall [options] installer 10:14:15 INFO - Options: 10:14:15 INFO - -h, --help show this help message and exit 10:14:15 INFO - -d DEST, --destination=DEST 10:14:15 INFO - Directory to install application into. [default: 10:14:15 INFO - "/builds/slave/test"] 10:14:15 INFO - --app=APP Application being installed. [default: firefox] 10:14:15 INFO - mkdir: /builds/slave/test/build/application 10:14:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:14:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:14:32 INFO - Reading from file tmpfile_stdout 10:14:32 INFO - Output received: 10:14:32 INFO - /builds/slave/test/build/application/firefox/firefox 10:14:32 INFO - Running post-action listener: _resource_record_post_action 10:14:32 INFO - [mozharness: 2016-11-27 18:14:32.887960Z] Finished install step (success) 10:14:32 INFO - [mozharness: 2016-11-27 18:14:32.888202Z] Running run-tests step. 10:14:32 INFO - Running pre-action listener: _resource_record_pre_action 10:14:32 INFO - Running main action method: run_tests 10:14:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:14:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:14:32 INFO - Python 2.7.3 10:14:32 INFO - Return code: 0 10:14:32 INFO - grabbing minidump binary from tooltool 10:14:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:32 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 0x245cfc0>, '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 0x245dec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245e350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:14:32 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 10:14:32 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 10:14:32 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 10:14:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:14:32 INFO - Return code: 0 10:14:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:14:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:14:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:14:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:14:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:14:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WJfaXgl1QsWK2H_Uf6uSGQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:14:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WJfaXgl1QsWK2H_Uf6uSGQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:14:32 INFO - Using env: {'DISPLAY': ':0', 10:14:32 INFO - 'HOME': '/home/cltbld', 10:14:32 INFO - 'LANG': 'en_US.UTF-8', 10:14:32 INFO - 'LANGUAGE': 'en_US:en', 10:14:32 INFO - 'LOGNAME': 'cltbld', 10:14:32 INFO - 'MAIL': '/var/mail/cltbld', 10:14:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:14:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:14:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:32 INFO - 'MOZ_NO_REMOTE': '1', 10:14:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:14:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:32 INFO - 'NO_EM_RESTART': '1', 10:14:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:32 INFO - 'PWD': '/builds/slave/test', 10:14:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:14:32 INFO - 'SHELL': '/bin/bash', 10:14:32 INFO - 'SHLVL': '1', 10:14:32 INFO - 'TERM': 'linux', 10:14:32 INFO - 'TMOUT': '86400', 10:14:32 INFO - 'USER': 'cltbld', 10:14:32 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1480267606.920969-302350423', 10:14:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:32 INFO - '_': '/tools/buildbot/bin/python'} 10:14:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WJfaXgl1QsWK2H_Uf6uSGQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:14:33 INFO - mozversion application_buildid: 20161127073101 10:14:33 INFO - mozversion application_changeset: 05328d3102efd4d5fc0696489734d7771d24459f 10:14:33 INFO - mozversion application_display_name: Nightly 10:14:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:14:33 INFO - mozversion application_name: Firefox 10:14:33 INFO - mozversion application_remotingname: firefox 10:14:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:14:33 INFO - mozversion application_vendor: Mozilla 10:14:33 INFO - mozversion application_version: 53.0a1 10:14:33 INFO - mozversion platform_buildid: 20161127073101 10:14:33 INFO - mozversion platform_changeset: 05328d3102efd4d5fc0696489734d7771d24459f 10:14:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:14:33 INFO - mozversion platform_version: 53.0a1 10:14:33 INFO - using testdate: 1480270473 10:14:33 INFO - actual date: 1480270473 10:14:33 INFO - starting webserver on 'localhost:36899' 10:14:33 INFO - SUITE-START | Running 2 tests 10:14:33 INFO - TEST-START | dromaeo_css 10:14:33 INFO - operating with platform_type : linux_ 10:14:33 INFO - Initialising browser for dromaeo_css test... 10:14:33 INFO - TEST-INFO | started process 3377 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_4JvMv/profile http://localhost:36899/getInfo.html) 10:14:37 INFO - PROCESS | 3377 | __metrics Screen width/height:1600/1200 10:14:37 INFO - PROCESS | 3377 | colorDepth:24 10:14:37 INFO - PROCESS | 3377 | Browser inner width/height: 1024/697 10:14:37 INFO - PROCESS | 3377 | __metrics 10:14:38 INFO - PROCESS | 3377 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:14:38 INFO - PROCESS | 3377 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:14:38 INFO - PROCESS | 3377 | console.error: PushService: 10:14:38 INFO - PROCESS | 3377 | stateChangeProcessEnqueue: Error transitioning state 10:14:38 INFO - PROCESS | 3377 | UnknownError 10:14:39 INFO - TEST-INFO | 3377: exit 0 10:14:39 INFO - Browser initialized. 10:14:39 INFO - Running cycle 1/1 for dromaeo_css test... 10:14:39 INFO - TEST-INFO | started process 3463 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_4JvMv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:14:51 INFO - PROCESS | 3463 | RSS: Main: 173248512 10:14:51 INFO - PROCESS | 3463 | 10:15:42 INFO - PROCESS | 3463 | 1480270542756 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] 10:17:54 INFO - PROCESS | 3463 | Cycle 1(1): loaded http://localhost:36899/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36899/tests/dromaeo/cssquery-ext.html) 10:17:56 INFO - PROCESS | 3463 | RSS: Main: 348631040 10:17:56 INFO - PROCESS | 3463 | 10:20:59 INFO - PROCESS | 3463 | Cycle 1(1): loaded http://localhost:36899/tests/dromaeo/cssquery-ext.html (next: http://localhost:36899/tests/dromaeo/cssquery-jquery.html) 10:20:59 INFO - PROCESS | 3463 | RSS: Main: 284782592 10:20:59 INFO - PROCESS | 3463 | 10:24:01 INFO - PROCESS | 3463 | Cycle 1(1): loaded http://localhost:36899/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36899/tests/dromaeo/cssquery-mootools.html) 10:24:02 INFO - PROCESS | 3463 | RSS: Main: 219860992 10:24:02 INFO - PROCESS | 3463 | 10:27:04 INFO - PROCESS | 3463 | Cycle 1(1): loaded http://localhost:36899/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36899/tests/dromaeo/cssquery-prototype.html) 10:27:05 INFO - PROCESS | 3463 | RSS: Main: 247001088 10:27:05 INFO - PROCESS | 3463 | 10:30:08 INFO - PROCESS | 3463 | Cycle 1(1): loaded http://localhost:36899/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36899/tests/dromaeo/cssquery-yui.html) 10:30:08 INFO - PROCESS | 3463 | RSS: Main: 216121344 10:30:08 INFO - PROCESS | 3463 | 10:33:11 INFO - PROCESS | 3463 | Cycle 1(1): loaded http://localhost:36899/tests/dromaeo/cssquery-yui.html (next: http://localhost:36899/tests/dromaeo/cssquery-dojo.html) 10:33:11 INFO - PROCESS | 3463 | RSS: Main: 313630720 10:33:11 INFO - PROCESS | 3463 | 10:33:11 INFO - PROCESS | 3463 | __start_tp_report 10:33:11 INFO - PROCESS | 3463 | _x_x_mozilla_page_load 10:33:11 INFO - PROCESS | 3463 | _x_x_mozilla_page_load_details 10:33:11 INFO - PROCESS | 3463 | |i|pagename|runs| 10:33:11 INFO - PROCESS | 3463 | |0;dojo.html;3121.0480803354976;3160.3837251735913;3167.3348596794685;3180.093673303109;3211.8554665040087;5261.210818377236;5339.866503337409;5410.48600382964;5505.0366185917455;5522.861928451785;5330.200469929512;5450.56395488361;5508.366537848148;5518.310211223597;5610.635308704931;4904.60763138948;4982.676126051795;5008.9499105008845;5010.849674509771;5021.774020169101;4937.358143441347;4967.627427942901;4994.450610432849;5018.498150184989;5131.589472842183;5057.949420505803;5078.289039534449;5080.898382032357;5107.233914912756;5121.5390614844655;4799.6400269979895;4823.421189457253;4853.102176097434;4998.40019197695;5048.545630893201;4853.466118726938;4877.51224877513;4896.828610998634;4900.044491324194;4935.383077115361;5351.143816989263;5374.435684253136;5389.622726409153;5405.864853378657;5417.59368047398;5640.351359593658;5673.8581535461535;5778.42215778423;5780.450857168562;5785.045467497858;5897.7935772247765;5926.259217597801;5940.851478713023;5961.910571341434;5984.640921544721;5515.806946756844;5518.53092487135;5519;5519.116941289374;5521.723913804293;5834.154047663065;5885.588008839341;5994.610350327215;5994.910076348859;6005.159277701126;5743.684097374601;5786.94213057864;5800.8259752207505;5829.533637309005;5888.676122813201;5871.266091738533;5909.438603332676;5912.615679980788;5919.585629005928;5927.170196172539;5558.916616250759;5857.88284234313;5898.941010589925;5913.822585322448;5918.556108291896;5686.943130568724;5702.657840529499;5710.5717071219;5712.457316555004;5716.228309178207;4456.888577785517;4470.195364834296;4470.642348612103;4471.977640111779;4477.955220447754;4039.333509970822;4043.6158564936286;4044.170944956277;4046.0289530512464;4048.8987775305263;5428.077226871442;5467.644603100785;5477.917831232535;5480.369757477862;5486.780528778804;5806.535477161817;5807.477327040587;5810.680412577264;5811.041178205549;5819.127130930395;5487.451254874481;5488.1493368527945;5491.258680078218;5492.093804522209;5492.340919089735;5000.874978125576;5005.524475174852;5013.348264725562;5053.267276244997;5055.772490237948;6028.517718582503;6038.698065096728;6041.848953776191;6051.183090282843;6051.909221361683;5594.41258667834;5605.943940560543;5838.766449342149;5857.238558987305;5879;6093.806546925568;6122.672617327995;6125.327021303102;6125.449118208525;6131.162586540493;5785.623934444247;5788.565857560784;5789.913151302818;5794;5842.853928651818;5661.801836935688;5713.885722285614;5802.332731735904;5881.441263080001;5887.1757953885635;5630.239917611234;5756.107803290497;5764.942350576608;5780.421957804186;5812.3025236971835;5753.884922301447;5762.855928601818;5763.769449221984;5768.480836724547;5769.307683078057;5456.727163641882;5482.451754824486;5705.144228365778;5742.28221472316;5743.942560574341;5646.943530564642;5654.3497497788285;5659;5661.348944871393;5667.319921609434;5502.257195278747;5536.944630553643;5539.833804985857;5540.63985840919;5549.889002220014 10:33:11 INFO - PROCESS | 3463 | |1;ext.html;552.7024414168421;581.8399940016496;598.9550783691225;628.7139351595025;647.3494138390917;31154;33581;40046.59953400469;41143.382849257214;41148.38277425834;42059.57940420595;42430;42457.57542424575;42466.36300455488;42533.361999569956;8361.623726932288;8519.914800852006;8525.44584601999;8529.232369086782;8534.1039190885;7949.880751788728;8121.228483294078;8130.186981301882;8257.793555161139;8331.750047498585;10041.497925103753;10279.383237005766;10286.485675716222;10575.576976920915;10589.682309530726;10134.949325253363;10197.337173083726;10206.438645874474;10220.948895255477;10225;10030.498475076218;10092;10101.69694909154;10117.443540605263;10122;39779.8011009946;40060.59939400598;40083.39874901879;40093.79953100245;40130.39804402936;3322.1362445764034;3335.8832440864694;3353.84907679155;3382.4757162639585;3813.2564149990762;30035;30619.23451913698;30641.387172256655;30706.38587228265;30725.385492290254;4026.335654616985;4074.9388759168637;4128.071183983609;4153.709240353177;4285.8499952501825;328811;329674;330185;330322;330589;53244;53591;53602.463975359744;53625.463745362824;53642.73178634082;54829.88775841828;55342.72328638331;55781.44218557844;55890;55979;13431.059825812295;13572.728545429036;13582;13582.93208533951;13589.252591107585;10491.737706557396;10535.315204511682;10558.04977552024;10564.313319634199;10565.366078035342;13961.371738271599;14337.498187563386;15094.924525377523;15430.768538471932;15524.37902483888;5909.303692194246;6109.84725381869;6171.876562468726;6235.314115447297;6298.842528936813;916.3310783128354;998.83519219328;1013.2096964367657;1020.3520764314713;1125.7129431994788;30182.54726179109;30458.54312185319;30548.54177187344;30653.693463065083;31007;1041.614602597044;1052.153016821466;1068.4497483795851;1077.3374374759467;1079.83262594298;16031.839681603034;16241.756373654405;16315.428959986344;16382.344706211856;16559.25483353252;460605;465309;465722;466105;467007;47487;48621.270680939815;51270;52235.21647175295;52670.47329526656;1296.623979046066;1308.4700696218047;1320.3728229091105;1324.6886981559326;1339.0225135651028;29717.85141074281;31841.840790795897;32074.67925320717;32199.456335382132;32333.51499727459;47514.28728569005;47963.28055079107;47963.76018120027;48012.27981580349;48041;259252;259477;259635;259648;260129;37247.55048990159;37796;38198.80900595479;38328.6167138325;38493.80753096216;43412.78293608512;43823;43983.12033759371;44048;45546;37549;37828.62171378251;38074.23851523009;38257.80871095738;38367.232655347296;37005.94193990043;37659.610635042976;38249.808750956065;38879.80560097181;39150.21699565936;37718.43422348612;38119.80940095282;38223;38269.80865095768;38329.61670383372;32039.359212816078;34033.19995404163;34422.655773442944;34582.30835383329;34821.1294717624;25476.872615636803;26250.60624090602;26269.605955910294;26307.736922631295;26726.19821405361 10:33:11 INFO - PROCESS | 3463 | |2;jquery.html;375.69005570404425;398.56158225951475;407.7675724836843;409.08773435239414;417.3072699319131;13457.932710336447;15429.228538573083;18530.3514376997;19051;19265.32571360003;18947.621047579076;18962.146703398346;19323.90338048308;19496.122674479648;19527.316543920966;4640.883977900546;5480.177973304007;5697.430256974311;5710.914336284959;5714.828555143332;6067.605605635642;6282.4974002079725;6314;6319.273283572379;6323.430891219789;6086.391360863922;6267.937320626804;6289.968550157266;6297.4017468340435;6307.558470907038;6203.782867599635;6233.563650544464;6234.470070044052;6243.157173781527;6246.718897649616;5369.248305237231;5570.610057295991;5602.859928501779;5607.383187849333;5616.129499927518;22797.43006424836;22952.31143065694;22974;23085.307440776804;23107.191248306397;2221.144859229192;2221.466847956495;2242.7532971373134;2276.3398614401804;2452.0069371904406;9907.851382229272;10331.121854642364;10462.895371046345;10548.419836908966;10770.4614769262;1861.1345724238295;1863.3292014874635;1870.532366908273;1881.0876724788466;1916.597514521952;80670.59664701698;82736;83845.58077209575;84217.57891210505;84320;10935.179861510418;11054.502547385388;11136.777264454666;11204.551817927191;11251.493682784294;15756.369745210062;15791.052536847827;15795;15825.366985320688;15836.208189590474;6907.965460172667;7175.784726458214;7613.5431874087735;7731.110922243902;7858.764237072897;7002.474814388839;7069.798134317179;7072.115985501812;7270.854582908312;7281;4759.333693282943;4773.498782627844;4786.234202527578;4813.638977076734;4945.530174633404;1949.6588097083238;1982.5043739065234;2019.202415046078;2041.428400047989;2042.5914817036653;863.7279257034014;985.019905194322;989.5893204320271;989.737719504332;997.1474389396961;17918.820811791717;18849.246030158913;19432.902835485733;19441.708374374397;19502.902485487764;941.1648030149037;941.755143662639;962.0956301076965;975.3855071305032;1049.559185142242;10281.331713438603;10881.727956801144;10883.401412922207;10893.83659245112;11001.834972475419;415617;432148;439121;439353;443312;92332;93432.53283733538;94133;95395;95411;976.0337266106503;988.3773222869546;992.4541502173776;1005.9044390782864;1010.5452546354023;14775.92612036933;16192.190390480193;17342.566435839206;17417.216225270146;17558.385456509473;42004.3699344504;42175.57824421716;42326.576734232265;42940.35589466223;44458.777706111265;56276.71861640666;57152.714236428554;57814.7109264451;58554.414455854894;59195.704021479614;8273.048599411144;8400.159984001551;8424.315136972507;8435.367347448842;8645.654173832976;9830.508474576385;12561.309127998047;12925.741485170432;13011.21932684004;13163.407646656115;11141.665750027512;11354.432278385882;11460.312381257152;11594;11998.64004079879;11035.39305338214;11066.170037247399;11130.10959123252;11147.108231341312;11407.25852819564;11625.534978600761;11671.416429178338;11701.186316121015;11747.588834390755;11797.76404471923;8657.567121643766;8725.127487251479;8846.867296990678;8907.376483646083;8927.910720892707;10604.734881628021;11558.653240402802;11560.248583842023;11575.942120289345;11908.880911191123 10:33:11 INFO - PROCESS | 3463 | |3;mootools.html;1296.1704509114163;1432.4413478743286;1467.2077078377674;1592.3710134496873;1730.3338214787302;7147.32100450457;8032.317253033492;8259.95870020649;8315;8493.065762766106;8303.878976338192;8389.328853691706;8389.412741108124;8390.328773698106;8394.118617545162;1942.3881477334664;1997.8401727861808;1999.7000449932482;2190.211523851412;2223.5330580578097;2034.52188735647;2052.230413594902;2125.08621292844;2128.8722676639372;2143.239150101715;2205.3935167828813;2218.279059305724;2220.955580888381;2229.9554008919813;2230.5761905237955;2154.235246487498;2213.347062616532;2215.9667604985775;2220.4781876259067;2225.2990308052913;2103.5582527669208;2105.8525903186783;2108.1778106538463;2220.6668999650183;2239.9888000560054;8369.58152092393;8479.533625650587;8490.915090849074;8494.235518803276;8498.447600905922;5051.217061355495;5173.793048278064;5197.688138711652;5199.376074871039;5199.610029247821;3039.696030396965;3272.541844141822;3308.123347312964;3310.933781324384;3387.762856600039;965.1506674126794;1002.0330381182122;1005.1305620638095;1013.751630850439;1060.294903888913;11559.190856640038;11598.652040438801;11611.76776464466;11615.593454229062;11649.76700465986;4322.243607368698;4593.333966574828;4646.976765116153;4680.251159814414;4693.48371679115;9778.559964801601;9806.313558050868;9808.950955245178;9814.705558833246;9816.607335706634;5193.480651934852;5198.740062996835;5204.947950520522;5252.947470525322;5263.5525980292105;4587.931181032287;4764.094821983812;4772.49888761682;4779.115863565252;4809.615230781529;3593.6047034826147;3699.463577781207;3717.070732316921;3732.552093748713;3781.054736315921;1130.4121856634667;1132.416805345248;1146.744314975101;1171.4260012593938;1171.5782318365382;823.1932705948204;931.771715929588;932.7015355086443;940.0787228516092;960.6829746183743;5893.941060589339;5910.261217347832;6098.35967223444;6131.202943617391;6323.114763933053;941.7374459842105;955.1546881010356;972.7276362618478;993.5429702337005;1009.7526106103904;4054.108096218827;4055.168690418457;4065.3698676705158;4073.409355643415;4234.7670878102;10055.648052318134;10218.948905255575;10287.691369258935;10346.53440595175;10387.896121038693;10246.897531024744;10251.642122311761;10264.281500295057;10282.742931426774;10304;7498.550086994689;7932.920670793334;8058.194180581895;8066.475679080841;8078.515289082674;5970.164177015308;6012.3386427493815;6120.510359171167;6139.662318572521;6188.4739797117745;9423.811523769624;9495.810083798147;9561.474118923526;9566.856497152687;9628.807423851344;9589.232861370934;9738.902610974083;9813.067758562926;9824.852627210455;9836.016398360392;6645.933540664725;6700.329967003261;7283.271672832674;7312.232215617496;7455.552666840007;7808.336291415293;8251.711190108317;8309.916900831156;8331.833363332578;8332.04181519133;7381.188069312479;7382.114146302478;7403.18564957865;7413.443991700537;7441.776746697607;7096.7516136934955;7120.145582530129;7206.819829504304;7214.458915581457;7222.819429514304;6724.697388617426;6775.898361524482;6801.863962720817;6820.35206655367;6847.144106986627;5076.974615126901;5088.414832294334;5147.510986456281;5174.327337446259;5262.657927234717;5080.110980578458;5315.282436870973;5319.840404787863;5337.919931200958;5419.972900135474 10:33:11 INFO - PROCESS | 3463 | |4;prototype.html;321.51159914923085;337.2984192878811;342.83886573310537;346.67239458711515;349.32754447688194;5266.157414813631;5292.353823088456;5295.338082739658;5299.867503312419;5354;4954.027583449928;5015.172496538076;5071.84784456466;5074.873128171788;5247;4113.712040157183;4122.587741225883;4138.544315496564;4146.937795933063;4170.228507726065;4128.917421651565;4157.8544750933725;4164.12553363794;4182.205380977604;4207.26372884744;3975.284448799215;4003.5996400359877;4045.757254564721;4073.63337299643;4109.075458021951;4086.468759061318;4094.1402305515876;4095.8361665533344;4111.444954931076;4125.092479654471;3689.7786132832116;3692.7599706019023;3694.5751238607636;3702.407614781649;3711.758735682172;4962.553370196663;5014.749262536859;5045.84862454127;5186.273921650972;5198.908229271858;4637.515994881605;4660.347551342815;4671.369365135697;4675.95324046762;4682.578567928868;5383.380911195223;5409.83770486886;5417.26866872975;5425.914817036609;5429.864253393657;3913.6086391360923;3954.8220330085214;3982;4003;4004.8586152946564;5605.663660180361;5607.691576963265;5612;5632.7746890124345;5639.774409023634;4097.938530922039;4099.97950010248;4101.159262351211;4113.650339721157;4114.691398145151;4046.352583586612;4094.5086589609436;4158.043649960526;4165.187788381297;4169.937450938239;4607.585317321457;4608.493065762764;4636.003259299199;4659.603933665609;4686.156491831503;5414.35027796667;5425.9186112208345;5447.237386765856;5461.563074953994;5470.288862447856;1313.382710126239;1363.7613417651871;1377.2218696436482;1390.332640332646;1391.5199256256576;919.0928822692805;929.9256059515222;941.2140862379853;942.8585712143097;946.2997381937316;5160.793568257228;5183.870403239874;5198.92201616976;5211.635185537052;5261.842144735664;5057.848264552069;5395.352557693023;5431.83704488866;5446.2375267462585;5468.945310546923;5075.832558511563;5087.847364579068;5093;5095.515925987025;5105.821296254613;2860.6567211934703;2866.3407416293953;2867.3978464522684;2873.353495463504;2882.553204253344;5503.724813759296;5580.609357345028;5593.608447408724;5803.593748437654;5879.911801322984;5728;5744.673407270062;5750.712464376765;5785.71071446426;5800.419958004166;5676.971615141898;5850.12248162779;5879.559033072536;5884.970575147183;5935.376785437467;5641.323041235078;5661.773529058792;5674.517665998436;5692.6299790513485;5695.401982791913;5559.971405290034;5587.525060369914;5599.356074051373;5607.467290607386;5648.039833228443;5583.413741557078;5785.479306862402;5820.70896455184;5845.743165219498;5883.882322353615;4155.812988415468;4166.145940082215;4173.728707633994;4183.184279065553;4193.475815523059;5441.673499590037;5558.24963629921;5583.804566840141;5611.943880561305;5637.689927053887;5500.449955004628;5501.449855014466;5503.780288531254;5512.3660779010925;5527.198556209408;5272.124988133642;5494;5509.338879334506;5521.420250873761;5531.751071201725;5433.565314774887;5473.397926228191;5489.752961116839;5500.642458240201;5508.394076651645;5549.861253468695;5550.916736249041;5553.611247212656;5554.305711786027;5558.861028474159;5220.216967454912;5386.730663466889;5426;5448.727563621882;5510.3938566758425 10:33:11 INFO - PROCESS | 3463 | |5;yui.html;698.8776964031293;723.2839488905985;724.1418918581481;787.8227398835267;791.4855344026382;15271.618209544768;15713.292901819417;15749.291281892314;15752.369905203777;15809.60475988101;14566.635834104152;14701.117932924031;14727;14727;14727.190004549746;651.9608823470584;675.3988949834651;761.375671949002;777.8833175023764;782.1279273609941;788.3850596534684;800.087899794235;800.5116878703986;801.1187693537121;801.2548330053048;844.1811442900407;844.5777111444278;844.932405407569;845.344857735254;846.3313981954249;695.3429009585943;716.3839098375445;812.9349652027823;842.692417267696;843.0768308701962;610.9053096770008;617.9042248451498;618.4001518527022;618.5484596244767;618.6875627807973;14922.477713279983;14932.402703891832;14946;14977.1013739176;14980.475683351031;14194.361253743606;14447.349869255908;14506.56480305582;14535.624676410946;14563.417463301455;12422.81365779514;12766.36168191596;12954.870451295461;13076.08467407282;13100.148490348098;4293.162833247518;4295;4301.483821941387;4326.870193894189;4381.890452738675;87055.69416458758;88164.5591772037;88957;90208;90791.63812542817;9780.902190978142;10021.29850910444;10054.547545360476;11538.307701537935;11610.6516804496;20762.896185518977;21108.366748997247;21117;21118.894405528183;21135.26026589062;7541.208173141851;7546.396288296923;7607.239276072349;7740.4194685398825;7976.441649084509;4291.9785401072795;4298.634616057608;4336.609705126553;4345.500267469219;4399.824007039682;3220.323732016256;3323.4017876781927;3332.4501457259767;3703.7407381483035;3853.2100919311474;616.1035693066577;622.2688341199073;625.0499241153422;637.4963778614842;643.810076027573;570.7802496039055;638.9488840892717;642.6561789442626;683.3190351734788;726.8110291324293;9430.811383772287;10061.346012509164;10109.64616238428;10301.9484902575;10442.530086146142;606.6269244414653;625.7497001199556;681.6353251010686;690.9723611055603;727.6689106456549;4590.104929538775;4643.628509719214;4734.076855013308;4739.597134243628;4762.119007983534;69008.3099169012;70652;71796.64101679459;84536;86219;63924.68037659782;71027;71496;71761;72039;63129.68435157795;65188.34811651918;66280.33719662837;66469;67103;9534.618615255313;10190.643327483798;10281.794364112826;10339.586416543554;10458.111060559937;41451;42855.785721071195;42872.571274286856;44094;44378.77810610926;54712.452875470735;55741.721291394904;61283;62395;64399.03401449076;12718.300493472578;12921.612351629467;12943.741125177632;13015.934920325337;13062.477500899857;14138.575842724735;14210.502632407815;14244.857551424768;14531.418743250151;15192.316345764246;14083.859161408665;14118.2940852959;14170.858291416955;14563;14799.92600037036;13068.125112277932;13277.80083298732;13296.401661925043;13511.121777084458;13537.59387218385;12876.484940602271;13183.209007459584;13353.732925341634;13449;13903.652408689459;11281.71795705114;11447.713807154887;11739.647810565697;12134.75730485403;12162.77000889626;10084.69745907624;10669.89330106689;11716.36057203737;11954.70113247141;12094 10:33:11 INFO - PROCESS | 3463 | __end_tp_report 10:33:11 INFO - PROCESS | 3463 | __start_cc_report 10:33:11 INFO - PROCESS | 3463 | _x_x_mozilla_cycle_collect,1769 10:33:11 INFO - PROCESS | 3463 | __end_cc_report 10:33:11 INFO - PROCESS | 3463 | __startTimestamp1480271591783__endTimestamp 10:33:11 INFO - PROCESS | 3463 | 10:33:11 INFO - PROCESS | 3463 | ------- Summary: start ------- 10:33:11 INFO - PROCESS | 3463 | Number of tests: 6 10:33:11 INFO - PROCESS | 3463 | 10:33:11 INFO - PROCESS | 3463 | [#0] dojo.html Cycles:165 Average:5420.14 Median:5594.41 stddev:610.21 (10.9%) stddev-sans-first:584.82 10:33:11 INFO - PROCESS | 3463 | Values: 3121.0 3160.4 3167.3 3180.1 3211.9 5261.2 5339.9 5410.5 5505.0 5522.9 5330.2 5450.6 5508.4 5518.3 5610.6 4904.6 4982.7 5008.9 5010.8 5021.8 4937.4 4967.6 4994.5 5018.5 5131.6 5057.9 5078.3 5080.9 5107.2 5121.5 4799.6 4823.4 4853.1 4998.4 5048.5 4853.5 4877.5 4896.8 4900.0 4935.4 5351.1 5374.4 5389.6 5405.9 5417.6 5640.4 5673.9 5778.4 5780.5 5785.0 5897.8 5926.3 5940.9 5961.9 5984.6 5515.8 5518.5 5519.0 5519.1 5521.7 5834.2 5885.6 5994.6 5994.9 6005.2 5743.7 5786.9 5800.8 5829.5 5888.7 5871.3 5909.4 5912.6 5919.6 5927.2 5558.9 5857.9 5898.9 5913.8 5918.6 5686.9 5702.7 5710.6 5712.5 5716.2 4456.9 4470.2 4470.6 4472.0 4478.0 4039.3 4043.6 4044.2 4046.0 4048.9 5428.1 5467.6 5477.9 5480.4 5486.8 5806.5 5807.5 5810.7 5811.0 5819.1 5487.5 5488.1 5491.3 5492.1 5492.3 5000.9 5005.5 5013.3 5053.3 5055.8 6028.5 6038.7 6041.8 6051.2 6051.9 5594.4 5605.9 5838.8 5857.2 5879.0 6093.8 6122.7 6125.3 6125.4 6131.2 5785.6 5788.6 5789.9 5794.0 5842.9 5661.8 5713.9 5802.3 5881.4 5887.2 5630.2 5756.1 5764.9 5780.4 5812.3 5753.9 5762.9 5763.8 5768.5 5769.3 5456.7 5482.5 5705.1 5742.3 5743.9 5646.9 5654.3 5659.0 5661.3 5667.3 5502.3 5536.9 5539.8 5540.6 5549.9 10:33:11 INFO - PROCESS | 3463 | 10:33:11 INFO - PROCESS | 3463 | [#1] ext.html Cycles:180 Average:51431.16 Median:37398.28 stddev:95513.34 (255.4%) stddev-sans-first:95704.88 10:33:11 INFO - PROCESS | 3463 | Values: 552.7 581.8 599.0 628.7 647.3 31154.0 33581.0 40046.6 41143.4 41148.4 42059.6 42430.0 42457.6 42466.4 42533.4 8361.6 8519.9 8525.4 8529.2 8534.1 7949.9 8121.2 8130.2 8257.8 8331.8 10041.5 10279.4 10286.5 10575.6 10589.7 10134.9 10197.3 10206.4 10220.9 10225.0 10030.5 10092.0 10101.7 10117.4 10122.0 39779.8 40060.6 40083.4 40093.8 40130.4 3322.1 3335.9 3353.8 3382.5 3813.3 30035.0 30619.2 30641.4 30706.4 30725.4 4026.3 4074.9 4128.1 4153.7 4285.8 328811.0 329674.0 330185.0 330322.0 330589.0 53244.0 53591.0 53602.5 53625.5 53642.7 54829.9 55342.7 55781.4 55890.0 55979.0 13431.1 13572.7 13582.0 13582.9 13589.3 10491.7 10535.3 10558.0 10564.3 10565.4 13961.4 14337.5 15094.9 15430.8 15524.4 5909.3 6109.8 6171.9 6235.3 6298.8 916.3 998.8 1013.2 1020.4 1125.7 30182.5 30458.5 30548.5 30653.7 31007.0 1041.6 1052.2 1068.4 1077.3 1079.8 16031.8 16241.8 16315.4 16382.3 16559.3 460605.0 465309.0 465722.0 466105.0 467007.0 47487.0 48621.3 51270.0 52235.2 52670.5 1296.6 1308.5 1320.4 1324.7 1339.0 29717.9 31841.8 32074.7 32199.5 32333.5 47514.3 47963.3 47963.8 48012.3 48041.0 259252.0 259477.0 259635.0 259648.0 260129.0 37247.6 37796.0 38198.8 38328.6 38493.8 43412.8 43823.0 43983.1 44048.0 45546.0 37549.0 37828.6 38074.2 38257.8 38367.2 37005.9 37659.6 38249.8 38879.8 39150.2 37718.4 38119.8 38223.0 38269.8 38329.6 32039.4 34033.2 34422.7 34582.3 34821.1 25476.9 26250.6 26269.6 26307.7 26726.2 10:33:11 INFO - PROCESS | 3463 | 10:33:11 INFO - PROCESS | 3463 | [#2] jquery.html Cycles:180 Average:27472.02 Median:208017.15 stddev:72030.92 (34.6%) stddev-sans-first:72204.25 10:33:11 INFO - PROCESS | 3463 | Values: 375.7 398.6 407.8 409.1 417.3 13457.9 15429.2 18530.4 19051.0 19265.3 18947.6 18962.1 19323.9 19496.1 19527.3 4640.9 5480.2 5697.4 5710.9 5714.8 6067.6 6282.5 6314.0 6319.3 6323.4 6086.4 6267.9 6290.0 6297.4 6307.6 6203.8 6233.6 6234.5 6243.2 6246.7 5369.2 5570.6 5602.9 5607.4 5616.1 22797.4 22952.3 22974.0 23085.3 23107.2 2221.1 2221.5 2242.8 2276.3 2452.0 9907.9 10331.1 10462.9 10548.4 10770.5 1861.1 1863.3 1870.5 1881.1 1916.6 80670.6 82736.0 83845.6 84217.6 84320.0 10935.2 11054.5 11136.8 11204.6 11251.5 15756.4 15791.1 15795.0 15825.4 15836.2 6908.0 7175.8 7613.5 7731.1 7858.8 7002.5 7069.8 7072.1 7270.9 7281.0 4759.3 4773.5 4786.2 4813.6 4945.5 1949.7 1982.5 2019.2 2041.4 2042.6 863.7 985.0 989.6 989.7 997.1 17918.8 18849.2 19432.9 19441.7 19502.9 941.2 941.8 962.1 975.4 1049.6 10281.3 10881.7 10883.4 10893.8 11001.8 415617.0 432148.0 439121.0 439353.0 443312.0 92332.0 93432.5 94133.0 95395.0 95411.0 976.0 988.4 992.5 1005.9 1010.5 14775.9 16192.2 17342.6 17417.2 17558.4 42004.4 42175.6 42326.6 42940.4 44458.8 56276.7 57152.7 57814.7 58554.4 59195.7 8273.0 8400.2 8424.3 8435.4 8645.7 9830.5 12561.3 12925.7 13011.2 13163.4 11141.7 11354.4 11460.3 11594.0 11998.6 11035.4 11066.2 11130.1 11147.1 11407.3 11625.5 11671.4 11701.2 11747.6 11797.8 8657.6 8725.1 8846.9 8907.4 8927.9 10604.7 11558.7 11560.2 11575.9 11908.9 10:33:11 INFO - PROCESS | 3463 | 10:33:11 INFO - PROCESS | 3463 | [#3] mootools.html Cycles:180 Average:5566.68 Median:5199.49 stddev:3121.24 (60.0%) stddev-sans-first:3113.50 10:33:11 INFO - PROCESS | 3463 | Values: 1296.2 1432.4 1467.2 1592.4 1730.3 7147.3 8032.3 8260.0 8315.0 8493.1 8303.9 8389.3 8389.4 8390.3 8394.1 1942.4 1997.8 1999.7 2190.2 2223.5 2034.5 2052.2 2125.1 2128.9 2143.2 2205.4 2218.3 2221.0 2230.0 2230.6 2154.2 2213.3 2216.0 2220.5 2225.3 2103.6 2105.9 2108.2 2220.7 2240.0 8369.6 8479.5 8490.9 8494.2 8498.4 5051.2 5173.8 5197.7 5199.4 5199.6 3039.7 3272.5 3308.1 3310.9 3387.8 965.2 1002.0 1005.1 1013.8 1060.3 11559.2 11598.7 11611.8 11615.6 11649.8 4322.2 4593.3 4647.0 4680.3 4693.5 9778.6 9806.3 9809.0 9814.7 9816.6 5193.5 5198.7 5204.9 5252.9 5263.6 4587.9 4764.1 4772.5 4779.1 4809.6 3593.6 3699.5 3717.1 3732.6 3781.1 1130.4 1132.4 1146.7 1171.4 1171.6 823.2 931.8 932.7 940.1 960.7 5893.9 5910.3 6098.4 6131.2 6323.1 941.7 955.2 972.7 993.5 1009.8 4054.1 4055.2 4065.4 4073.4 4234.8 10055.6 10218.9 10287.7 10346.5 10387.9 10246.9 10251.6 10264.3 10282.7 10304.0 7498.6 7932.9 8058.2 8066.5 8078.5 5970.2 6012.3 6120.5 6139.7 6188.5 9423.8 9495.8 9561.5 9566.9 9628.8 9589.2 9738.9 9813.1 9824.9 9836.0 6645.9 6700.3 7283.3 7312.2 7455.6 7808.3 8251.7 8309.9 8331.8 8332.0 7381.2 7382.1 7403.2 7413.4 7441.8 7096.8 7120.1 7206.8 7214.5 7222.8 6724.7 6775.9 6801.9 6820.4 6847.1 5077.0 5088.4 5147.5 5174.3 5262.7 5080.1 5315.3 5319.8 5337.9 5420.0 10:33:11 INFO - PROCESS | 3463 | 10:33:11 INFO - PROCESS | 3463 | [#4] prototype.html Cycles:180 Average:4617.89 Median:5254.42 stddev:1346.78 (25.6%) stddev-sans-first:1311.38 10:33:11 INFO - PROCESS | 3463 | Values: 321.5 337.3 342.8 346.7 349.3 5266.2 5292.4 5295.3 5299.9 5354.0 4954.0 5015.2 5071.8 5074.9 5247.0 4113.7 4122.6 4138.5 4146.9 4170.2 4128.9 4157.9 4164.1 4182.2 4207.3 3975.3 4003.6 4045.8 4073.6 4109.1 4086.5 4094.1 4095.8 4111.4 4125.1 3689.8 3692.8 3694.6 3702.4 3711.8 4962.6 5014.7 5045.8 5186.3 5198.9 4637.5 4660.3 4671.4 4676.0 4682.6 5383.4 5409.8 5417.3 5425.9 5429.9 3913.6 3954.8 3982.0 4003.0 4004.9 5605.7 5607.7 5612.0 5632.8 5639.8 4097.9 4100.0 4101.2 4113.7 4114.7 4046.4 4094.5 4158.0 4165.2 4169.9 4607.6 4608.5 4636.0 4659.6 4686.2 5414.4 5425.9 5447.2 5461.6 5470.3 1313.4 1363.8 1377.2 1390.3 1391.5 919.1 929.9 941.2 942.9 946.3 5160.8 5183.9 5198.9 5211.6 5261.8 5057.8 5395.4 5431.8 5446.2 5468.9 5075.8 5087.8 5093.0 5095.5 5105.8 2860.7 2866.3 2867.4 2873.4 2882.6 5503.7 5580.6 5593.6 5803.6 5879.9 5728.0 5744.7 5750.7 5785.7 5800.4 5677.0 5850.1 5879.6 5885.0 5935.4 5641.3 5661.8 5674.5 5692.6 5695.4 5560.0 5587.5 5599.4 5607.5 5648.0 5583.4 5785.5 5820.7 5845.7 5883.9 4155.8 4166.1 4173.7 4183.2 4193.5 5441.7 5558.2 5583.8 5611.9 5637.7 5500.4 5501.4 5503.8 5512.4 5527.2 5272.1 5494.0 5509.3 5521.4 5531.8 5433.6 5473.4 5489.8 5500.6 5508.4 5549.9 5550.9 5553.6 5554.3 5558.9 5220.2 5386.7 5426.0 5448.7 5510.4 10:33:11 INFO - PROCESS | 3463 | 10:33:11 INFO - PROCESS | 3463 | [#5] yui.html Cycles:180 Average:18082.39 Median:4331.74 stddev:23567.08 (544.1%) stddev-sans-first:23597.05 10:33:11 INFO - PROCESS | 3463 | Values: 698.9 723.3 724.1 787.8 791.5 15271.6 15713.3 15749.3 15752.4 15809.6 14566.6 14701.1 14727.0 14727.0 14727.2 652.0 675.4 761.4 777.9 782.1 788.4 800.1 800.5 801.1 801.3 844.2 844.6 844.9 845.3 846.3 695.3 716.4 812.9 842.7 843.1 610.9 617.9 618.4 618.5 618.7 14922.5 14932.4 14946.0 14977.1 14980.5 14194.4 14447.3 14506.6 14535.6 14563.4 12422.8 12766.4 12954.9 13076.1 13100.1 4293.2 4295.0 4301.5 4326.9 4381.9 87055.7 88164.6 88957.0 90208.0 90791.6 9780.9 10021.3 10054.5 11538.3 11610.7 20762.9 21108.4 21117.0 21118.9 21135.3 7541.2 7546.4 7607.2 7740.4 7976.4 4292.0 4298.6 4336.6 4345.5 4399.8 3220.3 3323.4 3332.5 3703.7 3853.2 616.1 622.3 625.0 637.5 643.8 570.8 638.9 642.7 683.3 726.8 9430.8 10061.3 10109.6 10301.9 10442.5 606.6 625.7 681.6 691.0 727.7 4590.1 4643.6 4734.1 4739.6 4762.1 69008.3 70652.0 71796.6 84536.0 86219.0 63924.7 71027.0 71496.0 71761.0 72039.0 63129.7 65188.3 66280.3 66469.0 67103.0 9534.6 10190.6 10281.8 10339.6 10458.1 41451.0 42855.8 42872.6 44094.0 44378.8 54712.5 55741.7 61283.0 62395.0 64399.0 12718.3 12921.6 12943.7 13015.9 13062.5 14138.6 14210.5 14244.9 14531.4 15192.3 14083.9 14118.3 14170.9 14563.0 14799.9 13068.1 13277.8 13296.4 13511.1 13537.6 12876.5 13183.2 13353.7 13449.0 13903.7 11281.7 11447.7 11739.6 12134.8 12162.8 10084.7 10669.9 11716.4 11954.7 12094.0 10:33:11 INFO - PROCESS | 3463 | -------- Summary: end -------- 10:33:11 INFO - PROCESS | 3463 | 10:33:12 INFO - TEST-INFO | 3463: exit 0 10:33:12 INFO - TEST-OK | dromaeo_css | took 1119633ms 10:33:12 INFO - TEST-START | kraken 10:33:12 INFO - operating with platform_type : linux_ 10:33:12 INFO - Initialising browser for kraken test... 10:33:12 INFO - TEST-INFO | started process 3773 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7BxnUv/profile http://localhost:36899/getInfo.html) 10:33:16 INFO - PROCESS | 3773 | __metrics Screen width/height:1600/1200 10:33:16 INFO - PROCESS | 3773 | colorDepth:24 10:33:16 INFO - PROCESS | 3773 | Browser inner width/height: 1024/697 10:33:16 INFO - PROCESS | 3773 | __metrics 10:33:17 INFO - PROCESS | 3773 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:33:17 INFO - PROCESS | 3773 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:33:18 INFO - PROCESS | 3773 | console.error: PushService: 10:33:18 INFO - PROCESS | 3773 | stateChangeProcessEnqueue: Error transitioning state 10:33:18 INFO - PROCESS | 3773 | UnknownError 10:33:18 INFO - TEST-INFO | 3773: exit 0 10:33:18 INFO - Browser initialized. 10:33:18 INFO - Running cycle 1/1 for kraken test... 10:33:18 INFO - TEST-INFO | started process 3859 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7BxnUv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:33:30 INFO - PROCESS | 3859 | RSS: Main: 173252608 10:33:30 INFO - PROCESS | 3859 | 10:33:33 INFO - PROCESS | 3859 | Cycle 1(1): loaded http://localhost:36899/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36899/tests/kraken/driver.html?testName=audio-beat-detection) 10:33:34 INFO - PROCESS | 3859 | RSS: Main: 234541056 10:33:34 INFO - PROCESS | 3859 | 10:33:36 INFO - PROCESS | 3859 | Cycle 1(1): loaded http://localhost:36899/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36899/tests/kraken/driver.html?testName=audio-dft) 10:33:37 INFO - PROCESS | 3859 | RSS: Main: 217059328 10:33:37 INFO - PROCESS | 3859 | 10:33:40 INFO - PROCESS | 3859 | Cycle 1(1): loaded http://localhost:36899/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36899/tests/kraken/driver.html?testName=audio-fft) 10:33:41 INFO - PROCESS | 3859 | RSS: Main: 298123264 10:33:41 INFO - PROCESS | 3859 | 10:33:43 INFO - PROCESS | 3859 | Cycle 1(1): loaded http://localhost:36899/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36899/tests/kraken/driver.html?testName=audio-oscillator) 10:33:43 INFO - PROCESS | 3859 | RSS: Main: 210227200 10:33:43 INFO - PROCESS | 3859 | 10:33:46 INFO - PROCESS | 3859 | Cycle 1(1): loaded http://localhost:36899/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36899/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:33:46 INFO - PROCESS | 3859 | RSS: Main: 214016000 10:33:46 INFO - PROCESS | 3859 | 10:33:49 INFO - PROCESS | 3859 | Cycle 1(1): loaded http://localhost:36899/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36899/tests/kraken/driver.html?testName=imaging-darkroom) 10:33:50 INFO - PROCESS | 3859 | RSS: Main: 253173760 10:33:50 INFO - PROCESS | 3859 | 10:33:53 INFO - PROCESS | 3859 | Cycle 1(1): loaded http://localhost:36899/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36899/tests/kraken/driver.html?testName=imaging-desaturate) 10:33:54 INFO - PROCESS | 3859 | RSS: Main: 252817408 10:33:54 INFO - PROCESS | 3859 | 10:33:56 INFO - PROCESS | 3859 | Cycle 1(1): loaded http://localhost:36899/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36899/tests/kraken/driver.html?testName=json-parse-financial) 10:33:57 INFO - PROCESS | 3859 | RSS: Main: 252071936 10:33:57 INFO - PROCESS | 3859 | 10:33:59 INFO - PROCESS | 3859 | Cycle 1(1): loaded http://localhost:36899/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36899/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:33:59 INFO - PROCESS | 3859 | RSS: Main: 214392832 10:33:59 INFO - PROCESS | 3859 | 10:34:01 INFO - PROCESS | 3859 | Cycle 1(1): loaded http://localhost:36899/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36899/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:34:02 INFO - PROCESS | 3859 | RSS: Main: 220184576 10:34:02 INFO - PROCESS | 3859 | 10:34:04 INFO - PROCESS | 3859 | Cycle 1(1): loaded http://localhost:36899/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36899/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:34:04 INFO - PROCESS | 3859 | RSS: Main: 230158336 10:34:04 INFO - PROCESS | 3859 | 10:34:07 INFO - PROCESS | 3859 | Cycle 1(1): loaded http://localhost:36899/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36899/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:34:08 INFO - PROCESS | 3859 | RSS: Main: 237998080 10:34:08 INFO - PROCESS | 3859 | 10:34:10 INFO - PROCESS | 3859 | Cycle 1(1): loaded http://localhost:36899/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36899/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:34:11 INFO - PROCESS | 3859 | RSS: Main: 235655168 10:34:11 INFO - PROCESS | 3859 | 10:34:13 INFO - PROCESS | 3859 | Cycle 1(1): loaded http://localhost:36899/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36899/tests/kraken/driver.html?testName=ai-astar) 10:34:13 INFO - PROCESS | 3859 | RSS: Main: 287875072 10:34:13 INFO - PROCESS | 3859 | 10:34:13 INFO - PROCESS | 3859 | __start_tp_report 10:34:13 INFO - PROCESS | 3859 | _x_x_mozilla_page_load 10:34:13 INFO - PROCESS | 3859 | _x_x_mozilla_page_load_details 10:34:13 INFO - PROCESS | 3859 | |i|pagename|runs| 10:34:13 INFO - PROCESS | 3859 | |0;ai-astar;104;112;111;113;114;110;111;111;110;112 10:34:13 INFO - PROCESS | 3859 | |1;audio-beat-detection;151;125;125;172;123;122;122;123;148;123 10:34:13 INFO - PROCESS | 3859 | |2;audio-dft;161;161;161;160;160;161;163;162;161;161 10:34:13 INFO - PROCESS | 3859 | |3;audio-fft;75;76;75;109;77;77;76;75;105;75 10:34:13 INFO - PROCESS | 3859 | |4;audio-oscillator;82;82;112;88;81;81;99;82;82;107 10:34:13 INFO - PROCESS | 3859 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;117;117;117 10:34:13 INFO - PROCESS | 3859 | |6;imaging-darkroom;146;146;146;146;146;148;147;145;146;146 10:34:13 INFO - PROCESS | 3859 | |7;imaging-desaturate;95;95;95;96;95;95;95;95;95;95 10:34:13 INFO - PROCESS | 3859 | |8;json-parse-financial;52;51;52;51;52;53;52;51;52;52 10:34:13 INFO - PROCESS | 3859 | |9;json-stringify-tinderbox;63;63;64;63;65;63;64;64;64;65 10:34:13 INFO - PROCESS | 3859 | |10;stanford-crypto-aes;81;82;80;80;81;79;81;87;83;81 10:34:13 INFO - PROCESS | 3859 | |11;stanford-crypto-ccm;133;140;136;131;131;133;133;140;179;139 10:34:13 INFO - PROCESS | 3859 | |12;stanford-crypto-pbkdf2;172;172;167;169;166;169;166;167;172;170 10:34:13 INFO - PROCESS | 3859 | |13;stanford-crypto-sha256-iterative;64;67;65;65;66;81;65;67;70;64 10:34:13 INFO - PROCESS | 3859 | __end_tp_report 10:34:13 INFO - PROCESS | 3859 | __start_cc_report 10:34:13 INFO - PROCESS | 3859 | _x_x_mozilla_cycle_collect,1679 10:34:13 INFO - PROCESS | 3859 | __end_cc_report 10:34:13 INFO - PROCESS | 3859 | __startTimestamp1480271653498__endTimestamp 10:34:13 INFO - PROCESS | 3859 | 10:34:13 INFO - PROCESS | 3859 | ------- Summary: start ------- 10:34:13 INFO - PROCESS | 3859 | Number of tests: 14 10:34:13 INFO - PROCESS | 3859 | 10:34:13 INFO - PROCESS | 3859 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.50 stddev:2.70 (2.4%) stddev-sans-first:1.33 10:34:13 INFO - PROCESS | 3859 | Values: 104.0 112.0 111.0 113.0 114.0 110.0 111.0 111.0 110.0 112.0 10:34:13 INFO - PROCESS | 3859 | 10:34:13 INFO - PROCESS | 3859 | [#1] audio-beat-detection Cycles:10 Average:133.40 Median:125.00 stddev:17.44 (14.0%) stddev-sans-first:17.30 10:34:13 INFO - PROCESS | 3859 | Values: 151.0 125.0 125.0 172.0 123.0 122.0 122.0 123.0 148.0 123.0 10:34:13 INFO - PROCESS | 3859 | 10:34:13 INFO - PROCESS | 3859 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 10:34:13 INFO - PROCESS | 3859 | Values: 161.0 161.0 161.0 160.0 160.0 161.0 163.0 162.0 161.0 161.0 10:34:13 INFO - PROCESS | 3859 | 10:34:13 INFO - PROCESS | 3859 | [#3] audio-fft Cycles:10 Average:82.00 Median:75.50 stddev:13.23 (17.5%) stddev-sans-first:13.79 10:34:13 INFO - PROCESS | 3859 | Values: 75.0 76.0 75.0 109.0 77.0 77.0 76.0 75.0 105.0 75.0 10:34:13 INFO - PROCESS | 3859 | 10:34:13 INFO - PROCESS | 3859 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:82.00 stddev:11.90 (14.5%) stddev-sans-first:12.30 10:34:13 INFO - PROCESS | 3859 | Values: 82.0 82.0 112.0 88.0 81.0 81.0 99.0 82.0 82.0 107.0 10:34:13 INFO - PROCESS | 3859 | 10:34:13 INFO - PROCESS | 3859 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:34:13 INFO - PROCESS | 3859 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 10:34:13 INFO - PROCESS | 3859 | 10:34:13 INFO - PROCESS | 3859 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 10:34:13 INFO - PROCESS | 3859 | Values: 146.0 146.0 146.0 146.0 146.0 148.0 147.0 145.0 146.0 146.0 10:34:13 INFO - PROCESS | 3859 | 10:34:13 INFO - PROCESS | 3859 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:34:13 INFO - PROCESS | 3859 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 10:34:13 INFO - PROCESS | 3859 | 10:34:13 INFO - PROCESS | 3859 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.00 stddev:0.63 (1.2%) stddev-sans-first:0.67 10:34:13 INFO - PROCESS | 3859 | Values: 52.0 51.0 52.0 51.0 52.0 53.0 52.0 51.0 52.0 52.0 10:34:13 INFO - PROCESS | 3859 | 10:34:13 INFO - PROCESS | 3859 | [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:64.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 10:34:13 INFO - PROCESS | 3859 | Values: 63.0 63.0 64.0 63.0 65.0 63.0 64.0 64.0 64.0 65.0 10:34:13 INFO - PROCESS | 3859 | 10:34:13 INFO - PROCESS | 3859 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:81.00 stddev:2.22 (2.7%) stddev-sans-first:2.35 10:34:13 INFO - PROCESS | 3859 | Values: 81.0 82.0 80.0 80.0 81.0 79.0 81.0 87.0 83.0 81.0 10:34:13 INFO - PROCESS | 3859 | 10:34:13 INFO - PROCESS | 3859 | [#11] stanford-crypto-ccm Cycles:10 Average:139.50 Median:137.50 stddev:14.32 (10.4%) stddev-sans-first:14.99 10:34:13 INFO - PROCESS | 3859 | Values: 133.0 140.0 136.0 131.0 131.0 133.0 133.0 140.0 179.0 139.0 10:34:13 INFO - PROCESS | 3859 | 10:34:13 INFO - PROCESS | 3859 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:169.50 stddev:2.45 (1.4%) stddev-sans-first:2.35 10:34:13 INFO - PROCESS | 3859 | Values: 172.0 172.0 167.0 169.0 166.0 169.0 166.0 167.0 172.0 170.0 10:34:13 INFO - PROCESS | 3859 | 10:34:13 INFO - PROCESS | 3859 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:66.50 stddev:5.10 (7.7%) stddev-sans-first:5.26 10:34:13 INFO - PROCESS | 3859 | Values: 64.0 67.0 65.0 65.0 66.0 81.0 65.0 67.0 70.0 64.0 10:34:13 INFO - PROCESS | 3859 | -------- Summary: end -------- 10:34:13 INFO - PROCESS | 3859 | 10:34:14 INFO - TEST-INFO | 3859: exit 0 10:34:14 INFO - TEST-OK | kraken | took 61898ms 10:34:14 INFO - SUITE-END | took 1181s 10:34:15 INFO - Completed test suite (00:19:41) 10:34:15 INFO - javascript benchmark 10:34:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3121.0480803354976, 3160.3837251735913, 3167.3348596794685, 3180.093673303109, 3211.8554665040087, 5261.210818377236, 5339.866503337409, 5410.48600382964, 5505.0366185917455, 5522.861928451785, 5330.200469929512, 5450.56395488361, 5508.366537848148, 5518.310211223597, 5610.635308704931, 4904.60763138948, 4982.676126051795, 5008.9499105008845, 5010.849674509771, 5021.774020169101, 4937.358143441347, 4967.627427942901, 4994.450610432849, 5018.498150184989, 5131.589472842183, 5057.949420505803, 5078.289039534449, 5080.898382032357, 5107.233914912756, 5121.5390614844655, 4799.6400269979895, 4823.421189457253, 4853.102176097434, 4998.40019197695, 5048.545630893201, 4853.466118726938, 4877.51224877513, 4896.828610998634, 4900.044491324194, 4935.383077115361, 5351.143816989263, 5374.435684253136, 5389.622726409153, 5405.864853378657, 5417.59368047398, 5640.351359593658, 5673.8581535461535, 5778.42215778423, 5780.450857168562, 5785.045467497858, 5897.7935772247765, 5926.259217597801, 5940.851478713023, 5961.910571341434, 5984.640921544721, 5515.806946756844, 5518.53092487135, 5519.0, 5519.116941289374, 5521.723913804293, 5834.154047663065, 5885.588008839341, 5994.610350327215, 5994.910076348859, 6005.159277701126, 5743.684097374601, 5786.94213057864, 5800.8259752207505, 5829.533637309005, 5888.676122813201, 5871.266091738533, 5909.438603332676, 5912.615679980788, 5919.585629005928, 5927.170196172539, 5558.916616250759, 5857.88284234313, 5898.941010589925, 5913.822585322448, 5918.556108291896, 5686.943130568724, 5702.657840529499, 5710.5717071219, 5712.457316555004, 5716.228309178207, 4456.888577785517, 4470.195364834296, 4470.642348612103, 4471.977640111779, 4477.955220447754, 4039.333509970822, 4043.6158564936286, 4044.170944956277, 4046.0289530512464, 4048.8987775305263, 5428.077226871442, 5467.644603100785, 5477.917831232535, 5480.369757477862, 5486.780528778804, 5806.535477161817, 5807.477327040587, 5810.680412577264, 5811.041178205549, 5819.127130930395, 5487.451254874481, 5488.1493368527945, 5491.258680078218, 5492.093804522209, 5492.340919089735, 5000.874978125576, 5005.524475174852, 5013.348264725562, 5053.267276244997, 5055.772490237948, 6028.517718582503, 6038.698065096728, 6041.848953776191, 6051.183090282843, 6051.909221361683, 5594.41258667834, 5605.943940560543, 5838.766449342149, 5857.238558987305, 5879.0, 6093.806546925568, 6122.672617327995, 6125.327021303102, 6125.449118208525, 6131.162586540493, 5785.623934444247, 5788.565857560784, 5789.913151302818, 5794.0, 5842.853928651818, 5661.801836935688, 5713.885722285614, 5802.332731735904, 5881.441263080001, 5887.1757953885635, 5630.239917611234, 5756.107803290497, 5764.942350576608, 5780.421957804186, 5812.3025236971835, 5753.884922301447, 5762.855928601818, 5763.769449221984, 5768.480836724547, 5769.307683078057, 5456.727163641882, 5482.451754824486, 5705.144228365778, 5742.28221472316, 5743.942560574341, 5646.943530564642, 5654.3497497788285, 5659.0, 5661.348944871393, 5667.319921609434, 5502.257195278747, 5536.944630553643, 5539.833804985857, 5540.63985840919, 5549.889002220014], "value": 5379.529037534004, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.7024414168421, 581.8399940016496, 598.9550783691225, 628.7139351595025, 647.3494138390917, 31154.0, 33581.0, 40046.59953400469, 41143.382849257214, 41148.38277425834, 42059.57940420595, 42430.0, 42457.57542424575, 42466.36300455488, 42533.361999569956, 8361.623726932288, 8519.914800852006, 8525.44584601999, 8529.232369086782, 8534.1039190885, 7949.880751788728, 8121.228483294078, 8130.186981301882, 8257.793555161139, 8331.750047498585, 10041.497925103753, 10279.383237005766, 10286.485675716222, 10575.576976920915, 10589.682309530726, 10134.949325253363, 10197.337173083726, 10206.438645874474, 10220.948895255477, 10225.0, 10030.498475076218, 10092.0, 10101.69694909154, 10117.443540605263, 10122.0, 39779.8011009946, 40060.59939400598, 40083.39874901879, 40093.79953100245, 40130.39804402936, 3322.1362445764034, 3335.8832440864694, 3353.84907679155, 3382.4757162639585, 3813.2564149990762, 30035.0, 30619.23451913698, 30641.387172256655, 30706.38587228265, 30725.385492290254, 4026.335654616985, 4074.9388759168637, 4128.071183983609, 4153.709240353177, 4285.8499952501825, 328811.0, 329674.0, 330185.0, 330322.0, 330589.0, 53244.0, 53591.0, 53602.463975359744, 53625.463745362824, 53642.73178634082, 54829.88775841828, 55342.72328638331, 55781.44218557844, 55890.0, 55979.0, 13431.059825812295, 13572.728545429036, 13582.0, 13582.93208533951, 13589.252591107585, 10491.737706557396, 10535.315204511682, 10558.04977552024, 10564.313319634199, 10565.366078035342, 13961.371738271599, 14337.498187563386, 15094.924525377523, 15430.768538471932, 15524.37902483888, 5909.303692194246, 6109.84725381869, 6171.876562468726, 6235.314115447297, 6298.842528936813, 916.3310783128354, 998.83519219328, 1013.2096964367657, 1020.3520764314713, 1125.7129431994788, 30182.54726179109, 30458.54312185319, 30548.54177187344, 30653.693463065083, 31007.0, 1041.614602597044, 1052.153016821466, 1068.4497483795851, 1077.3374374759467, 1079.83262594298, 16031.839681603034, 16241.756373654405, 16315.428959986344, 16382.344706211856, 16559.25483353252, 460605.0, 465309.0, 465722.0, 466105.0, 467007.0, 47487.0, 48621.270680939815, 51270.0, 52235.21647175295, 52670.47329526656, 1296.623979046066, 1308.4700696218047, 1320.3728229091105, 1324.6886981559326, 1339.0225135651028, 29717.85141074281, 31841.840790795897, 32074.67925320717, 32199.456335382132, 32333.51499727459, 47514.28728569005, 47963.28055079107, 47963.76018120027, 48012.27981580349, 48041.0, 259252.0, 259477.0, 259635.0, 259648.0, 260129.0, 37247.55048990159, 37796.0, 38198.80900595479, 38328.6167138325, 38493.80753096216, 43412.78293608512, 43823.0, 43983.12033759371, 44048.0, 45546.0, 37549.0, 37828.62171378251, 38074.23851523009, 38257.80871095738, 38367.232655347296, 37005.94193990043, 37659.610635042976, 38249.808750956065, 38879.80560097181, 39150.21699565936, 37718.43422348612, 38119.80940095282, 38223.0, 38269.80865095768, 38329.61670383372, 32039.359212816078, 34033.19995404163, 34422.655773442944, 34582.30835383329, 34821.1294717624, 25476.872615636803, 26250.60624090602, 26269.605955910294, 26307.736922631295, 26726.19821405361], "value": 18875.001606750156, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.69005570404425, 398.56158225951475, 407.7675724836843, 409.08773435239414, 417.3072699319131, 13457.932710336447, 15429.228538573083, 18530.3514376997, 19051.0, 19265.32571360003, 18947.621047579076, 18962.146703398346, 19323.90338048308, 19496.122674479648, 19527.316543920966, 4640.883977900546, 5480.177973304007, 5697.430256974311, 5710.914336284959, 5714.828555143332, 6067.605605635642, 6282.4974002079725, 6314.0, 6319.273283572379, 6323.430891219789, 6086.391360863922, 6267.937320626804, 6289.968550157266, 6297.4017468340435, 6307.558470907038, 6203.782867599635, 6233.563650544464, 6234.470070044052, 6243.157173781527, 6246.718897649616, 5369.248305237231, 5570.610057295991, 5602.859928501779, 5607.383187849333, 5616.129499927518, 22797.43006424836, 22952.31143065694, 22974.0, 23085.307440776804, 23107.191248306397, 2221.144859229192, 2221.466847956495, 2242.7532971373134, 2276.3398614401804, 2452.0069371904406, 9907.851382229272, 10331.121854642364, 10462.895371046345, 10548.419836908966, 10770.4614769262, 1861.1345724238295, 1863.3292014874635, 1870.532366908273, 1881.0876724788466, 1916.597514521952, 80670.59664701698, 82736.0, 83845.58077209575, 84217.57891210505, 84320.0, 10935.179861510418, 11054.502547385388, 11136.777264454666, 11204.551817927191, 11251.493682784294, 15756.369745210062, 15791.052536847827, 15795.0, 15825.366985320688, 15836.208189590474, 6907.965460172667, 7175.784726458214, 7613.5431874087735, 7731.110922243902, 7858.764237072897, 7002.474814388839, 7069.798134317179, 7072.115985501812, 7270.854582908312, 7281.0, 4759.333693282943, 4773.498782627844, 4786.234202527578, 4813.638977076734, 4945.530174633404, 1949.6588097083238, 1982.5043739065234, 2019.202415046078, 2041.428400047989, 2042.5914817036653, 863.7279257034014, 985.019905194322, 989.5893204320271, 989.737719504332, 997.1474389396961, 17918.820811791717, 18849.246030158913, 19432.902835485733, 19441.708374374397, 19502.902485487764, 941.1648030149037, 941.755143662639, 962.0956301076965, 975.3855071305032, 1049.559185142242, 10281.331713438603, 10881.727956801144, 10883.401412922207, 10893.83659245112, 11001.834972475419, 415617.0, 432148.0, 439121.0, 439353.0, 443312.0, 92332.0, 93432.53283733538, 94133.0, 95395.0, 95411.0, 976.0337266106503, 988.3773222869546, 992.4541502173776, 1005.9044390782864, 1010.5452546354023, 14775.92612036933, 16192.190390480193, 17342.566435839206, 17417.216225270146, 17558.385456509473, 42004.3699344504, 42175.57824421716, 42326.576734232265, 42940.35589466223, 44458.777706111265, 56276.71861640666, 57152.714236428554, 57814.7109264451, 58554.414455854894, 59195.704021479614, 8273.048599411144, 8400.159984001551, 8424.315136972507, 8435.367347448842, 8645.654173832976, 9830.508474576385, 12561.309127998047, 12925.741485170432, 13011.21932684004, 13163.407646656115, 11141.665750027512, 11354.432278385882, 11460.312381257152, 11594.0, 11998.64004079879, 11035.39305338214, 11066.170037247399, 11130.10959123252, 11147.108231341312, 11407.25852819564, 11625.534978600761, 11671.416429178338, 11701.186316121015, 11747.588834390755, 11797.76404471923, 8657.567121643766, 8725.127487251479, 8846.867296990678, 8907.376483646083, 8927.910720892707, 10604.734881628021, 11558.653240402802, 11560.248583842023, 11575.942120289345, 11908.880911191123], "value": 9135.16698340647, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1296.1704509114163, 1432.4413478743286, 1467.2077078377674, 1592.3710134496873, 1730.3338214787302, 7147.32100450457, 8032.317253033492, 8259.95870020649, 8315.0, 8493.065762766106, 8303.878976338192, 8389.328853691706, 8389.412741108124, 8390.328773698106, 8394.118617545162, 1942.3881477334664, 1997.8401727861808, 1999.7000449932482, 2190.211523851412, 2223.5330580578097, 2034.52188735647, 2052.230413594902, 2125.08621292844, 2128.8722676639372, 2143.239150101715, 2205.3935167828813, 2218.279059305724, 2220.955580888381, 2229.9554008919813, 2230.5761905237955, 2154.235246487498, 2213.347062616532, 2215.9667604985775, 2220.4781876259067, 2225.2990308052913, 2103.5582527669208, 2105.8525903186783, 2108.1778106538463, 2220.6668999650183, 2239.9888000560054, 8369.58152092393, 8479.533625650587, 8490.915090849074, 8494.235518803276, 8498.447600905922, 5051.217061355495, 5173.793048278064, 5197.688138711652, 5199.376074871039, 5199.610029247821, 3039.696030396965, 3272.541844141822, 3308.123347312964, 3310.933781324384, 3387.762856600039, 965.1506674126794, 1002.0330381182122, 1005.1305620638095, 1013.751630850439, 1060.294903888913, 11559.190856640038, 11598.652040438801, 11611.76776464466, 11615.593454229062, 11649.76700465986, 4322.243607368698, 4593.333966574828, 4646.976765116153, 4680.251159814414, 4693.48371679115, 9778.559964801601, 9806.313558050868, 9808.950955245178, 9814.705558833246, 9816.607335706634, 5193.480651934852, 5198.740062996835, 5204.947950520522, 5252.947470525322, 5263.5525980292105, 4587.931181032287, 4764.094821983812, 4772.49888761682, 4779.115863565252, 4809.615230781529, 3593.6047034826147, 3699.463577781207, 3717.070732316921, 3732.552093748713, 3781.054736315921, 1130.4121856634667, 1132.416805345248, 1146.744314975101, 1171.4260012593938, 1171.5782318365382, 823.1932705948204, 931.771715929588, 932.7015355086443, 940.0787228516092, 960.6829746183743, 5893.941060589339, 5910.261217347832, 6098.35967223444, 6131.202943617391, 6323.114763933053, 941.7374459842105, 955.1546881010356, 972.7276362618478, 993.5429702337005, 1009.7526106103904, 4054.108096218827, 4055.168690418457, 4065.3698676705158, 4073.409355643415, 4234.7670878102, 10055.648052318134, 10218.948905255575, 10287.691369258935, 10346.53440595175, 10387.896121038693, 10246.897531024744, 10251.642122311761, 10264.281500295057, 10282.742931426774, 10304.0, 7498.550086994689, 7932.920670793334, 8058.194180581895, 8066.475679080841, 8078.515289082674, 5970.164177015308, 6012.3386427493815, 6120.510359171167, 6139.662318572521, 6188.4739797117745, 9423.811523769624, 9495.810083798147, 9561.474118923526, 9566.856497152687, 9628.807423851344, 9589.232861370934, 9738.902610974083, 9813.067758562926, 9824.852627210455, 9836.016398360392, 6645.933540664725, 6700.329967003261, 7283.271672832674, 7312.232215617496, 7455.552666840007, 7808.336291415293, 8251.711190108317, 8309.916900831156, 8331.833363332578, 8332.04181519133, 7381.188069312479, 7382.114146302478, 7403.18564957865, 7413.443991700537, 7441.776746697607, 7096.7516136934955, 7120.145582530129, 7206.819829504304, 7214.458915581457, 7222.819429514304, 6724.697388617426, 6775.898361524482, 6801.863962720817, 6820.35206655367, 6847.144106986627, 5076.974615126901, 5088.414832294334, 5147.510986456281, 5174.327337446259, 5262.657927234717, 5080.110980578458, 5315.282436870973, 5319.840404787863, 5337.919931200958, 5419.972900135474], "value": 4451.86528168835, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.51159914923085, 337.2984192878811, 342.83886573310537, 346.67239458711515, 349.32754447688194, 5266.157414813631, 5292.353823088456, 5295.338082739658, 5299.867503312419, 5354.0, 4954.027583449928, 5015.172496538076, 5071.84784456466, 5074.873128171788, 5247.0, 4113.712040157183, 4122.587741225883, 4138.544315496564, 4146.937795933063, 4170.228507726065, 4128.917421651565, 4157.8544750933725, 4164.12553363794, 4182.205380977604, 4207.26372884744, 3975.284448799215, 4003.5996400359877, 4045.757254564721, 4073.63337299643, 4109.075458021951, 4086.468759061318, 4094.1402305515876, 4095.8361665533344, 4111.444954931076, 4125.092479654471, 3689.7786132832116, 3692.7599706019023, 3694.5751238607636, 3702.407614781649, 3711.758735682172, 4962.553370196663, 5014.749262536859, 5045.84862454127, 5186.273921650972, 5198.908229271858, 4637.515994881605, 4660.347551342815, 4671.369365135697, 4675.95324046762, 4682.578567928868, 5383.380911195223, 5409.83770486886, 5417.26866872975, 5425.914817036609, 5429.864253393657, 3913.6086391360923, 3954.8220330085214, 3982.0, 4003.0, 4004.8586152946564, 5605.663660180361, 5607.691576963265, 5612.0, 5632.7746890124345, 5639.774409023634, 4097.938530922039, 4099.97950010248, 4101.159262351211, 4113.650339721157, 4114.691398145151, 4046.352583586612, 4094.5086589609436, 4158.043649960526, 4165.187788381297, 4169.937450938239, 4607.585317321457, 4608.493065762764, 4636.003259299199, 4659.603933665609, 4686.156491831503, 5414.35027796667, 5425.9186112208345, 5447.237386765856, 5461.563074953994, 5470.288862447856, 1313.382710126239, 1363.7613417651871, 1377.2218696436482, 1390.332640332646, 1391.5199256256576, 919.0928822692805, 929.9256059515222, 941.2140862379853, 942.8585712143097, 946.2997381937316, 5160.793568257228, 5183.870403239874, 5198.92201616976, 5211.635185537052, 5261.842144735664, 5057.848264552069, 5395.352557693023, 5431.83704488866, 5446.2375267462585, 5468.945310546923, 5075.832558511563, 5087.847364579068, 5093.0, 5095.515925987025, 5105.821296254613, 2860.6567211934703, 2866.3407416293953, 2867.3978464522684, 2873.353495463504, 2882.553204253344, 5503.724813759296, 5580.609357345028, 5593.608447408724, 5803.593748437654, 5879.911801322984, 5728.0, 5744.673407270062, 5750.712464376765, 5785.71071446426, 5800.419958004166, 5676.971615141898, 5850.12248162779, 5879.559033072536, 5884.970575147183, 5935.376785437467, 5641.323041235078, 5661.773529058792, 5674.517665998436, 5692.6299790513485, 5695.401982791913, 5559.971405290034, 5587.525060369914, 5599.356074051373, 5607.467290607386, 5648.039833228443, 5583.413741557078, 5785.479306862402, 5820.70896455184, 5845.743165219498, 5883.882322353615, 4155.812988415468, 4166.145940082215, 4173.728707633994, 4183.184279065553, 4193.475815523059, 5441.673499590037, 5558.24963629921, 5583.804566840141, 5611.943880561305, 5637.689927053887, 5500.449955004628, 5501.449855014466, 5503.780288531254, 5512.3660779010925, 5527.198556209408, 5272.124988133642, 5494.0, 5509.338879334506, 5521.420250873761, 5531.751071201725, 5433.565314774887, 5473.397926228191, 5489.752961116839, 5500.642458240201, 5508.394076651645, 5549.861253468695, 5550.916736249041, 5553.611247212656, 5554.305711786027, 5558.861028474159, 5220.216967454912, 5386.730663466889, 5426.0, 5448.727563621882, 5510.3938566758425], "value": 4189.5098726458355, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.8776964031293, 723.2839488905985, 724.1418918581481, 787.8227398835267, 791.4855344026382, 15271.618209544768, 15713.292901819417, 15749.291281892314, 15752.369905203777, 15809.60475988101, 14566.635834104152, 14701.117932924031, 14727.0, 14727.0, 14727.190004549746, 651.9608823470584, 675.3988949834651, 761.375671949002, 777.8833175023764, 782.1279273609941, 788.3850596534684, 800.087899794235, 800.5116878703986, 801.1187693537121, 801.2548330053048, 844.1811442900407, 844.5777111444278, 844.932405407569, 845.344857735254, 846.3313981954249, 695.3429009585943, 716.3839098375445, 812.9349652027823, 842.692417267696, 843.0768308701962, 610.9053096770008, 617.9042248451498, 618.4001518527022, 618.5484596244767, 618.6875627807973, 14922.477713279983, 14932.402703891832, 14946.0, 14977.1013739176, 14980.475683351031, 14194.361253743606, 14447.349869255908, 14506.56480305582, 14535.624676410946, 14563.417463301455, 12422.81365779514, 12766.36168191596, 12954.870451295461, 13076.08467407282, 13100.148490348098, 4293.162833247518, 4295.0, 4301.483821941387, 4326.870193894189, 4381.890452738675, 87055.69416458758, 88164.5591772037, 88957.0, 90208.0, 90791.63812542817, 9780.902190978142, 10021.29850910444, 10054.547545360476, 11538.307701537935, 11610.6516804496, 20762.896185518977, 21108.366748997247, 21117.0, 21118.894405528183, 21135.26026589062, 7541.208173141851, 7546.396288296923, 7607.239276072349, 7740.4194685398825, 7976.441649084509, 4291.9785401072795, 4298.634616057608, 4336.609705126553, 4345.500267469219, 4399.824007039682, 3220.323732016256, 3323.4017876781927, 3332.4501457259767, 3703.7407381483035, 3853.2100919311474, 616.1035693066577, 622.2688341199073, 625.0499241153422, 637.4963778614842, 643.810076027573, 570.7802496039055, 638.9488840892717, 642.6561789442626, 683.3190351734788, 726.8110291324293, 9430.811383772287, 10061.346012509164, 10109.64616238428, 10301.9484902575, 10442.530086146142, 606.6269244414653, 625.7497001199556, 681.6353251010686, 690.9723611055603, 727.6689106456549, 4590.104929538775, 4643.628509719214, 4734.076855013308, 4739.597134243628, 4762.119007983534, 69008.3099169012, 70652.0, 71796.64101679459, 84536.0, 86219.0, 63924.68037659782, 71027.0, 71496.0, 71761.0, 72039.0, 63129.68435157795, 65188.34811651918, 66280.33719662837, 66469.0, 67103.0, 9534.618615255313, 10190.643327483798, 10281.794364112826, 10339.586416543554, 10458.111060559937, 41451.0, 42855.785721071195, 42872.571274286856, 44094.0, 44378.77810610926, 54712.452875470735, 55741.721291394904, 61283.0, 62395.0, 64399.03401449076, 12718.300493472578, 12921.612351629467, 12943.741125177632, 13015.934920325337, 13062.477500899857, 14138.575842724735, 14210.502632407815, 14244.857551424768, 14531.418743250151, 15192.316345764246, 14083.859161408665, 14118.2940852959, 14170.858291416955, 14563.0, 14799.92600037036, 13068.125112277932, 13277.80083298732, 13296.401661925043, 13511.121777084458, 13537.59387218385, 12876.484940602271, 13183.209007459584, 13353.732925341634, 13449.0, 13903.652408689459, 11281.71795705114, 11447.713807154887, 11739.647810565697, 12134.75730485403, 12162.77000889626, 10084.69745907624, 10669.89330106689, 11716.36057203737, 11954.70113247141, 12094.0], "value": 7232.49534431255, "unit": "score"}], "name": "dromaeo_css", "value": 7072.357479457533, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 111.0, 113.0, 114.0, 110.0, 111.0, 111.0, 110.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 125.0, 172.0, 123.0, 122.0, 122.0, 123.0, 148.0, 123.0], "value": 133.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 160.0, 161.0, 163.0, 162.0, 161.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 109.0, 77.0, 77.0, 76.0, 75.0, 105.0, 75.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 112.0, 88.0, 81.0, 81.0, 99.0, 82.0, 82.0, 107.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 148.0, 147.0, 145.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 51.0, 52.0, 53.0, 52.0, 51.0, 52.0, 52.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 63.0, 65.0, 63.0, 64.0, 64.0, 64.0, 65.0], "value": 63.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 80.0, 80.0, 81.0, 79.0, 81.0, 87.0, 83.0, 81.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 140.0, 136.0, 131.0, 131.0, 133.0, 133.0, 140.0, 179.0, 139.0], "value": 139.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 167.0, 169.0, 166.0, 169.0, 166.0, 167.0, 172.0, 170.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 65.0, 65.0, 66.0, 81.0, 65.0, 67.0, 70.0, 64.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1508.3000000000002, "alertThreshold": 2.0}]} 10:34:15 INFO - Return code: 0 10:34:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:34:15 INFO - # TBPL SUCCESS # 10:34:15 INFO - Running post-action listener: _resource_record_post_action 10:34:15 INFO - [mozharness: 2016-11-27 18:34:15.285327Z] Finished run-tests step (success) 10:34:15 INFO - Running post-run listener: _resource_record_post_run 10:34:15 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403533824; Read time: 12; Write time: 270792 10:34:15 INFO - TinderboxPrint: CPU usage
13.1% 10:34:15 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:34:15 INFO - TinderboxPrint: I/O write bytes / time
403,533,824 / 270,792 10:34:15 INFO - TinderboxPrint: CPU idle
8,313.1 (86.9%) 10:34:15 INFO - TinderboxPrint: CPU user
1,202.8 (12.6%) 10:34:15 INFO - TinderboxPrint: Swap in / out
0 / 0 10:34:15 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 115339264; Read time: 0; Write time: 67356 10:34:15 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 288194560; Read time: 0; Write time: 203436 10:34:15 INFO - Running post-run listener: _upload_blobber_files 10:34:15 INFO - Blob upload gear active. 10:34:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:34:15 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 10:34:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:34:16 INFO - (blobuploader) - INFO - Open directory for files ... 10:34:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:34:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:34:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:34:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:34:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:34:17 INFO - (blobuploader) - INFO - Done attempting. 10:34:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:34:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:34:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:34:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:34:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:34:20 INFO - (blobuploader) - INFO - Done attempting. 10:34:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:34:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:34:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:34:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:34:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:34:21 INFO - (blobuploader) - INFO - Done attempting. 10:34:21 INFO - (blobuploader) - INFO - Iteration through files over. 10:34:21 INFO - Return code: 0 10:34:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:34:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:34:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/908ebae089469d205e00d7682718ad0fd23b6d73a53ed7f65df86cc8d5875592bd254a5c7205e169e96f1a0295ca7c03394c2f402f6acf1b978189a119a4c473", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62aaf6a220f7d0cc105d75e2f8eeda05085fe2e28869352569dd91f5afff91c883f53c171cf46369d392ae44ba9a17243cca696567e397fa3c6a69f6396f4d16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/521613466af6788a9144595788fc4b5438f205eb709584e5856314e2c2dd0dafcf95d5758270b5c1fb84a6b9a6d06ac856009f2453d5a7c4467bd0d493053023"} 10:34:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:34:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:34:21 INFO - Contents: 10:34:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/908ebae089469d205e00d7682718ad0fd23b6d73a53ed7f65df86cc8d5875592bd254a5c7205e169e96f1a0295ca7c03394c2f402f6acf1b978189a119a4c473", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62aaf6a220f7d0cc105d75e2f8eeda05085fe2e28869352569dd91f5afff91c883f53c171cf46369d392ae44ba9a17243cca696567e397fa3c6a69f6396f4d16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/521613466af6788a9144595788fc4b5438f205eb709584e5856314e2c2dd0dafcf95d5758270b5c1fb84a6b9a6d06ac856009f2453d5a7c4467bd0d493053023"} 10:34:21 INFO - Running post-run listener: copy_logs_to_upload_dir 10:34:21 INFO - Copying logs to upload dir... 10:34:21 INFO - mkdir: /builds/slave/test/build/upload/logs 10:34:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.440122 ========= master_lag: 0.54 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-11-27 10:34:21.564887) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-27 10:34:21.568003) ========= 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=4300f881736b422476174874000001bc-1480267606.920969-302350423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/908ebae089469d205e00d7682718ad0fd23b6d73a53ed7f65df86cc8d5875592bd254a5c7205e169e96f1a0295ca7c03394c2f402f6acf1b978189a119a4c473", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62aaf6a220f7d0cc105d75e2f8eeda05085fe2e28869352569dd91f5afff91c883f53c171cf46369d392ae44ba9a17243cca696567e397fa3c6a69f6396f4d16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/521613466af6788a9144595788fc4b5438f205eb709584e5856314e2c2dd0dafcf95d5758270b5c1fb84a6b9a6d06ac856009f2453d5a7c4467bd0d493053023"} build_url:https://queue.taskcluster.net/v1/task/WJfaXgl1QsWK2H_Uf6uSGQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011369 build_url: 'https://queue.taskcluster.net/v1/task/WJfaXgl1QsWK2H_Uf6uSGQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/908ebae089469d205e00d7682718ad0fd23b6d73a53ed7f65df86cc8d5875592bd254a5c7205e169e96f1a0295ca7c03394c2f402f6acf1b978189a119a4c473", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62aaf6a220f7d0cc105d75e2f8eeda05085fe2e28869352569dd91f5afff91c883f53c171cf46369d392ae44ba9a17243cca696567e397fa3c6a69f6396f4d16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/521613466af6788a9144595788fc4b5438f205eb709584e5856314e2c2dd0dafcf95d5758270b5c1fb84a6b9a6d06ac856009f2453d5a7c4467bd0d493053023"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-27 10:34:21.600908) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 10:34:21.601271) ========= 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=4300f881736b422476174874000001bc-1480267606.920969-302350423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004570 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 10:34:21.650371) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-27 10:34:21.650717) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-27 10:34:21.651001) ========= ========= Total master_lag: 0.67 =========