builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-055 starttime: 1475814100.0 results: success (0) buildid: 20161006195901 builduid: 054da0f41da04033863ff8a4e33869b7 revision: a5b04b518afe0eadef15f5dd3e5e7a8408d75a67 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 21:21:40.003037) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 21:21:40.003406) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 21:21:40.003691) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 21:21:40.042911) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:21:40.043194) ========= 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=bb9b54edd4a927dc735d112f000001d9-1475811857.462648-2078148260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-06 21:21:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.9M=0s 2016-10-06 21:21:40 (88.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113031 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:21:40.180972) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:21:40.181289) ========= 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=bb9b54edd4a927dc735d112f000001d9-1475811857.462648-2078148260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018475 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:21:40.248920) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:21:40.252270) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a5b04b518afe0eadef15f5dd3e5e7a8408d75a67 --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 a5b04b518afe0eadef15f5dd3e5e7a8408d75a67 --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=bb9b54edd4a927dc735d112f000001d9-1475811857.462648-2078148260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-06 21:21:40,370 truncating revision to first 12 chars 2016-10-06 21:21:40,370 Setting DEBUG logging. 2016-10-06 21:21:40,370 attempt 1/10 2016-10-06 21:21:40,370 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a5b04b518afe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 21:21:40,744 unpacking tar archive at: mozilla-central-a5b04b518afe/testing/mozharness/ program finished with exit code 0 elapsedTime=0.708937 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:21:40.975283) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 21:21:40.975565) ========= script_repo_revision: a5b04b518afe0eadef15f5dd3e5e7a8408d75a67 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 21:21:40.975921) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 21:21:40.976210) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 21:21:40.994660) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-06 21:21:40.994921) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bb9b54edd4a927dc735d112f000001d9-1475811857.462648-2078148260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:21:41 INFO - MultiFileLogger online at 20161006 21:21:41 in /builds/slave/test 21:21:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 21:21:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:21:41 INFO - {'append_to_log': False, 21:21:41 INFO - 'base_work_dir': '/builds/slave/test', 21:21:41 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 21:21:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:21:41 INFO - 'branch': 'Firefox-Non-PGO', 21:21:41 INFO - 'buildbot_json_path': 'buildprops.json', 21:21:41 INFO - 'config_files': ('talos/linux_config.py',), 21:21:41 INFO - 'default_actions': ('clobber', 21:21:41 INFO - 'read-buildbot-config', 21:21:41 INFO - 'download-and-extract', 21:21:41 INFO - 'populate-webroot', 21:21:41 INFO - 'create-virtualenv', 21:21:41 INFO - 'install', 21:21:41 INFO - 'run-tests'), 21:21:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:21:41 INFO - 'download_minidump_stackwalk': True, 21:21:41 INFO - 'download_symbols': 'ondemand', 21:21:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:21:41 INFO - 'tooltool.py': '/tools/tooltool.py', 21:21:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:21:41 INFO - '/tools/misc-python/virtualenv.py')}, 21:21:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:21:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:21:41 INFO - 'installer_path': 'installer.exe', 21:21:41 INFO - 'log_level': 'info', 21:21:41 INFO - 'log_name': 'talos', 21:21:41 INFO - 'log_to_console': True, 21:21:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:21:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:21:41 INFO - 'opt_config_files': (), 21:21:41 INFO - 'pip_index': False, 21:21:41 INFO - 'sps_profile': False, 21:21:41 INFO - 'sps_profile_interval': 0, 21:21:41 INFO - 'suite': 'dromaeojs', 21:21:41 INFO - 'system_bits': '32', 21:21:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:21:41 INFO - 'title': 'talos-linux64-ix-055', 21:21:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:21:41 INFO - 'use_talos_json': True, 21:21:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:21:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:21:41 INFO - 'work_dir': 'build'} 21:21:41 INFO - [mozharness: 2016-10-07 04:21:41.204678Z] Running clobber step. 21:21:41 INFO - Running pre-action listener: _resource_record_pre_action 21:21:41 INFO - Running main action method: clobber 21:21:41 INFO - rmtree: /builds/slave/test/build 21:21:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:21:41 INFO - Running post-action listener: _resource_record_post_action 21:21:41 INFO - [mozharness: 2016-10-07 04:21:41.652400Z] Finished clobber step (success) 21:21:41 INFO - [mozharness: 2016-10-07 04:21:41.652501Z] Running read-buildbot-config step. 21:21:41 INFO - Running pre-action listener: _resource_record_pre_action 21:21:41 INFO - Running main action method: read_buildbot_config 21:21:41 INFO - Using buildbot properties: 21:21:41 INFO - { 21:21:41 INFO - "project": "", 21:21:41 INFO - "product": "firefox", 21:21:41 INFO - "script_repo_revision": "production", 21:21:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 21:21:41 INFO - "repository": "", 21:21:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 21:21:41 INFO - "buildid": "20161006195901", 21:21:41 INFO - "pgo_build": "False", 21:21:41 INFO - "basedir": "/builds/slave/test", 21:21:41 INFO - "buildnumber": 233, 21:21:41 INFO - "slavename": "talos-linux64-ix-055", 21:21:41 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:21:41 INFO - "platform": "ubuntu64_hw", 21:21:41 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 21:21:41 INFO - "branch": "mozilla-central", 21:21:41 INFO - "repo_path": "mozilla-central", 21:21:41 INFO - "revision": "a5b04b518afe0eadef15f5dd3e5e7a8408d75a67", 21:21:41 INFO - "stage_platform": "linux64", 21:21:41 INFO - "builduid": "054da0f41da04033863ff8a4e33869b7", 21:21:41 INFO - "slavebuilddir": "test" 21:21:41 INFO - } 21:21:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/IbGk_ujvRt-eWxpDu7V-RQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:21:41 INFO - Running post-action listener: _resource_record_post_action 21:21:41 INFO - [mozharness: 2016-10-07 04:21:41.654940Z] Finished read-buildbot-config step (success) 21:21:41 INFO - [mozharness: 2016-10-07 04:21:41.655028Z] Running download-and-extract step. 21:21:41 INFO - Running pre-action listener: _resource_record_pre_action 21:21:41 INFO - Running main action method: download_and_extract 21:21:41 INFO - mkdir: /builds/slave/test/build/tests 21:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:41 INFO - trying https://queue.taskcluster.net/v1/task/IbGk_ujvRt-eWxpDu7V-RQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:21:41 INFO - Downloading https://queue.taskcluster.net/v1/task/IbGk_ujvRt-eWxpDu7V-RQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:21:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IbGk_ujvRt-eWxpDu7V-RQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:21:42 INFO - Downloaded 1361 bytes. 21:21:42 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:21:42 INFO - Using the following test package requirements: 21:21:42 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:21:42 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:21:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:21:42 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:21:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:21:42 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:21:42 INFO - u'jsshell-linux-x86_64.zip'], 21:21:42 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:21:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:21:42 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:21:42 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:21:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:21:42 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:21:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:21:42 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:21:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:21:42 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:21:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:21:42 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:21:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IbGk_ujvRt-eWxpDu7V-RQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:21:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IbGk_ujvRt-eWxpDu7V-RQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:21:42 INFO - Fetch https://queue.taskcluster.net/v1/task/IbGk_ujvRt-eWxpDu7V-RQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:21:42 INFO - Http code: 200 21:21:42 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 21:21:42 INFO - x-amz-cf-id: M5NO5lxgcgt3ZfwBeqc3LWpX2o0SHSdPlWqSlC77zkZf7e5QUQZN2Q== 21:21:42 INFO - x-amz-version-id: DtRVJLhSFTHYgAvv6MpncIvXkLIgogMz 21:21:43 INFO - Expected file size: 20449831 21:21:43 INFO - Obtained file size: 20449831 21:21:47 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:21:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IbGk_ujvRt-eWxpDu7V-RQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:21:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IbGk_ujvRt-eWxpDu7V-RQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:21:47 INFO - Fetch https://queue.taskcluster.net/v1/task/IbGk_ujvRt-eWxpDu7V-RQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:21:47 INFO - Http code: 200 21:21:47 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 21:21:47 INFO - x-amz-cf-id: eTfWGXAXOdDGvesQaRTVgmzheSPE4cmB8VHOkAI5Y4ZSIWrewnK6AA== 21:21:47 INFO - x-amz-version-id: DtRVJLhSFTHYgAvv6MpncIvXkLIgogMz 21:21:47 INFO - Expected file size: 20449831 21:21:47 INFO - Obtained file size: 20449831 21:21:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IbGk_ujvRt-eWxpDu7V-RQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:21:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IbGk_ujvRt-eWxpDu7V-RQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:21:52 INFO - Fetch https://queue.taskcluster.net/v1/task/IbGk_ujvRt-eWxpDu7V-RQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:21:52 INFO - Http code: 200 21:21:52 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 21:21:52 INFO - x-amz-cf-id: 2R64Lp2-dw-RAgODmBC4QwxvxsO3W1qIFLcaWY75Tyq_FzHoybOsSw== 21:21:52 INFO - x-amz-version-id: sqlIEytCpE3ceANOrev68.jfizLEQ4ey 21:21:53 INFO - Expected file size: 14409006 21:21:53 INFO - Obtained file size: 14409006 21:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:54 INFO - trying https://queue.taskcluster.net/v1/task/IbGk_ujvRt-eWxpDu7V-RQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:21:54 INFO - Downloading https://queue.taskcluster.net/v1/task/IbGk_ujvRt-eWxpDu7V-RQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:21:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IbGk_ujvRt-eWxpDu7V-RQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:21:55 INFO - Downloaded 55842234 bytes. 21:21:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IbGk_ujvRt-eWxpDu7V-RQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:21:55 INFO - mkdir: /builds/slave/test/properties 21:21:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:21:55 INFO - Writing to file /builds/slave/test/properties/build_url 21:21:55 INFO - Contents: 21:21:55 INFO - build_url:https://queue.taskcluster.net/v1/task/IbGk_ujvRt-eWxpDu7V-RQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:21:56 INFO - Running post-action listener: _resource_record_post_action 21:21:56 INFO - Running post-action listener: set_extra_try_arguments 21:21:56 INFO - [mozharness: 2016-10-07 04:21:56.146592Z] Finished download-and-extract step (success) 21:21:56 INFO - [mozharness: 2016-10-07 04:21:56.146818Z] Running populate-webroot step. 21:21:56 INFO - Running pre-action listener: _resource_record_pre_action 21:21:56 INFO - Running main action method: populate_webroot 21:21:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:21:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:21:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:21:56 INFO - '--tppagecycles', 21:21:56 INFO - '7'], 21:21:56 INFO - 'tests': ['tsvgm']}}, 21:21:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:21:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:21:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:21:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:21:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:21:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:21:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:21:56 INFO - 'talos_options': ['--disable-e10s'], 21:21:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:21:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:21:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:21:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:21:56 INFO - 'talos_options': ['--disable-e10s'], 21:21:56 INFO - 'tests': ['damp', 'tps']}, 21:21:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:21:56 INFO - 'tests': ['damp', 'tps']}, 21:21:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:21:56 INFO - 'tests': ['dromaeo_dom']}, 21:21:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:21:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:21:56 INFO - 'tests': ['basic_compositor_video']}, 21:21:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:21:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:21:56 INFO - 'tests': ['a11yr', 21:21:56 INFO - 'ts_paint', 21:21:56 INFO - 'tpaint', 21:21:56 INFO - 'sessionrestore', 21:21:56 INFO - 'sessionrestore_no_auto_restore', 21:21:56 INFO - 'tabpaint']}, 21:21:56 INFO - 'other-e10s': {'tests': ['a11yr', 21:21:56 INFO - 'ts_paint', 21:21:56 INFO - 'tpaint', 21:21:56 INFO - 'sessionrestore', 21:21:56 INFO - 'sessionrestore_no_auto_restore', 21:21:56 INFO - 'tabpaint']}, 21:21:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:21:56 INFO - 'ts_paint', 21:21:56 INFO - 'tpaint', 21:21:56 INFO - 'sessionrestore', 21:21:56 INFO - 'sessionrestore_no_auto_restore', 21:21:56 INFO - 'tabpaint']}, 21:21:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:21:56 INFO - 'ts_paint', 21:21:56 INFO - 'tpaint', 21:21:56 INFO - 'sessionrestore', 21:21:56 INFO - 'sessionrestore_no_auto_restore', 21:21:56 INFO - 'tabpaint']}, 21:21:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:21:56 INFO - 'tests': ['a11yr', 21:21:56 INFO - 'ts_paint', 21:21:56 INFO - 'tpaint', 21:21:56 INFO - 'sessionrestore', 21:21:56 INFO - 'sessionrestore_no_auto_restore', 21:21:56 INFO - 'tabpaint']}, 21:21:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:21:56 INFO - 'tests': ['a11yr', 21:21:56 INFO - 'ts_paint', 21:21:56 INFO - 'tpaint', 21:21:56 INFO - 'sessionrestore', 21:21:56 INFO - 'sessionrestore_no_auto_restore', 21:21:56 INFO - 'tabpaint']}, 21:21:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:21:56 INFO - 'tests': ['tsvgx', 21:21:56 INFO - 'tsvgr_opacity', 21:21:56 INFO - 'tart', 21:21:56 INFO - 'tscrollx', 21:21:56 INFO - 'cart']}, 21:21:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:21:56 INFO - 'tsvgr_opacity', 21:21:56 INFO - 'tart', 21:21:56 INFO - 'tscrollx', 21:21:56 INFO - 'cart']}, 21:21:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:21:56 INFO - 'talos_options': ['--disable-e10s'], 21:21:56 INFO - 'tests': ['tp5o']}, 21:21:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:21:56 INFO - 'tests': ['tp5o']}, 21:21:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:21:56 INFO - 'talos_options': ['--disable-e10s', 21:21:56 INFO - '--xperf_path', 21:21:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:21:56 INFO - 'tests': ['tp5n']}, 21:21:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:21:56 INFO - 'talos_options': ['--xperf_path', 21:21:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:21:56 INFO - 'tests': ['tp5n']}}, 21:21:56 INFO - 'talos.zip': {'path': '', 21:21:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:21:56 INFO - Running post-action listener: _resource_record_post_action 21:21:56 INFO - [mozharness: 2016-10-07 04:21:56.163637Z] Finished populate-webroot step (success) 21:21:56 INFO - [mozharness: 2016-10-07 04:21:56.163724Z] Running create-virtualenv step. 21:21:56 INFO - Running pre-action listener: _resource_record_pre_action 21:21:56 INFO - Running main action method: create_virtualenv 21:21:56 INFO - Creating virtualenv /builds/slave/test/build/venv 21:21:56 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 21:21:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:21:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:21:56 INFO - Using real prefix '/usr' 21:21:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:21:56 INFO - Installing distribute.............................................................................................................................................................................................done. 21:21:58 INFO - Installing pip.................done. 21:21:58 INFO - Return code: 0 21:21:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:21:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:21:58 INFO - Reading from file tmpfile_stdout 21:21:58 INFO - Output received: 21:21:58 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) 21:21:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f37d194af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2637ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2634f60>, '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 0x2635d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26361d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475811857.462648-2078148260', '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 21:21:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:21:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:21:58 INFO - Using env: {'DISPLAY': ':0', 21:21:58 INFO - 'HOME': '/home/cltbld', 21:21:58 INFO - 'LANG': 'en_US.UTF-8', 21:21:58 INFO - 'LANGUAGE': 'en_US:en', 21:21:58 INFO - 'LOGNAME': 'cltbld', 21:21:58 INFO - 'MAIL': '/var/mail/cltbld', 21:21:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:58 INFO - 'MOZ_NO_REMOTE': '1', 21:21:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:21:58 INFO - 'NO_EM_RESTART': '1', 21:21:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:21:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:58 INFO - 'PWD': '/builds/slave/test', 21:21:58 INFO - 'SHELL': '/bin/bash', 21:21:58 INFO - 'SHLVL': '1', 21:21:58 INFO - 'TERM': 'linux', 21:21:58 INFO - 'TMOUT': '86400', 21:21:58 INFO - 'USER': 'cltbld', 21:21:58 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475811857.462648-2078148260', 21:21:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:58 INFO - '_': '/tools/buildbot/bin/python'} 21:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:59 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 21:21:59 INFO - Cleaning up... 21:21:59 INFO - Return code: 0 21:21:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:21: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')]} 21:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21: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')]} 21:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21: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', '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 0x7f37d194af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2637ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2634f60>, '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 0x2635d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26361d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475811857.462648-2078148260', '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 21:21: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', 'psutil>=3.1.1'] in /builds/slave/test/build 21:21: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 psutil>=3.1.1 21:21:59 INFO - Using env: {'DISPLAY': ':0', 21:21:59 INFO - 'HOME': '/home/cltbld', 21:21:59 INFO - 'LANG': 'en_US.UTF-8', 21:21:59 INFO - 'LANGUAGE': 'en_US:en', 21:21:59 INFO - 'LOGNAME': 'cltbld', 21:21:59 INFO - 'MAIL': '/var/mail/cltbld', 21:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:59 INFO - 'MOZ_NO_REMOTE': '1', 21:21:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:21:59 INFO - 'NO_EM_RESTART': '1', 21:21:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:59 INFO - 'PWD': '/builds/slave/test', 21:21:59 INFO - 'SHELL': '/bin/bash', 21:21:59 INFO - 'SHLVL': '1', 21:21:59 INFO - 'TERM': 'linux', 21:21:59 INFO - 'TMOUT': '86400', 21:21:59 INFO - 'USER': 'cltbld', 21:21:59 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475811857.462648-2078148260', 21:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:59 INFO - '_': '/tools/buildbot/bin/python'} 21:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:59 INFO - Downloading/unpacking psutil>=3.1.1 21:21: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 21:21: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 21:21: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 21:21: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 21:21: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 21:21: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 21:22:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:22:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:22:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:22:01 INFO - Installing collected packages: psutil 21:22:01 INFO - Running setup.py install for psutil 21:22:01 INFO - building 'psutil._psutil_linux' extension 21:22:01 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 21:22:01 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 21:22:01 INFO - building 'psutil._psutil_posix' extension 21:22:01 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 21:22:02 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 21:22:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:22:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:22:02 INFO - Successfully installed psutil 21:22:02 INFO - Cleaning up... 21:22:02 INFO - Return code: 0 21:22:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:22:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:22:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:02 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 0x7f37d194af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2637ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2634f60>, '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 0x2635d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26361d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475811857.462648-2078148260', '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 21:22:02 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 21:22:02 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 21:22:02 INFO - Using env: {'DISPLAY': ':0', 21:22:02 INFO - 'HOME': '/home/cltbld', 21:22:02 INFO - 'LANG': 'en_US.UTF-8', 21:22:02 INFO - 'LANGUAGE': 'en_US:en', 21:22:02 INFO - 'LOGNAME': 'cltbld', 21:22:02 INFO - 'MAIL': '/var/mail/cltbld', 21:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:02 INFO - 'MOZ_NO_REMOTE': '1', 21:22:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:22:02 INFO - 'NO_EM_RESTART': '1', 21:22:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:02 INFO - 'PWD': '/builds/slave/test', 21:22:02 INFO - 'SHELL': '/bin/bash', 21:22:02 INFO - 'SHLVL': '1', 21:22:02 INFO - 'TERM': 'linux', 21:22:02 INFO - 'TMOUT': '86400', 21:22:02 INFO - 'USER': 'cltbld', 21:22:02 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475811857.462648-2078148260', 21:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:02 INFO - '_': '/tools/buildbot/bin/python'} 21:22:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:22:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:22:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:22:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:22:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:22:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:22:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:22:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:22:04 INFO - Installing collected packages: mozsystemmonitor 21:22:04 INFO - Running setup.py install for mozsystemmonitor 21:22:04 INFO - Successfully installed mozsystemmonitor 21:22:04 INFO - Cleaning up... 21:22:04 INFO - Return code: 0 21:22:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:22: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')]} 21:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:22:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22: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')]} 21:22:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:22:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22: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', '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 0x7f37d194af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2637ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2634f60>, '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 0x2635d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26361d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475811857.462648-2078148260', '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 21:22: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:22: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 jsonschema==2.5.1 21:22:04 INFO - Using env: {'DISPLAY': ':0', 21:22:04 INFO - 'HOME': '/home/cltbld', 21:22:04 INFO - 'LANG': 'en_US.UTF-8', 21:22:04 INFO - 'LANGUAGE': 'en_US:en', 21:22:04 INFO - 'LOGNAME': 'cltbld', 21:22:04 INFO - 'MAIL': '/var/mail/cltbld', 21:22:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:04 INFO - 'MOZ_NO_REMOTE': '1', 21:22:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:22:04 INFO - 'NO_EM_RESTART': '1', 21:22:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:22:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:04 INFO - 'PWD': '/builds/slave/test', 21:22:04 INFO - 'SHELL': '/bin/bash', 21:22:04 INFO - 'SHLVL': '1', 21:22:04 INFO - 'TERM': 'linux', 21:22:04 INFO - 'TMOUT': '86400', 21:22:04 INFO - 'USER': 'cltbld', 21:22:04 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475811857.462648-2078148260', 21:22:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:04 INFO - '_': '/tools/buildbot/bin/python'} 21:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:22:04 INFO - Downloading/unpacking jsonschema==2.5.1 21:22: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 21:22: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 21:22: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 21:22: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 21:22: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 21:22: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 21:22:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:22:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:22: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 21:22: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 21:22: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 21:22: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 21:22: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 21:22: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 21:22:06 INFO - Downloading functools32-3.2.3-2.tar.gz 21:22:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:22:06 INFO - warning: no files found matching '*.txt' 21:22:06 INFO - no previously-included directories found matching 'build' 21:22:06 INFO - no previously-included directories found matching 'dist' 21:22:06 INFO - no previously-included directories found matching '.git*' 21:22:06 INFO - Installing collected packages: jsonschema, functools32 21:22:06 INFO - Running setup.py install for functools32 21:22:07 INFO - warning: no files found matching '*.txt' 21:22:07 INFO - no previously-included directories found matching 'build' 21:22:07 INFO - no previously-included directories found matching 'dist' 21:22:07 INFO - no previously-included directories found matching '.git*' 21:22:07 INFO - Successfully installed jsonschema functools32 21:22:07 INFO - Cleaning up... 21:22:07 INFO - Return code: 0 21:22:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:22:07 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')]} 21:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:22:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:07 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')]} 21:22:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:22:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:07 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 0x7f37d194af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2637ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2634f60>, '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 0x2635d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26361d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475811857.462648-2078148260', '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 21:22:07 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 21:22:07 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 21:22:07 INFO - Using env: {'DISPLAY': ':0', 21:22:07 INFO - 'HOME': '/home/cltbld', 21:22:07 INFO - 'LANG': 'en_US.UTF-8', 21:22:07 INFO - 'LANGUAGE': 'en_US:en', 21:22:07 INFO - 'LOGNAME': 'cltbld', 21:22:07 INFO - 'MAIL': '/var/mail/cltbld', 21:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:07 INFO - 'MOZ_NO_REMOTE': '1', 21:22:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:22:07 INFO - 'NO_EM_RESTART': '1', 21:22:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:07 INFO - 'PWD': '/builds/slave/test', 21:22:07 INFO - 'SHELL': '/bin/bash', 21:22:07 INFO - 'SHLVL': '1', 21:22:07 INFO - 'TERM': 'linux', 21:22:07 INFO - 'TMOUT': '86400', 21:22:07 INFO - 'USER': 'cltbld', 21:22:07 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475811857.462648-2078148260', 21:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:07 INFO - '_': '/tools/buildbot/bin/python'} 21:22:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:22:07 INFO - Cleaning up... 21:22:07 INFO - Return code: 0 21:22:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:22:07 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')]} 21:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:22:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:07 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')]} 21:22:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:22:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:07 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 0x7f37d194af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2637ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2634f60>, '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 0x2635d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26361d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475811857.462648-2078148260', '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 21:22:07 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 21:22:07 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 21:22:07 INFO - Using env: {'DISPLAY': ':0', 21:22:07 INFO - 'HOME': '/home/cltbld', 21:22:07 INFO - 'LANG': 'en_US.UTF-8', 21:22:07 INFO - 'LANGUAGE': 'en_US:en', 21:22:07 INFO - 'LOGNAME': 'cltbld', 21:22:07 INFO - 'MAIL': '/var/mail/cltbld', 21:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:07 INFO - 'MOZ_NO_REMOTE': '1', 21:22:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:22:07 INFO - 'NO_EM_RESTART': '1', 21:22:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:07 INFO - 'PWD': '/builds/slave/test', 21:22:07 INFO - 'SHELL': '/bin/bash', 21:22:07 INFO - 'SHLVL': '1', 21:22:07 INFO - 'TERM': 'linux', 21:22:07 INFO - 'TMOUT': '86400', 21:22:07 INFO - 'USER': 'cltbld', 21:22:07 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475811857.462648-2078148260', 21:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:07 INFO - '_': '/tools/buildbot/bin/python'} 21:22:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:22:07 INFO - Downloading/unpacking blobuploader==1.2.4 21:22: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 21:22: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 21:22: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 21:22: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 21:22: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 21:22: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 21:22:09 INFO - Downloading blobuploader-1.2.4.tar.gz 21:22:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:22:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:22:09 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 21:22:09 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 21:22:09 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 21:22:09 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 21:22:09 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 21:22:09 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 21:22:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:22:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:22:09 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 21:22:09 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 21:22:09 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 21:22:09 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 21:22:09 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 21:22:09 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 21:22:10 INFO - Downloading docopt-0.6.1.tar.gz 21:22:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:22:10 INFO - Installing collected packages: blobuploader, requests, docopt 21:22:10 INFO - Running setup.py install for blobuploader 21:22:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:22:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:22:10 INFO - Running setup.py install for requests 21:22:10 INFO - Running setup.py install for docopt 21:22:10 INFO - Successfully installed blobuploader requests docopt 21:22:10 INFO - Cleaning up... 21:22:10 INFO - Return code: 0 21:22:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:22:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:22:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:10 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 0x7f37d194af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2637ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2634f60>, '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 0x2635d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26361d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475811857.462648-2078148260', '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 21:22:10 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 21:22:10 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 21:22:10 INFO - Using env: {'DISPLAY': ':0', 21:22:10 INFO - 'HOME': '/home/cltbld', 21:22:10 INFO - 'LANG': 'en_US.UTF-8', 21:22:10 INFO - 'LANGUAGE': 'en_US:en', 21:22:10 INFO - 'LOGNAME': 'cltbld', 21:22:10 INFO - 'MAIL': '/var/mail/cltbld', 21:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:10 INFO - 'MOZ_NO_REMOTE': '1', 21:22:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:22:10 INFO - 'NO_EM_RESTART': '1', 21:22:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:10 INFO - 'PWD': '/builds/slave/test', 21:22:10 INFO - 'SHELL': '/bin/bash', 21:22:10 INFO - 'SHLVL': '1', 21:22:10 INFO - 'TERM': 'linux', 21:22:10 INFO - 'TMOUT': '86400', 21:22:10 INFO - 'USER': 'cltbld', 21:22:10 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475811857.462648-2078148260', 21:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:10 INFO - '_': '/tools/buildbot/bin/python'} 21:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:22:11 INFO - Running setup.py (path:/tmp/pip-wIKgpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:22:11 INFO - Running setup.py (path:/tmp/pip-HsyQz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:22:11 INFO - Running setup.py (path:/tmp/pip-EUXCv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:22:11 INFO - Running setup.py (path:/tmp/pip-QYPrpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:22:11 INFO - Running setup.py (path:/tmp/pip-sLZGSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:22:11 INFO - Running setup.py (path:/tmp/pip-jYJDZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:22:11 INFO - Running setup.py (path:/tmp/pip-bgxMbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:22:11 INFO - Running setup.py (path:/tmp/pip-qGEnmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:22:11 INFO - Running setup.py (path:/tmp/pip-mX9cGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:22:11 INFO - Running setup.py (path:/tmp/pip-9VUUoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:22:11 INFO - Running setup.py (path:/tmp/pip-x7E9Wm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:22:11 INFO - Running setup.py (path:/tmp/pip-gdQffE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:22:11 INFO - Running setup.py (path:/tmp/pip-D10zAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:22:11 INFO - Running setup.py (path:/tmp/pip-T8wxXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:22:12 INFO - Running setup.py (path:/tmp/pip-3PeSJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:22:12 INFO - Running setup.py (path:/tmp/pip-vepzFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:22:12 INFO - Running setup.py (path:/tmp/pip-9dQsLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:22:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:22:12 INFO - Running setup.py install for manifestparser 21:22:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:22:12 INFO - Running setup.py install for mozcrash 21:22:12 INFO - Running setup.py install for mozdebug 21:22:12 INFO - Running setup.py install for mozdevice 21:22:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:22:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:22:12 INFO - Running setup.py install for mozfile 21:22:12 INFO - Running setup.py install for mozhttpd 21:22:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:22:12 INFO - Running setup.py install for mozinfo 21:22:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:22:12 INFO - Running setup.py install for mozInstall 21:22:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:22:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:22:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:22:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:22:13 INFO - Running setup.py install for mozleak 21:22:13 INFO - Running setup.py install for mozlog 21:22:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:22:13 INFO - Running setup.py install for moznetwork 21:22:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:22:13 INFO - Running setup.py install for mozprocess 21:22:13 INFO - Running setup.py install for mozprofile 21:22:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:22:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:22:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:22:13 INFO - Running setup.py install for mozrunner 21:22:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:22:13 INFO - Running setup.py install for mozscreenshot 21:22:13 INFO - Running setup.py install for moztest 21:22:13 INFO - Running setup.py install for mozversion 21:22:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:22:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:22:14 INFO - Cleaning up... 21:22:14 INFO - Return code: 0 21:22:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:22:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:22:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:14 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 0x7f37d194af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2637ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2634f60>, '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 0x2635d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26361d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475811857.462648-2078148260', '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 21:22:14 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 21:22:14 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 21:22:14 INFO - Using env: {'DISPLAY': ':0', 21:22:14 INFO - 'HOME': '/home/cltbld', 21:22:14 INFO - 'LANG': 'en_US.UTF-8', 21:22:14 INFO - 'LANGUAGE': 'en_US:en', 21:22:14 INFO - 'LOGNAME': 'cltbld', 21:22:14 INFO - 'MAIL': '/var/mail/cltbld', 21:22:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:14 INFO - 'MOZ_NO_REMOTE': '1', 21:22:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:22:14 INFO - 'NO_EM_RESTART': '1', 21:22:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:22:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:14 INFO - 'PWD': '/builds/slave/test', 21:22:14 INFO - 'SHELL': '/bin/bash', 21:22:14 INFO - 'SHLVL': '1', 21:22:14 INFO - 'TERM': 'linux', 21:22:14 INFO - 'TMOUT': '86400', 21:22:14 INFO - 'USER': 'cltbld', 21:22:14 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475811857.462648-2078148260', 21:22:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:14 INFO - '_': '/tools/buildbot/bin/python'} 21:22:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:22:14 INFO - Running setup.py (path:/tmp/pip-bSF7_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:22:14 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)) 21:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:22:14 INFO - Running setup.py (path:/tmp/pip-UBRJRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:22:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:22:14 INFO - Running setup.py (path:/tmp/pip-NonfBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:22:14 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)) 21:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:22:14 INFO - Running setup.py (path:/tmp/pip-fM1ZXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:22:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:22:14 INFO - Running setup.py (path:/tmp/pip-AZ9iWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:22:14 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)) 21:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:22:14 INFO - Running setup.py (path:/tmp/pip-jbdY2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:22:14 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)) 21:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:22:14 INFO - Running setup.py (path:/tmp/pip-fcadG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:22:14 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)) 21:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:22:14 INFO - Running setup.py (path:/tmp/pip-yWrUol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:22:14 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)) 21:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:22:14 INFO - Running setup.py (path:/tmp/pip-BDPJrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:22:14 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)) 21:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:22:14 INFO - Running setup.py (path:/tmp/pip-E58FJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:22:14 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)) 21:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:22:15 INFO - Running setup.py (path:/tmp/pip-Be083Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:22:15 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)) 21:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:22:15 INFO - Running setup.py (path:/tmp/pip-XWL9ir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:22:15 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)) 21:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:22:15 INFO - Running setup.py (path:/tmp/pip-C5beUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:22:15 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)) 21:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:22:15 INFO - Running setup.py (path:/tmp/pip-UC0xW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:22:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:22:15 INFO - Running setup.py (path:/tmp/pip-_YrKuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:22:15 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)) 21:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:22:15 INFO - Running setup.py (path:/tmp/pip-hFGRgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:22:15 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)) 21:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:22:15 INFO - Running setup.py (path:/tmp/pip-Yca_2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:22:15 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)) 21:22:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:22:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:22:15 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)) 21:22:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:22:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:22:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:22:15 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 21:22:15 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 21:22:15 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 21:22:15 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 21:22:15 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 21:22:15 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 21:22:17 INFO - Downloading blessings-1.6.tar.gz 21:22:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:22:17 INFO - Installing collected packages: blessings 21:22:17 INFO - Running setup.py install for blessings 21:22:17 INFO - Successfully installed blessings 21:22:17 INFO - Cleaning up... 21:22:17 INFO - Return code: 0 21:22:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:22:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:22:17 INFO - Reading from file tmpfile_stdout 21:22:17 INFO - Current package versions: 21:22:17 INFO - argparse == 1.2.1 21:22:17 INFO - blessings == 1.6 21:22:17 INFO - blobuploader == 1.2.4 21:22:17 INFO - docopt == 0.6.1 21:22:17 INFO - functools32 == 3.2.3-2 21:22:17 INFO - jsonschema == 2.5.1 21:22:17 INFO - manifestparser == 1.1 21:22:17 INFO - mozInstall == 1.12 21:22:17 INFO - mozcrash == 0.17 21:22:17 INFO - mozdebug == 0.1 21:22:17 INFO - mozdevice == 0.48 21:22:17 INFO - mozfile == 1.2 21:22:17 INFO - mozhttpd == 0.7 21:22:17 INFO - mozinfo == 0.9 21:22:17 INFO - mozleak == 0.1 21:22:17 INFO - mozlog == 3.4 21:22:17 INFO - moznetwork == 0.27 21:22:17 INFO - mozprocess == 0.23 21:22:17 INFO - mozprofile == 0.28 21:22:17 INFO - mozrunner == 6.12 21:22:17 INFO - mozscreenshot == 0.1 21:22:17 INFO - mozsystemmonitor == 0.3 21:22:17 INFO - moztest == 0.7 21:22:17 INFO - mozversion == 1.4 21:22:17 INFO - psutil == 3.1.1 21:22:17 INFO - requests == 1.2.3 21:22:17 INFO - wsgiref == 0.1.2 21:22:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:22:17 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')]} 21:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:22:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:17 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')]} 21:22:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:22:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:17 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 0x7f37d194af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2637ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2634f60>, '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 0x2635d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26361d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475811857.462648-2078148260', '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 21:22:17 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 21:22:17 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 21:22:17 INFO - Using env: {'DISPLAY': ':0', 21:22:17 INFO - 'HOME': '/home/cltbld', 21:22:17 INFO - 'LANG': 'en_US.UTF-8', 21:22:17 INFO - 'LANGUAGE': 'en_US:en', 21:22:17 INFO - 'LOGNAME': 'cltbld', 21:22:17 INFO - 'MAIL': '/var/mail/cltbld', 21:22:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:17 INFO - 'MOZ_NO_REMOTE': '1', 21:22:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:22:17 INFO - 'NO_EM_RESTART': '1', 21:22:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:22:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:17 INFO - 'PWD': '/builds/slave/test', 21:22:17 INFO - 'SHELL': '/bin/bash', 21:22:17 INFO - 'SHLVL': '1', 21:22:17 INFO - 'TERM': 'linux', 21:22:17 INFO - 'TMOUT': '86400', 21:22:17 INFO - 'USER': 'cltbld', 21:22:17 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475811857.462648-2078148260', 21:22:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:17 INFO - '_': '/tools/buildbot/bin/python'} 21:22:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:22:18 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)) 21:22:18 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)) 21:22:18 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)) 21:22:18 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)) 21:22:18 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)) 21:22:18 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)) 21:22:18 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)) 21:22:18 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)) 21:22:18 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)) 21:22:18 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)) 21:22:18 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)) 21:22:18 INFO - Cleaning up... 21:22:18 INFO - Return code: 0 21:22:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:22:18 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')]} 21:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:22:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:18 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')]} 21:22:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:22:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:18 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 0x7f37d194af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2637ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2634f60>, '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 0x2635d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26361d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475811857.462648-2078148260', '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 21:22:18 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 21:22:18 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 21:22:18 INFO - Using env: {'DISPLAY': ':0', 21:22:18 INFO - 'HOME': '/home/cltbld', 21:22:18 INFO - 'LANG': 'en_US.UTF-8', 21:22:18 INFO - 'LANGUAGE': 'en_US:en', 21:22:18 INFO - 'LOGNAME': 'cltbld', 21:22:18 INFO - 'MAIL': '/var/mail/cltbld', 21:22:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:18 INFO - 'MOZ_NO_REMOTE': '1', 21:22:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:22:18 INFO - 'NO_EM_RESTART': '1', 21:22:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:22:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:18 INFO - 'PWD': '/builds/slave/test', 21:22:18 INFO - 'SHELL': '/bin/bash', 21:22:18 INFO - 'SHLVL': '1', 21:22:18 INFO - 'TERM': 'linux', 21:22:18 INFO - 'TMOUT': '86400', 21:22:18 INFO - 'USER': 'cltbld', 21:22:18 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475811857.462648-2078148260', 21:22:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:18 INFO - '_': '/tools/buildbot/bin/python'} 21:22:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:22:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:22:18 INFO - Cleaning up... 21:22:18 INFO - Return code: 0 21:22:18 INFO - Running post-action listener: _resource_record_post_action 21:22:18 INFO - Running post-action listener: _start_resource_monitoring 21:22:18 INFO - Starting resource monitoring. 21:22:18 INFO - [mozharness: 2016-10-07 04:22:18.382043Z] Finished create-virtualenv step (success) 21:22:18 INFO - [mozharness: 2016-10-07 04:22:18.382507Z] Running install step. 21:22:18 INFO - Running pre-action listener: _resource_record_pre_action 21:22:18 INFO - Running main action method: install 21:22:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:22:18 INFO - Reading from file tmpfile_stdout 21:22:18 INFO - Detecting whether we're running mozinstall >=1.0... 21:22:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:22:18 INFO - Reading from file tmpfile_stdout 21:22:18 INFO - Output received: 21:22:18 INFO - Usage: mozinstall [options] installer 21:22:18 INFO - Options: 21:22:18 INFO - -h, --help show this help message and exit 21:22:18 INFO - -d DEST, --destination=DEST 21:22:18 INFO - Directory to install application into. [default: 21:22:18 INFO - "/builds/slave/test"] 21:22:18 INFO - --app=APP Application being installed. [default: firefox] 21:22:18 INFO - mkdir: /builds/slave/test/build/application 21:22:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:22:34 INFO - Reading from file tmpfile_stdout 21:22:34 INFO - Output received: 21:22:34 INFO - /builds/slave/test/build/application/firefox/firefox 21:22:34 INFO - Running post-action listener: _resource_record_post_action 21:22:34 INFO - [mozharness: 2016-10-07 04:22:34.794870Z] Finished install step (success) 21:22:34 INFO - [mozharness: 2016-10-07 04:22:34.795115Z] Running run-tests step. 21:22:34 INFO - Running pre-action listener: _resource_record_pre_action 21:22:34 INFO - Running main action method: run_tests 21:22:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:22:34 INFO - Python 2.7.3 21:22:34 INFO - Return code: 0 21:22:34 INFO - grabbing minidump binary from tooltool 21:22:34 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')]} 21:22:34 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 0x2634f60>, '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 0x2635d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26361d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:22:34 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 21:22:34 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 21:22:34 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 21:22:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:22:34 INFO - Return code: 0 21:22:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:22:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:22:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:22:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:22:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:22:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IbGk_ujvRt-eWxpDu7V-RQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 21:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IbGk_ujvRt-eWxpDu7V-RQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 21:22:34 INFO - Using env: {'DISPLAY': ':0', 21:22:34 INFO - 'HOME': '/home/cltbld', 21:22:34 INFO - 'LANG': 'en_US.UTF-8', 21:22:34 INFO - 'LANGUAGE': 'en_US:en', 21:22:34 INFO - 'LOGNAME': 'cltbld', 21:22:34 INFO - 'MAIL': '/var/mail/cltbld', 21:22:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:22:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:34 INFO - 'MOZ_NO_REMOTE': '1', 21:22:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:22:34 INFO - 'NO_EM_RESTART': '1', 21:22:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:34 INFO - 'PWD': '/builds/slave/test', 21:22:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:22:34 INFO - 'SHELL': '/bin/bash', 21:22:34 INFO - 'SHLVL': '1', 21:22:34 INFO - 'TERM': 'linux', 21:22:34 INFO - 'TMOUT': '86400', 21:22:34 INFO - 'USER': 'cltbld', 21:22:34 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475811857.462648-2078148260', 21:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:34 INFO - '_': '/tools/buildbot/bin/python'} 21:22:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IbGk_ujvRt-eWxpDu7V-RQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 21:22:35 INFO - mozversion application_buildid: 20161006195901 21:22:35 INFO - mozversion application_changeset: a5b04b518afe0eadef15f5dd3e5e7a8408d75a67 21:22:35 INFO - mozversion application_display_name: Nightly 21:22:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:22:35 INFO - mozversion application_name: Firefox 21:22:35 INFO - mozversion application_remotingname: firefox 21:22:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:22:35 INFO - mozversion application_vendor: Mozilla 21:22:35 INFO - mozversion application_version: 52.0a1 21:22:35 INFO - mozversion platform_buildid: 20161006195901 21:22:35 INFO - mozversion platform_changeset: a5b04b518afe0eadef15f5dd3e5e7a8408d75a67 21:22:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:22:35 INFO - mozversion platform_version: 52.0a1 21:22:35 INFO - using testdate: 1475814155 21:22:35 INFO - actual date: 1475814155 21:22:35 INFO - starting webserver on 'localhost:57416' 21:22:35 INFO - SUITE-START | Running 2 tests 21:22:35 INFO - TEST-START | dromaeo_css 21:22:35 INFO - operating with platform_type : linux_ 21:22:35 INFO - Initialising browser for dromaeo_css test... 21:22:35 INFO - TEST-INFO | started process 6458 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsVQ3YS/profile http://localhost:57416/getInfo.html) 21:22:39 INFO - PROCESS | 6458 | __metrics Screen width/height:1600/1200 21:22:39 INFO - PROCESS | 6458 | colorDepth:24 21:22:39 INFO - PROCESS | 6458 | Browser inner width/height: 1024/697 21:22:39 INFO - PROCESS | 6458 | __metrics 21:22:40 INFO - PROCESS | 6458 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:22:40 INFO - PROCESS | 6458 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:22:40 INFO - PROCESS | 6458 | console.error: PushService: 21:22:40 INFO - PROCESS | 6458 | stateChangeProcessEnqueue: Error transitioning state 21:22:40 INFO - PROCESS | 6458 | UnknownError 21:22:41 INFO - TEST-INFO | 6458: exit 0 21:22:41 INFO - Browser initialized. 21:22:41 INFO - Running cycle 1/1 for dromaeo_css test... 21:22:41 INFO - TEST-INFO | started process 6537 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsVQ3YS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:22:53 INFO - PROCESS | 6537 | RSS: Main: 175464448 21:22:53 INFO - PROCESS | 6537 | 21:23:44 INFO - PROCESS | 6537 | 1475814224756 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] 21:25:58 INFO - PROCESS | 6537 | Cycle 1(1): loaded http://localhost:57416/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57416/tests/dromaeo/cssquery-ext.html) 21:26:01 INFO - PROCESS | 6537 | RSS: Main: 406446080 21:26:01 INFO - PROCESS | 6537 | 21:29:03 INFO - PROCESS | 6537 | Cycle 1(1): loaded http://localhost:57416/tests/dromaeo/cssquery-ext.html (next: http://localhost:57416/tests/dromaeo/cssquery-jquery.html) 21:29:04 INFO - PROCESS | 6537 | RSS: Main: 282353664 21:29:04 INFO - PROCESS | 6537 | 21:32:06 INFO - PROCESS | 6537 | Cycle 1(1): loaded http://localhost:57416/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57416/tests/dromaeo/cssquery-mootools.html) 21:32:07 INFO - PROCESS | 6537 | RSS: Main: 258666496 21:32:07 INFO - PROCESS | 6537 | 21:35:09 INFO - PROCESS | 6537 | Cycle 1(1): loaded http://localhost:57416/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57416/tests/dromaeo/cssquery-prototype.html) 21:35:10 INFO - PROCESS | 6537 | RSS: Main: 245583872 21:35:10 INFO - PROCESS | 6537 | 21:38:13 INFO - PROCESS | 6537 | Cycle 1(1): loaded http://localhost:57416/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57416/tests/dromaeo/cssquery-yui.html) 21:38:13 INFO - PROCESS | 6537 | RSS: Main: 220151808 21:38:13 INFO - PROCESS | 6537 | 21:41:16 INFO - PROCESS | 6537 | Cycle 1(1): loaded http://localhost:57416/tests/dromaeo/cssquery-yui.html (next: http://localhost:57416/tests/dromaeo/cssquery-dojo.html) 21:41:17 INFO - PROCESS | 6537 | RSS: Main: 304173056 21:41:17 INFO - PROCESS | 6537 | 21:41:17 INFO - PROCESS | 6537 | __start_tp_report 21:41:17 INFO - PROCESS | 6537 | _x_x_mozilla_page_load 21:41:17 INFO - PROCESS | 6537 | _x_x_mozilla_page_load_details 21:41:17 INFO - PROCESS | 6537 | |i|pagename|runs| 21:41:17 INFO - PROCESS | 6537 | |0;dojo.html;2558.5266725655756;2582.715901250863;2624.553825849606;2630.105764040226;2642.1941307901093;4561.475430325513;4629.560191781784;4717.693349932252;4742.099001189776;4756.239001759719;4653.115907977482;4674.7428891410955;4680.836170734025;4717.716936983783;4806.014766972771;4350;4378.014946637013;4393.978030109845;4401.22978478765;4415.0066235097165;4160.230357383879;4373.147236288925;4450.26570615848;4459.598636122749;4471.597556219956;4439.112177564484;4441.977790111045;4460.687751857371;4512.751798651073;4519.27691569349;4240.639545638624;4263.189993901149;4263.616274535307;4377.015171586399;4385.714928529667;4272.273713468718;4309.482862056573;4309.913801723979;4311.094670119279;4313.029568347097;4571.817127314904;4634.582887540104;4637.95362046382;4639.095376401603;4683;5066.746662666852;5069.290299358093;5070.822521211777;5071.137906555894;5114.207297868837;4899.926501102486;4950.232713929347;5001.72490513018;5044.495550444926;5156.303898973628;4709.058188362341;4716.3632909557455;4721.433427988663;4726.291056341576;4788.640851936049;5166.741662916839;5168.431472538018;5170.353705786777;5180.611454140954;5227.3988491323225;4702.059588082398;4739.886126760209;4852.733099679552;4937.308776771255;5004.049230646166;4971.552560269521;5050.217216331474;5052.797888084509;5087.618428617869;5121.769520371592;5014.147594908874;5036.294918711384;5037.874053148701;5040.218766091261;5090.211017292326;4866.0511200316305;4925.975370123127;4981.750912454363;4984.028114517707;5043.293938848564;3908.179282350681;3938.9212215755524;3940.054386947112;3962.663173630274;3998.3602623580086;3501.124718820295;3503.5270238517983;3506.7545271830727;3544.0608238816735;3547.6807087362263;4404.317330813729;4418.80115394808;4418.889527761831;4419.381286619876;4472.08322293929;4882.584980276645;4926.75366231687;4968.677035992649;4999.800007999639;5002.399712034579;4333.198358303661;4337.566243375637;4337.6963612546815;4373.431453910971;4392.4289842320295;4471.374007638933;4475.888102797391;4476.798544065525;4478.984456994365;4533.116042371706;4656.115338085753;4667.206574882211;4713.858584242478;4788.712677239377;4792.568668819823;5044.218146187347;5048.318477005704;5053.11570475158;5056.64603477753;5058.848234552969;4780.187368147493;4782.641301902302;4785.353977213171;4788.3056956741775;4790;4972.179590367549;4977.377827771528;4978.701277923336;4980.103581355391;4980.128477516492;5025.824096156617;5033.094043072282;5039.470855560114;5040.924386134137;5043.420006699276;4877.219644856806;4937.481564435682;4942.085714142895;4943.530364615356;4944.134776414185;4851.442084160367;4854.95145048545;4857.732824694534;4929.433115191656;4951.331570238116;4869.586085182799;4871.318015477765;4878.487758785276;4880.682755620874;4918.852434426973;4817.927731083966;4869.074875773592;4900.828471003498;4939.28380384835;5013.598912087097;4571.725696458223;4615;4621.537846215486;4622.329762184531;4904.7302398367 21:41:17 INFO - PROCESS | 6537 | |1;ext.html;544.9046416877048;546.0662267522537;553.4050895287567;558.7206396801598;560.1206106412933;37492.25015499692;39223;39291.803540982255;39477;43552;40766.388504172464;41233.38149927754;41280;41286.174276514525;41304;7499.962500187505;7632.389408847279;7635.541867487968;7638;7639.6944122235045;7513.887291690629;7601.619919004028;7604.125525564548;7608.961955190216;7656.502327348704;7601.049868766404;7641.121271053817;7641.808954776119;7647.808804779869;7701.152873183945;7586.203448637896;7604.239576042407;7605.771826845204;7684.193159718205;7689.115751688571;7525.736599219001;7635.503692259986;7639.236076392372;7640;7640.656170472342;38412.23175536474;38768.61231387678;38837;38849.80575097135;38865;2866.1831378057154;3002.534607135897;3077.9692203077907;3081.1372815611667;3320.5185248138882;28305.85847070772;28522.572161417596;28617.71382286171;28838.134855954355;29114.41771164586;3323.3353329333986;3349.480830471281;3390.847411866472;3449.9310013799836;3515.542979412686;242135;244774;244850.77574612192;245180;245736;52577.474225257254;52907.470925291025;52959.20561191585;52988.470115299126;53153;31841.840790795897;32848;33037.83481082579;35492;35633.8218308912;12984.091113621957;13100.344982750825;13106.60680179596;13114.082014259102;13117;10273.897261027443;10397.584096636201;10460.895391045991;10464.476776161313;10467.267291289536;17801;17842.01868897223;17880;17960.730589041174;18070.819291807176;6820.658967051628;6928.307169283132;6998.825029374307;7013.2986701329455;7034.6130962796515;779.9376049915993;884.3765145572356;909.7088931541844;942.7218970403748;1017.6692574913183;27121.321966950985;27215.727842721717;27679.169624911287;28150.85924570364;28231.15306540807;926.7961048569304;945.0785484153033;945.6784693204344;981.8821741390936;995.3878364805737;14233.28833558318;14857.331420086122;14945.202902711477;14982.850171498363;15076.929209183612;379290;379391;380872;381304;384298;47587.38601823692;48344;48396.27405588919;48416;48471;1044.4464433850071;1064.2869277584036;1117.1677100560134;1147.3517462633586;1170.9414529273502;26400.207993760218;28642.85678571594;29519.142480737995;29653.703462965095;29923.401531968804;36114.09714757152;36545;36590.8170459146;36608;36626.26747465089;288248.55875720485;289878;290037;290134;290226;21532.89233553822;22211;23525.294241172793;24635.8768206165;24872.875635621705;40313.52304832909;40528.18943621052;40926.18147636971;41071;41553.58446415497;34221.65778342185;34849;35214.29571408506;35681;36004.27991440209;34367;34376;34741;34860.47709284312;35228.647713522536;33972.49041264334;34180.14549636279;34665.82667086648;34828.303433930676;35028.64971350356;30097.84951075318;32104;32258.83870580632;32391.190220244684;32497.187570309987;23980.520389591762;24162.678239305642;24620.38449038717;24658.136965206133;25727.356816079748 21:41:17 INFO - PROCESS | 6537 | |2;jquery.html;342.9146750534558;366.52901022186495;374.36545056129864;375.91541903071806;385.22569635033574;12337.25976441413;15877.68244635108;16260.512184634465;16338;17295.82704172958;15303.846961530382;15694.136822474758;16935.3225870965;17027.91486042568;17113;4971.477994810538;4988.600911927056;5131.076406246874;5175.120229560984;5200.791968321281;3569.4824250483666;3771.7359784815076;5068.163752980754;5163.1480805667015;5165.9225111623355;5627.099664053752;5904.0553511438175;5920.171176035358;6049.637021778707;6050.092486127072;5797.159411885253;5968.731407086648;6002.039673652194;6038.607490513103;6051.909221361683;5279.340082489689;5288.10102282609;5288.101022826128;5289.497497737709;5290.867728306823;17947.641047178982;19970.10134543949;20265.797342026537;20490.5901881963;20699.5860082799;1857.1921214271836;1877.558773688182;1915.0137679095278;2255.526339468697;2416.6979127609047;8819.29445644347;8977.192052715222;9253;9487.857682134774;9495.05049495052;1655.5447252005674;1678.8992660440413;1706.9146542672818;1766.1081154017138;1785.57146284892;67530.3246967529;68368;68452.31547684509;70009.2999070008;71042.64478677574;9333.766655833522;9519.428834269966;9779.168770654574;9784.804303914025;9891.60433582663;13483.932580337232;13490.797638035438;13538;13552.289542091621;13554.254516001518;6293.590916590407;6487.448566871774;6683.532152749358;6722.5798712463475;6741.8651626967185;5973.104034394875;6022.909656355158;6217.875642487125;6236.438720515175;6263.655498947511;4183.5398106208295;4199.68502362324;4240.406343111967;4287.571242875688;4333.631641310524;1714.5113642611796;1771.3526420428866;1787.356551641408;1839.981600184008;1855.6752568300494;794.4716763352421;805.2229598437536;834.4242472693821;850.7660393391867;891.7101941868918;15918.92040539813;17150.914245428692;17220.913895430444;17340.30638774435;17590.38433654816;795.1928792275845;808.5714571277115;820.4830956497368;860.337540094124;866.5623859950684;9251.953740231256;9309.162175404246;9628.374155679858;9663.420194788336;9806.803863922682;345043;345671;349397;350976;351437;45282.54717452849;70782.2921770786;72427.27572724206;73049;74864.62567687126;897.1566727276339;914.0402577293814;914.5610107148606;920.1718453392001;946.8532377481501;15302.395477752048;15413.306401212196;15812.367505300119;16164.595885102966;16513.091779952218;36573.45139822851;36795.81602091972;37091.443628345056;38026.239475210896;38058.61941380661;42882.35676464918;45052.907276061575;50861.491385085676;50888.49111508838;52407.73796130995;4677.368555244999;5500.834974950758;7077.504574679723;7498.58757768328;7515.924840751522;10772.461376930965;11823.052562391877;11936.343501107174;12441.813372799596;12476;9676.95161524216;10407.47962601882;10458.424786636808;10797.028267455968;10946.671599852018;9990.100890919852;10218.540165692413;10376.429296388771;10473.31923424975;10604.204684648836;10372.222083343628;10450.42522661261;10563.788724225626;10649.8935010652;10848.891511085103;7417;7495.43784216175;7686.46194766361;7691.615419228904;7760.68957241704;9506.47714375716;10233.48832558384;10512.26414151002;10709.839352409565;10752.569897204337 21:41:17 INFO - PROCESS | 6537 | |3;mootools.html;1175.9294442333467;1284.3385656386959;1325.0261058122278;1336.2183122873118;1618.5225358519235;6504.804855854326;7222.277772222782;7525.096988361404;7528.924710752891;7770.883436748439;7564.357029652486;7641.044869391326;7644.46488745788;7646.6941322347175;7648.770536883889;2099.128861522466;2123.034019521122;2123.225022866658;2123.5646692428013;2125.90433430496;2027.2296527319672;2027.401916434648;2030.9187632494682;2035.928742494013;2091.9267825626107;2041.510037590975;2056.979430205701;2067.8138967492923;2069.0689189864547;2075.0973326602902;1998.4903849518425;2009.8693584916934;2014.1339224133617;2016.7781544030145;2017.2838642281924;1987.076009655517;1990.1044529961575;2017.4956260934766;2024.068928292987;2025.584755125196;7380.926190738078;7504;7558.01745773046;7606.733764318277;7615.31462168402;4107;4296.656267498593;4300.827966881321;4302;4304.548022457629;2646.655934728473;2737.986310068457;2804.5232310507263;2811.409603983166;2813.4935711571907;851.3614788908319;877.32007694037;877.6884206106804;1705.7782488276569;1750.8774385793;9869.60521579136;9997.700068997869;10139.746506337327;10140.797184056277;10171.288009839314;3732.42147467143;3819.1597848473293;3832.5400951885954;3958;3985.1830374773103;8075.717349892726;8090.231428014329;8107.675692972215;8117.391195660349;8124.228198321268;4122.752634841919;4150.501939767187;4150.522689890701;4162.687798415131;4167.229062623424;3285.589301337333;3384.6446123157207;3633.291508155937;3855.575886652466;3865.903352416156;3120.391523652866;3132.843357832099;3220.710136087763;3280.442324804741;3283.244853683618;966.1256562810668;966.6370417711134;970.9514524273758;972.7324985629009;974.2303580171726;658.4600627485416;742.1242933338605;787.4487858498959;811.5942028985507;852.2883392367319;5009.12340340439;5078.568321692697;5084.669496482717;5110.514501122462;5241.872997305598;788.9447738658354;814.0760237130899;828.3828547731978;854.0264098927228;915.4598786715869;3357.5131605917004;3389.9491507627404;3420.6579342065593;3423;3524.3479956208184;9114.772130696785;9482.194013508792;9492.857607135898;9501.762455938657;9504.857427138599;9239.30705197113;9259.814803703888;9338.719838404859;9349.158575728217;9427.387219830689;6993.300669932966;7026.473014523931;7034.718611255493;7126.857462850714;7138.892916606255;4769.642276829321;4906.790780580737;4979.228219625964;5024.221245706921;5129.410117836496;8310.127436619068;8475.279601233964;8478.788030299045;8480.024797148408;8519.488830669932;8148.796280093045;8433.87349189775;8448.408611397143;8602.655893764178;8698;5520.199571062254;6289.7169627365965;6432.710528026157;6435.613863168225;6438.871222575616;5974.641521508724;6131.509479241739;6154.230721159855;6159.1069294951085;6166.876662466636;6225.28409232944;6261.043174444721;6493.675316234075;6496.9025464617125;6520.282768895512;6443;6516.957286834084;6549.181352330958;6556.18047744032;6562;5929.377415371497;6051.667158306335;6052.727627256696;6052.788152414821;6057.485113765203;4179.623833854967;4223.915521689488;4232.36514522824;4299.935500967551;4317.913641727211;4332.393464914851;4377.343398490252;4411.889702757457;4558.316252562142;4629.560191781776 21:41:17 INFO - PROCESS | 6537 | |4;prototype.html;273.84938283943825;275.5453501722158;279.3978975308209;283.71203228722845;291.2340544368311;4588.632909367243;4759.643026772993;4760.642951778613;4785.138675038496;4804.846836759179;4526.434195725535;4651.9767401163035;4674.041821426608;4678.929816052762;4702.623790096793;3734.9253014939686;3738;3745.8876233712963;3750.3436898542645;3756.1173124315765;3544.4328907374825;3600.0796257589436;3742.9893928639253;3754.7371683982133;3759.774413535197;3500.824958752052;3708.2768860072297;3723.1250656095795;3724.8323825427783;3738.9065273368246;3712.7215458840697;3716.5540135183683;3725.5156829612247;3726.142987112966;3726.4410338449447;3284.277458959049;3284.770066095374;3289.5723555937575;3289.753268504872;3294.1929227339456;4536.931946020813;4561.908761824745;4606.124836281096;4638.933045399577;4669.556392142741;4209.684273679456;4211.536730959592;4212.283911735012;4213.019880656087;4218.303979843322;4936.851894443173;4941.516231057132;4957.628177886637;4957.826476073356;4957.950420495821;3466.480027995796;3511.280187561569;3559.519464872235;3567.3411863483607;3567.6967457766123;5144.819931302386;5146.3824341078935;5157.329547158883;5167.191482980964;5169.475004873534;3630.237650093457;3634.909127271839;3635.9091022724115;3649.872254471134;3663.4504824276037;3696.7227457940226;3705.555333360014;3712.2575484903127;3736.252749450121;3738.4953031340965;4106.322456794655;4171.561985991488;4198.160367926427;4222.176675548239;4238.36424536322;4924.8276310328965;4935.185694360391;4941.777620007108;4947.777350019258;4952.777125029383;1200.7958647030025;1239.3431481314917;1267.6070418170398;1278.5013844600612;1284.4220100954421;863.0765081363007;886.7339798060556;894.3024440936081;898.1602201941206;900.428228075177;4407.162639098561;4429.534898835575;4431.202383570923;4445.911081778411;4453.576910193527;5032.647714659939;5046.571041461443;5056.216286475602;5075.441701412841;5077.746112694351;4271.167122411162;4412.470503539532;4501.932471012938;4516.390287311171;4545.522720114406;2707.632645514003;2728.2770065932546;2734.1387462949106;2739.1508632323644;2739.2330147558714;4870.001649661811;4886.511348865156;4892.290617860391;4912.508749125059;4913.656044076952;5112.437631860566;5193.428722840485;5242.213667949762;5247.868803279948;5269.55208807248;4880.6827556210155;4885.828995985124;4886.584640305614;4889.706617602955;4897.755112244445;4977.328060711902;5110.437851836221;5118.769655365443;5121.974390128025;5153.3815942087185;4990.401151861654;5011.874703132451;5034.270030845433;5053.59571234293;5062.215356619729;4837;4845.328361715203;4856.39295088114;4864.537868902448;4881.267809828554;3493.301339732013;3495.7727747696317;3497.3529896969144;3497.5691894133333;3503.404421248445;4953.306537084739;5059.822906198266;5106.948930510796;5123.718195499283;5125.564327032244;4923.261510773269;4948.38145231846;4979.178435558238;4986.177280748636;5010.799568017239;4979.460475157768;4987.927595566971;4996.950030499794;5002.349694539686;5007.524285192901;4670.439547254351;4694.201985662377;4789.616830653609;4863.173260545645;4899.951000490092;4835.8065677372515;4981.3026176334615;4987.72567508776;4997.675151115166;4999;4865.343178670976;4876.78054487556;4882.6338024649;4883.023395320879;4891.682040667345 21:41:17 INFO - PROCESS | 6537 | |5;yui.html;636.1825054804574;643.4498503779267;673.3703986772372;681.1009467502895;721.5850885740697;12030;12892.548760793374;12931.159474634142;12955.09314347996;12960.83352498275;11956.103292253094;11967.281963082221;11974.640760777169;11974.700632484191;11994.16040877139;620.0575125808768;637.2003136064257;746.2388363868864;756.7805336452423;776.3866545429104;775.2712450296731;779.302524240807;780.3756994404482;780.9453338266323;781.3631890009652;832.7335252719132;838.1953324808161;838.5010918503481;839.1063517354029;840.3193413335188;644.561698045329;662.2913482573648;825.3438516379463;825.9380546459009;826.4338927834452;579.956503262257;593.4955288005204;596.5317225977631;598.3597550620838;598.8742364103543;13046.739065218642;13075.150115242479;13089.541866034642;13094.148880322844;13102.27937463439;11879.406029698566;12231.510739570496;12282.815757763641;12494;12986.09097363185;11655.533778648844;11736.589219377282;11754.05967522596;11910.702232444171;12060.939695301555;4080.510338759368;4096.262672718909;4102.487189101363;4299.91400171998;4301.892452688677;60480.27665843526;61639;61686.383136168515;62457.37542624561;62942;9843.753906152404;9998.15015723657;10202.591896324064;10248.948755256177;10564;16936.322547097978;16939.068351240552;17110.743338849927;17165.141742912805;17287.222075006655;6708.262091169968;6761.594304341756;6837.3162683731225;7021;7026.894596581055;3579.2304654498885;3640.0899775056237;3686.668199862025;3814.961850381461;3829.942550861739;2648.854313012764;2708.891644334244;2740.7670348020642;2740.9588856167175;2743.9451210975667;493.28227429091305;542.0432935868196;567.690608618304;568.5338022821247;583.3262581718122;525;550.2159422822461;565.1268789719893;616.4390404731762;617.5985609353955;8075.717349892726;8462.788430289293;8603.870941935877;8935.955320223356;9303.581338839633;496.3919198981219;516.9250458683545;557.5177471487216;589.8377946064867;602.072807875875;3936.5866584008268;4015.1768887378016;4205.537390887;4232.513260974965;4322.589354011364;97707.51146244223;98336.59148746888;99949;101442;101620.49189754152;46228.306575400726;46984.7650761744;47283;49504;81623;53322.73338633282;73166;73643.63178184076;73788.63105684437;74583;7420.295071968154;8782.824343513223;8993.865092023756;9055.637774488947;9233.169014788702;29941.850290748407;30302.393952120394;32430.675693242767;36237.27525449529;40515.79742101271;49562.75218623884;50114.24828627647;51552.74223628858;56764.71617641886;57909;11004.954529319702;11374.886251137383;11396.316221026766;11417.257878237888;11466.484008219817;13313.800292995418;13389.66525836862;13558.79661805054;13606.93196534011;13639.045266831623;12433;12479.875201248235;12563.811542827048;12682.619521414372;13268.800967985295;11731.824022639497;12100.152989290666;12481.500739970663;13048.086633935533;13223.471061157446;12079.698007549881;12143.453544590338;12236.694082648006;12428.502859885864;12725.172863763826;9625.229981601595;9715.951420242853;9957.900420995697;10277.84583231267;10380.093573799348;9914.950425248117;10402.531886064993;10593.576256949636;10657.680269591925;10868.728281793019 21:41:17 INFO - PROCESS | 6537 | __end_tp_report 21:41:17 INFO - PROCESS | 6537 | __start_cc_report 21:41:17 INFO - PROCESS | 6537 | _x_x_mozilla_cycle_collect,2621 21:41:17 INFO - PROCESS | 6537 | __end_cc_report 21:41:17 INFO - PROCESS | 6537 | __startTimestamp1475815277219__endTimestamp 21:41:17 INFO - PROCESS | 6537 | 21:41:17 INFO - PROCESS | 6537 | ------- Summary: start ------- 21:41:17 INFO - PROCESS | 6537 | Number of tests: 6 21:41:17 INFO - PROCESS | 6537 | 21:41:17 INFO - PROCESS | 6537 | [#0] dojo.html Cycles:165 Average:4634.63 Median:4780.19 stddev:507.52 (10.6%) stddev-sans-first:482.24 21:41:17 INFO - PROCESS | 6537 | Values: 2558.5 2582.7 2624.6 2630.1 2642.2 4561.5 4629.6 4717.7 4742.1 4756.2 4653.1 4674.7 4680.8 4717.7 4806.0 4350.0 4378.0 4394.0 4401.2 4415.0 4160.2 4373.1 4450.3 4459.6 4471.6 4439.1 4442.0 4460.7 4512.8 4519.3 4240.6 4263.2 4263.6 4377.0 4385.7 4272.3 4309.5 4309.9 4311.1 4313.0 4571.8 4634.6 4638.0 4639.1 4683.0 5066.7 5069.3 5070.8 5071.1 5114.2 4899.9 4950.2 5001.7 5044.5 5156.3 4709.1 4716.4 4721.4 4726.3 4788.6 5166.7 5168.4 5170.4 5180.6 5227.4 4702.1 4739.9 4852.7 4937.3 5004.0 4971.6 5050.2 5052.8 5087.6 5121.8 5014.1 5036.3 5037.9 5040.2 5090.2 4866.1 4926.0 4981.8 4984.0 5043.3 3908.2 3938.9 3940.1 3962.7 3998.4 3501.1 3503.5 3506.8 3544.1 3547.7 4404.3 4418.8 4418.9 4419.4 4472.1 4882.6 4926.8 4968.7 4999.8 5002.4 4333.2 4337.6 4337.7 4373.4 4392.4 4471.4 4475.9 4476.8 4479.0 4533.1 4656.1 4667.2 4713.9 4788.7 4792.6 5044.2 5048.3 5053.1 5056.6 5058.8 4780.2 4782.6 4785.4 4788.3 4790.0 4972.2 4977.4 4978.7 4980.1 4980.1 5025.8 5033.1 5039.5 5040.9 5043.4 4877.2 4937.5 4942.1 4943.5 4944.1 4851.4 4855.0 4857.7 4929.4 4951.3 4869.6 4871.3 4878.5 4880.7 4918.9 4817.9 4869.1 4900.8 4939.3 5013.6 4571.7 4615.0 4621.5 4622.3 4904.7 21:41:17 INFO - PROCESS | 6537 | 21:41:17 INFO - PROCESS | 6537 | [#1] ext.html Cycles:180 Average:45224.53 Median:35221.47 stddev:81665.42 (231.9%) stddev-sans-first:81825.61 21:41:17 INFO - PROCESS | 6537 | Values: 544.9 546.1 553.4 558.7 560.1 37492.3 39223.0 39291.8 39477.0 43552.0 40766.4 41233.4 41280.0 41286.2 41304.0 7500.0 7632.4 7635.5 7638.0 7639.7 7513.9 7601.6 7604.1 7609.0 7656.5 7601.0 7641.1 7641.8 7647.8 7701.2 7586.2 7604.2 7605.8 7684.2 7689.1 7525.7 7635.5 7639.2 7640.0 7640.7 38412.2 38768.6 38837.0 38849.8 38865.0 2866.2 3002.5 3078.0 3081.1 3320.5 28305.9 28522.6 28617.7 28838.1 29114.4 3323.3 3349.5 3390.8 3449.9 3515.5 242135.0 244774.0 244850.8 245180.0 245736.0 52577.5 52907.5 52959.2 52988.5 53153.0 31841.8 32848.0 33037.8 35492.0 35633.8 12984.1 13100.3 13106.6 13114.1 13117.0 10273.9 10397.6 10460.9 10464.5 10467.3 17801.0 17842.0 17880.0 17960.7 18070.8 6820.7 6928.3 6998.8 7013.3 7034.6 779.9 884.4 909.7 942.7 1017.7 27121.3 27215.7 27679.2 28150.9 28231.2 926.8 945.1 945.7 981.9 995.4 14233.3 14857.3 14945.2 14982.9 15076.9 379290.0 379391.0 380872.0 381304.0 384298.0 47587.4 48344.0 48396.3 48416.0 48471.0 1044.4 1064.3 1117.2 1147.4 1170.9 26400.2 28642.9 29519.1 29653.7 29923.4 36114.1 36545.0 36590.8 36608.0 36626.3 288248.6 289878.0 290037.0 290134.0 290226.0 21532.9 22211.0 23525.3 24635.9 24872.9 40313.5 40528.2 40926.2 41071.0 41553.6 34221.7 34849.0 35214.3 35681.0 36004.3 34367.0 34376.0 34741.0 34860.5 35228.6 33972.5 34180.1 34665.8 34828.3 35028.6 30097.8 32104.0 32258.8 32391.2 32497.2 23980.5 24162.7 24620.4 24658.1 25727.4 21:41:17 INFO - PROCESS | 6537 | 21:41:17 INFO - PROCESS | 6537 | [#2] jquery.html Cycles:180 Average:22702.69 Median:45167.73 stddev:57636.08 (127.6%) stddev-sans-first:57773.31 21:41:17 INFO - PROCESS | 6537 | Values: 342.9 366.5 374.4 375.9 385.2 12337.3 15877.7 16260.5 16338.0 17295.8 15303.8 15694.1 16935.3 17027.9 17113.0 4971.5 4988.6 5131.1 5175.1 5200.8 3569.5 3771.7 5068.2 5163.1 5165.9 5627.1 5904.1 5920.2 6049.6 6050.1 5797.2 5968.7 6002.0 6038.6 6051.9 5279.3 5288.1 5288.1 5289.5 5290.9 17947.6 19970.1 20265.8 20490.6 20699.6 1857.2 1877.6 1915.0 2255.5 2416.7 8819.3 8977.2 9253.0 9487.9 9495.1 1655.5 1678.9 1706.9 1766.1 1785.6 67530.3 68368.0 68452.3 70009.3 71042.6 9333.8 9519.4 9779.2 9784.8 9891.6 13483.9 13490.8 13538.0 13552.3 13554.3 6293.6 6487.4 6683.5 6722.6 6741.9 5973.1 6022.9 6217.9 6236.4 6263.7 4183.5 4199.7 4240.4 4287.6 4333.6 1714.5 1771.4 1787.4 1840.0 1855.7 794.5 805.2 834.4 850.8 891.7 15918.9 17150.9 17220.9 17340.3 17590.4 795.2 808.6 820.5 860.3 866.6 9252.0 9309.2 9628.4 9663.4 9806.8 345043.0 345671.0 349397.0 350976.0 351437.0 45282.5 70782.3 72427.3 73049.0 74864.6 897.2 914.0 914.6 920.2 946.9 15302.4 15413.3 15812.4 16164.6 16513.1 36573.5 36795.8 37091.4 38026.2 38058.6 42882.4 45052.9 50861.5 50888.5 52407.7 4677.4 5500.8 7077.5 7498.6 7515.9 10772.5 11823.1 11936.3 12441.8 12476.0 9677.0 10407.5 10458.4 10797.0 10946.7 9990.1 10218.5 10376.4 10473.3 10604.2 10372.2 10450.4 10563.8 10649.9 10848.9 7417.0 7495.4 7686.5 7691.6 7760.7 9506.5 10233.5 10512.3 10709.8 10752.6 21:41:17 INFO - PROCESS | 6537 | 21:41:17 INFO - PROCESS | 6537 | [#3] mootools.html Cycles:180 Average:4836.13 Median:5724.79 stddev:2730.83 (47.7%) stddev-sans-first:2724.64 21:41:17 INFO - PROCESS | 6537 | Values: 1175.9 1284.3 1325.0 1336.2 1618.5 6504.8 7222.3 7525.1 7528.9 7770.9 7564.4 7641.0 7644.5 7646.7 7648.8 2099.1 2123.0 2123.2 2123.6 2125.9 2027.2 2027.4 2030.9 2035.9 2091.9 2041.5 2057.0 2067.8 2069.1 2075.1 1998.5 2009.9 2014.1 2016.8 2017.3 1987.1 1990.1 2017.5 2024.1 2025.6 7380.9 7504.0 7558.0 7606.7 7615.3 4107.0 4296.7 4300.8 4302.0 4304.5 2646.7 2738.0 2804.5 2811.4 2813.5 851.4 877.3 877.7 1705.8 1750.9 9869.6 9997.7 10139.7 10140.8 10171.3 3732.4 3819.2 3832.5 3958.0 3985.2 8075.7 8090.2 8107.7 8117.4 8124.2 4122.8 4150.5 4150.5 4162.7 4167.2 3285.6 3384.6 3633.3 3855.6 3865.9 3120.4 3132.8 3220.7 3280.4 3283.2 966.1 966.6 971.0 972.7 974.2 658.5 742.1 787.4 811.6 852.3 5009.1 5078.6 5084.7 5110.5 5241.9 788.9 814.1 828.4 854.0 915.5 3357.5 3389.9 3420.7 3423.0 3524.3 9114.8 9482.2 9492.9 9501.8 9504.9 9239.3 9259.8 9338.7 9349.2 9427.4 6993.3 7026.5 7034.7 7126.9 7138.9 4769.6 4906.8 4979.2 5024.2 5129.4 8310.1 8475.3 8478.8 8480.0 8519.5 8148.8 8433.9 8448.4 8602.7 8698.0 5520.2 6289.7 6432.7 6435.6 6438.9 5974.6 6131.5 6154.2 6159.1 6166.9 6225.3 6261.0 6493.7 6496.9 6520.3 6443.0 6517.0 6549.2 6556.2 6562.0 5929.4 6051.7 6052.7 6052.8 6057.5 4179.6 4223.9 4232.4 4299.9 4317.9 4332.4 4377.3 4411.9 4558.3 4629.6 21:41:17 INFO - PROCESS | 6537 | 21:41:17 INFO - PROCESS | 6537 | [#4] prototype.html Cycles:180 Average:4130.01 Median:4686.57 stddev:1195.39 (25.5%) stddev-sans-first:1163.18 21:41:17 INFO - PROCESS | 6537 | Values: 273.8 275.5 279.4 283.7 291.2 4588.6 4759.6 4760.6 4785.1 4804.8 4526.4 4652.0 4674.0 4678.9 4702.6 3734.9 3738.0 3745.9 3750.3 3756.1 3544.4 3600.1 3743.0 3754.7 3759.8 3500.8 3708.3 3723.1 3724.8 3738.9 3712.7 3716.6 3725.5 3726.1 3726.4 3284.3 3284.8 3289.6 3289.8 3294.2 4536.9 4561.9 4606.1 4638.9 4669.6 4209.7 4211.5 4212.3 4213.0 4218.3 4936.9 4941.5 4957.6 4957.8 4958.0 3466.5 3511.3 3559.5 3567.3 3567.7 5144.8 5146.4 5157.3 5167.2 5169.5 3630.2 3634.9 3635.9 3649.9 3663.5 3696.7 3705.6 3712.3 3736.3 3738.5 4106.3 4171.6 4198.2 4222.2 4238.4 4924.8 4935.2 4941.8 4947.8 4952.8 1200.8 1239.3 1267.6 1278.5 1284.4 863.1 886.7 894.3 898.2 900.4 4407.2 4429.5 4431.2 4445.9 4453.6 5032.6 5046.6 5056.2 5075.4 5077.7 4271.2 4412.5 4501.9 4516.4 4545.5 2707.6 2728.3 2734.1 2739.2 2739.2 4870.0 4886.5 4892.3 4912.5 4913.7 5112.4 5193.4 5242.2 5247.9 5269.6 4880.7 4885.8 4886.6 4889.7 4897.8 4977.3 5110.4 5118.8 5122.0 5153.4 4990.4 5011.9 5034.3 5053.6 5062.2 4837.0 4845.3 4856.4 4864.5 4881.3 3493.3 3495.8 3497.4 3497.6 3503.4 4953.3 5059.8 5106.9 5123.7 5125.6 4923.3 4948.4 4979.2 4986.2 5010.8 4979.5 4987.9 4997.0 5002.3 5007.5 4670.4 4694.2 4789.6 4863.2 4900.0 4835.8 4981.3 4987.7 4997.7 4999.0 4865.3 4876.8 4882.6 4883.0 4891.7 21:41:17 INFO - PROCESS | 6537 | 21:41:17 INFO - PROCESS | 6537 | [#5] yui.html Cycles:180 Average:16385.07 Median:25275.45 stddev:22799.04 (90.2%) stddev-sans-first:22832.32 21:41:17 INFO - PROCESS | 6537 | Values: 636.2 643.4 673.4 681.1 721.6 12030.0 12892.5 12931.2 12955.1 12960.8 11956.1 11967.3 11974.6 11974.7 11994.2 620.1 637.2 746.2 756.8 776.4 775.3 779.3 780.4 780.9 781.4 832.7 838.2 838.5 839.1 840.3 644.6 662.3 825.3 825.9 826.4 580.0 593.5 596.5 598.4 598.9 13046.7 13075.2 13089.5 13094.1 13102.3 11879.4 12231.5 12282.8 12494.0 12986.1 11655.5 11736.6 11754.1 11910.7 12060.9 4080.5 4096.3 4102.5 4299.9 4301.9 60480.3 61639.0 61686.4 62457.4 62942.0 9843.8 9998.2 10202.6 10248.9 10564.0 16936.3 16939.1 17110.7 17165.1 17287.2 6708.3 6761.6 6837.3 7021.0 7026.9 3579.2 3640.1 3686.7 3815.0 3829.9 2648.9 2708.9 2740.8 2741.0 2743.9 493.3 542.0 567.7 568.5 583.3 525.0 550.2 565.1 616.4 617.6 8075.7 8462.8 8603.9 8936.0 9303.6 496.4 516.9 557.5 589.8 602.1 3936.6 4015.2 4205.5 4232.5 4322.6 97707.5 98336.6 99949.0 101442.0 101620.5 46228.3 46984.8 47283.0 49504.0 81623.0 53322.7 73166.0 73643.6 73788.6 74583.0 7420.3 8782.8 8993.9 9055.6 9233.2 29941.9 30302.4 32430.7 36237.3 40515.8 49562.8 50114.2 51552.7 56764.7 57909.0 11005.0 11374.9 11396.3 11417.3 11466.5 13313.8 13389.7 13558.8 13606.9 13639.0 12433.0 12479.9 12563.8 12682.6 13268.8 11731.8 12100.2 12481.5 13048.1 13223.5 12079.7 12143.5 12236.7 12428.5 12725.2 9625.2 9716.0 9957.9 10277.8 10380.1 9915.0 10402.5 10593.6 10657.7 10868.7 21:41:17 INFO - PROCESS | 6537 | -------- Summary: end -------- 21:41:17 INFO - PROCESS | 6537 | 21:41:18 INFO - TEST-INFO | 6537: exit 0 21:41:18 INFO - TEST-OK | dromaeo_css | took 1123121ms 21:41:18 INFO - TEST-START | kraken 21:41:18 INFO - operating with platform_type : linux_ 21:41:18 INFO - Initialising browser for kraken test... 21:41:18 INFO - TEST-INFO | started process 6837 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpheTwbz/profile http://localhost:57416/getInfo.html) 21:41:22 INFO - PROCESS | 6837 | __metrics Screen width/height:1600/1200 21:41:22 INFO - PROCESS | 6837 | colorDepth:24 21:41:22 INFO - PROCESS | 6837 | Browser inner width/height: 1024/697 21:41:22 INFO - PROCESS | 6837 | __metrics 21:41:23 INFO - PROCESS | 6837 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:41:23 INFO - PROCESS | 6837 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:41:23 INFO - PROCESS | 6837 | console.error: PushService: 21:41:23 INFO - PROCESS | 6837 | stateChangeProcessEnqueue: Error transitioning state 21:41:23 INFO - PROCESS | 6837 | UnknownError 21:41:24 INFO - TEST-INFO | 6837: exit 0 21:41:24 INFO - Browser initialized. 21:41:24 INFO - Running cycle 1/1 for kraken test... 21:41:24 INFO - TEST-INFO | started process 6917 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpheTwbz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:41:36 INFO - PROCESS | 6917 | RSS: Main: 175198208 21:41:36 INFO - PROCESS | 6917 | 21:41:39 INFO - PROCESS | 6917 | Cycle 1(1): loaded http://localhost:57416/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57416/tests/kraken/driver.html?testName=audio-beat-detection) 21:41:40 INFO - PROCESS | 6917 | RSS: Main: 242434048 21:41:40 INFO - PROCESS | 6917 | 21:41:43 INFO - PROCESS | 6917 | Cycle 1(1): loaded http://localhost:57416/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57416/tests/kraken/driver.html?testName=audio-dft) 21:41:43 INFO - PROCESS | 6917 | RSS: Main: 219049984 21:41:43 INFO - PROCESS | 6917 | 21:41:47 INFO - PROCESS | 6917 | Cycle 1(1): loaded http://localhost:57416/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57416/tests/kraken/driver.html?testName=audio-fft) 21:41:47 INFO - PROCESS | 6917 | RSS: Main: 300703744 21:41:47 INFO - PROCESS | 6917 | 21:41:49 INFO - PROCESS | 6917 | Cycle 1(1): loaded http://localhost:57416/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57416/tests/kraken/driver.html?testName=audio-oscillator) 21:41:50 INFO - PROCESS | 6917 | RSS: Main: 211570688 21:41:50 INFO - PROCESS | 6917 | 21:41:52 INFO - PROCESS | 6917 | Cycle 1(1): loaded http://localhost:57416/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57416/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:41:53 INFO - PROCESS | 6917 | RSS: Main: 214716416 21:41:53 INFO - PROCESS | 6917 | 21:41:56 INFO - PROCESS | 6917 | Cycle 1(1): loaded http://localhost:57416/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57416/tests/kraken/driver.html?testName=imaging-darkroom) 21:41:57 INFO - PROCESS | 6917 | RSS: Main: 250892288 21:41:57 INFO - PROCESS | 6917 | 21:42:00 INFO - PROCESS | 6917 | Cycle 1(1): loaded http://localhost:57416/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57416/tests/kraken/driver.html?testName=imaging-desaturate) 21:42:01 INFO - PROCESS | 6917 | RSS: Main: 249589760 21:42:01 INFO - PROCESS | 6917 | 21:42:04 INFO - PROCESS | 6917 | Cycle 1(1): loaded http://localhost:57416/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57416/tests/kraken/driver.html?testName=json-parse-financial) 21:42:04 INFO - PROCESS | 6917 | RSS: Main: 249708544 21:42:04 INFO - PROCESS | 6917 | 21:42:06 INFO - PROCESS | 6917 | Cycle 1(1): loaded http://localhost:57416/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57416/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:42:07 INFO - PROCESS | 6917 | RSS: Main: 212094976 21:42:07 INFO - PROCESS | 6917 | 21:42:08 INFO - PROCESS | 6917 | Cycle 1(1): loaded http://localhost:57416/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57416/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:42:09 INFO - PROCESS | 6917 | RSS: Main: 220327936 21:42:09 INFO - PROCESS | 6917 | 21:42:11 INFO - PROCESS | 6917 | Cycle 1(1): loaded http://localhost:57416/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57416/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:42:12 INFO - PROCESS | 6917 | RSS: Main: 228659200 21:42:12 INFO - PROCESS | 6917 | 21:42:15 INFO - PROCESS | 6917 | Cycle 1(1): loaded http://localhost:57416/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57416/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:42:15 INFO - PROCESS | 6917 | RSS: Main: 237305856 21:42:15 INFO - PROCESS | 6917 | 21:42:18 INFO - PROCESS | 6917 | Cycle 1(1): loaded http://localhost:57416/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57416/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:42:19 INFO - PROCESS | 6917 | RSS: Main: 234463232 21:42:19 INFO - PROCESS | 6917 | 21:42:21 INFO - PROCESS | 6917 | Cycle 1(1): loaded http://localhost:57416/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57416/tests/kraken/driver.html?testName=ai-astar) 21:42:21 INFO - PROCESS | 6917 | RSS: Main: 284524544 21:42:21 INFO - PROCESS | 6917 | 21:42:21 INFO - PROCESS | 6917 | __start_tp_report 21:42:21 INFO - PROCESS | 6917 | _x_x_mozilla_page_load 21:42:21 INFO - PROCESS | 6917 | _x_x_mozilla_page_load_details 21:42:21 INFO - PROCESS | 6917 | |i|pagename|runs| 21:42:21 INFO - PROCESS | 6917 | |0;ai-astar;114;115;116;116;115;117;115;115;118;115 21:42:21 INFO - PROCESS | 6917 | |1;audio-beat-detection;152;131;129;174;127;126;131;125;160;132 21:42:21 INFO - PROCESS | 6917 | |2;audio-dft;161;162;162;161;164;164;162;162;160;160 21:42:21 INFO - PROCESS | 6917 | |3;audio-fft;75;75;76;105;76;77;77;76;118;77 21:42:21 INFO - PROCESS | 6917 | |4;audio-oscillator;85;83;127;84;85;83;106;82;82;113 21:42:21 INFO - PROCESS | 6917 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;117;117 21:42:21 INFO - PROCESS | 6917 | |6;imaging-darkroom;146;147;146;146;146;148;147;146;147;146 21:42:21 INFO - PROCESS | 6917 | |7;imaging-desaturate;96;96;95;95;95;95;96;96;95;94 21:42:21 INFO - PROCESS | 6917 | |8;json-parse-financial;66;64;64;64;68;65;64;65;64;65 21:42:21 INFO - PROCESS | 6917 | |9;json-stringify-tinderbox;67;68;67;67;67;67;67;68;67;68 21:42:21 INFO - PROCESS | 6917 | |10;stanford-crypto-aes;85;84;85;84;84;84;84;83;83;83 21:42:21 INFO - PROCESS | 6917 | |11;stanford-crypto-ccm;146;140;143;147;148;150;147;144;182;146 21:42:21 INFO - PROCESS | 6917 | |12;stanford-crypto-pbkdf2;185;178;176;180;185;172;177;178;176;177 21:42:21 INFO - PROCESS | 6917 | |13;stanford-crypto-sha256-iterative;70;69;69;70;70;72;73;74;70;69 21:42:21 INFO - PROCESS | 6917 | __end_tp_report 21:42:21 INFO - PROCESS | 6917 | __start_cc_report 21:42:21 INFO - PROCESS | 6917 | _x_x_mozilla_cycle_collect,1945 21:42:21 INFO - PROCESS | 6917 | __end_cc_report 21:42:21 INFO - PROCESS | 6917 | __startTimestamp1475815341647__endTimestamp 21:42:21 INFO - PROCESS | 6917 | 21:42:21 INFO - PROCESS | 6917 | ------- Summary: start ------- 21:42:21 INFO - PROCESS | 6917 | Number of tests: 14 21:42:21 INFO - PROCESS | 6917 | 21:42:21 INFO - PROCESS | 6917 | [#0] ai-astar Cycles:10 Average:115.60 Median:115.50 stddev:1.17 (1.0%) stddev-sans-first:1.09 21:42:21 INFO - PROCESS | 6917 | Values: 114.0 115.0 116.0 116.0 115.0 117.0 115.0 115.0 118.0 115.0 21:42:21 INFO - PROCESS | 6917 | 21:42:21 INFO - PROCESS | 6917 | [#1] audio-beat-detection Cycles:10 Average:138.70 Median:131.50 stddev:17.06 (13.0%) stddev-sans-first:17.41 21:42:21 INFO - PROCESS | 6917 | Values: 152.0 131.0 129.0 174.0 127.0 126.0 131.0 125.0 160.0 132.0 21:42:21 INFO - PROCESS | 6917 | 21:42:21 INFO - PROCESS | 6917 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.40 (0.9%) stddev-sans-first:1.45 21:42:21 INFO - PROCESS | 6917 | Values: 161.0 162.0 162.0 161.0 164.0 164.0 162.0 162.0 160.0 160.0 21:42:21 INFO - PROCESS | 6917 | 21:42:21 INFO - PROCESS | 6917 | [#3] audio-fft Cycles:10 Average:83.20 Median:76.00 stddev:15.24 (20.1%) stddev-sans-first:15.88 21:42:21 INFO - PROCESS | 6917 | Values: 75.0 75.0 76.0 105.0 76.0 77.0 77.0 76.0 118.0 77.0 21:42:21 INFO - PROCESS | 6917 | 21:42:21 INFO - PROCESS | 6917 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:83.00 stddev:16.25 (19.6%) stddev-sans-first:16.97 21:42:21 INFO - PROCESS | 6917 | Values: 85.0 83.0 127.0 84.0 85.0 83.0 106.0 82.0 82.0 113.0 21:42:21 INFO - PROCESS | 6917 | 21:42:21 INFO - PROCESS | 6917 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 21:42:21 INFO - PROCESS | 6917 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 21:42:21 INFO - PROCESS | 6917 | 21:42:21 INFO - PROCESS | 6917 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 21:42:21 INFO - PROCESS | 6917 | Values: 146.0 147.0 146.0 146.0 146.0 148.0 147.0 146.0 147.0 146.0 21:42:21 INFO - PROCESS | 6917 | 21:42:21 INFO - PROCESS | 6917 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 21:42:21 INFO - PROCESS | 6917 | Values: 96.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 94.0 21:42:21 INFO - PROCESS | 6917 | 21:42:21 INFO - PROCESS | 6917 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:1.29 (2.0%) stddev-sans-first:1.30 21:42:21 INFO - PROCESS | 6917 | Values: 66.0 64.0 64.0 64.0 68.0 65.0 64.0 65.0 64.0 65.0 21:42:21 INFO - PROCESS | 6917 | 21:42:21 INFO - PROCESS | 6917 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 21:42:21 INFO - PROCESS | 6917 | Values: 67.0 68.0 67.0 67.0 67.0 67.0 67.0 68.0 67.0 68.0 21:42:21 INFO - PROCESS | 6917 | 21:42:21 INFO - PROCESS | 6917 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:0.74 (0.9%) stddev-sans-first:0.67 21:42:21 INFO - PROCESS | 6917 | Values: 85.0 84.0 85.0 84.0 84.0 84.0 84.0 83.0 83.0 83.0 21:42:21 INFO - PROCESS | 6917 | 21:42:21 INFO - PROCESS | 6917 | [#11] stanford-crypto-ccm Cycles:10 Average:149.30 Median:147.00 stddev:11.82 (8.0%) stddev-sans-first:12.48 21:42:21 INFO - PROCESS | 6917 | Values: 146.0 140.0 143.0 147.0 148.0 150.0 147.0 144.0 182.0 146.0 21:42:21 INFO - PROCESS | 6917 | 21:42:21 INFO - PROCESS | 6917 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.40 Median:178.00 stddev:4.03 (2.3%) stddev-sans-first:3.50 21:42:21 INFO - PROCESS | 6917 | Values: 185.0 178.0 176.0 180.0 185.0 172.0 177.0 178.0 176.0 177.0 21:42:21 INFO - PROCESS | 6917 | 21:42:21 INFO - PROCESS | 6917 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:70.00 stddev:1.78 (2.5%) stddev-sans-first:1.87 21:42:21 INFO - PROCESS | 6917 | Values: 70.0 69.0 69.0 70.0 70.0 72.0 73.0 74.0 70.0 69.0 21:42:21 INFO - PROCESS | 6917 | -------- Summary: end -------- 21:42:21 INFO - PROCESS | 6917 | 21:42:22 INFO - TEST-INFO | 6917: exit 0 21:42:23 INFO - TEST-OK | kraken | took 64810ms 21:42:23 INFO - SUITE-END | took 1187s 21:42:23 INFO - Completed test suite (00:19:48) 21:42:23 INFO - javascript benchmark 21:42:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2558.5266725655756, 2582.715901250863, 2624.553825849606, 2630.105764040226, 2642.1941307901093, 4561.475430325513, 4629.560191781784, 4717.693349932252, 4742.099001189776, 4756.239001759719, 4653.115907977482, 4674.7428891410955, 4680.836170734025, 4717.716936983783, 4806.014766972771, 4350.0, 4378.014946637013, 4393.978030109845, 4401.22978478765, 4415.0066235097165, 4160.230357383879, 4373.147236288925, 4450.26570615848, 4459.598636122749, 4471.597556219956, 4439.112177564484, 4441.977790111045, 4460.687751857371, 4512.751798651073, 4519.27691569349, 4240.639545638624, 4263.189993901149, 4263.616274535307, 4377.015171586399, 4385.714928529667, 4272.273713468718, 4309.482862056573, 4309.913801723979, 4311.094670119279, 4313.029568347097, 4571.817127314904, 4634.582887540104, 4637.95362046382, 4639.095376401603, 4683.0, 5066.746662666852, 5069.290299358093, 5070.822521211777, 5071.137906555894, 5114.207297868837, 4899.926501102486, 4950.232713929347, 5001.72490513018, 5044.495550444926, 5156.303898973628, 4709.058188362341, 4716.3632909557455, 4721.433427988663, 4726.291056341576, 4788.640851936049, 5166.741662916839, 5168.431472538018, 5170.353705786777, 5180.611454140954, 5227.3988491323225, 4702.059588082398, 4739.886126760209, 4852.733099679552, 4937.308776771255, 5004.049230646166, 4971.552560269521, 5050.217216331474, 5052.797888084509, 5087.618428617869, 5121.769520371592, 5014.147594908874, 5036.294918711384, 5037.874053148701, 5040.218766091261, 5090.211017292326, 4866.0511200316305, 4925.975370123127, 4981.750912454363, 4984.028114517707, 5043.293938848564, 3908.179282350681, 3938.9212215755524, 3940.054386947112, 3962.663173630274, 3998.3602623580086, 3501.124718820295, 3503.5270238517983, 3506.7545271830727, 3544.0608238816735, 3547.6807087362263, 4404.317330813729, 4418.80115394808, 4418.889527761831, 4419.381286619876, 4472.08322293929, 4882.584980276645, 4926.75366231687, 4968.677035992649, 4999.800007999639, 5002.399712034579, 4333.198358303661, 4337.566243375637, 4337.6963612546815, 4373.431453910971, 4392.4289842320295, 4471.374007638933, 4475.888102797391, 4476.798544065525, 4478.984456994365, 4533.116042371706, 4656.115338085753, 4667.206574882211, 4713.858584242478, 4788.712677239377, 4792.568668819823, 5044.218146187347, 5048.318477005704, 5053.11570475158, 5056.64603477753, 5058.848234552969, 4780.187368147493, 4782.641301902302, 4785.353977213171, 4788.3056956741775, 4790.0, 4972.179590367549, 4977.377827771528, 4978.701277923336, 4980.103581355391, 4980.128477516492, 5025.824096156617, 5033.094043072282, 5039.470855560114, 5040.924386134137, 5043.420006699276, 4877.219644856806, 4937.481564435682, 4942.085714142895, 4943.530364615356, 4944.134776414185, 4851.442084160367, 4854.95145048545, 4857.732824694534, 4929.433115191656, 4951.331570238116, 4869.586085182799, 4871.318015477765, 4878.487758785276, 4880.682755620874, 4918.852434426973, 4817.927731083966, 4869.074875773592, 4900.828471003498, 4939.28380384835, 5013.598912087097, 4571.725696458223, 4615.0, 4621.537846215486, 4622.329762184531, 4904.7302398367], "value": 4600.833867167674, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.9046416877048, 546.0662267522537, 553.4050895287567, 558.7206396801598, 560.1206106412933, 37492.25015499692, 39223.0, 39291.803540982255, 39477.0, 43552.0, 40766.388504172464, 41233.38149927754, 41280.0, 41286.174276514525, 41304.0, 7499.962500187505, 7632.389408847279, 7635.541867487968, 7638.0, 7639.6944122235045, 7513.887291690629, 7601.619919004028, 7604.125525564548, 7608.961955190216, 7656.502327348704, 7601.049868766404, 7641.121271053817, 7641.808954776119, 7647.808804779869, 7701.152873183945, 7586.203448637896, 7604.239576042407, 7605.771826845204, 7684.193159718205, 7689.115751688571, 7525.736599219001, 7635.503692259986, 7639.236076392372, 7640.0, 7640.656170472342, 38412.23175536474, 38768.61231387678, 38837.0, 38849.80575097135, 38865.0, 2866.1831378057154, 3002.534607135897, 3077.9692203077907, 3081.1372815611667, 3320.5185248138882, 28305.85847070772, 28522.572161417596, 28617.71382286171, 28838.134855954355, 29114.41771164586, 3323.3353329333986, 3349.480830471281, 3390.847411866472, 3449.9310013799836, 3515.542979412686, 242135.0, 244774.0, 244850.77574612192, 245180.0, 245736.0, 52577.474225257254, 52907.470925291025, 52959.20561191585, 52988.470115299126, 53153.0, 31841.840790795897, 32848.0, 33037.83481082579, 35492.0, 35633.8218308912, 12984.091113621957, 13100.344982750825, 13106.60680179596, 13114.082014259102, 13117.0, 10273.897261027443, 10397.584096636201, 10460.895391045991, 10464.476776161313, 10467.267291289536, 17801.0, 17842.01868897223, 17880.0, 17960.730589041174, 18070.819291807176, 6820.658967051628, 6928.307169283132, 6998.825029374307, 7013.2986701329455, 7034.6130962796515, 779.9376049915993, 884.3765145572356, 909.7088931541844, 942.7218970403748, 1017.6692574913183, 27121.321966950985, 27215.727842721717, 27679.169624911287, 28150.85924570364, 28231.15306540807, 926.7961048569304, 945.0785484153033, 945.6784693204344, 981.8821741390936, 995.3878364805737, 14233.28833558318, 14857.331420086122, 14945.202902711477, 14982.850171498363, 15076.929209183612, 379290.0, 379391.0, 380872.0, 381304.0, 384298.0, 47587.38601823692, 48344.0, 48396.27405588919, 48416.0, 48471.0, 1044.4464433850071, 1064.2869277584036, 1117.1677100560134, 1147.3517462633586, 1170.9414529273502, 26400.207993760218, 28642.85678571594, 29519.142480737995, 29653.703462965095, 29923.401531968804, 36114.09714757152, 36545.0, 36590.8170459146, 36608.0, 36626.26747465089, 288248.55875720485, 289878.0, 290037.0, 290134.0, 290226.0, 21532.89233553822, 22211.0, 23525.294241172793, 24635.8768206165, 24872.875635621705, 40313.52304832909, 40528.18943621052, 40926.18147636971, 41071.0, 41553.58446415497, 34221.65778342185, 34849.0, 35214.29571408506, 35681.0, 36004.27991440209, 34367.0, 34376.0, 34741.0, 34860.47709284312, 35228.647713522536, 33972.49041264334, 34180.14549636279, 34665.82667086648, 34828.303433930676, 35028.64971350356, 30097.84951075318, 32104.0, 32258.83870580632, 32391.190220244684, 32497.187570309987, 23980.520389591762, 24162.678239305642, 24620.38449038717, 24658.136965206133, 25727.356816079748], "value": 16842.13370132602, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.9146750534558, 366.52901022186495, 374.36545056129864, 375.91541903071806, 385.22569635033574, 12337.25976441413, 15877.68244635108, 16260.512184634465, 16338.0, 17295.82704172958, 15303.846961530382, 15694.136822474758, 16935.3225870965, 17027.91486042568, 17113.0, 4971.477994810538, 4988.600911927056, 5131.076406246874, 5175.120229560984, 5200.791968321281, 3569.4824250483666, 3771.7359784815076, 5068.163752980754, 5163.1480805667015, 5165.9225111623355, 5627.099664053752, 5904.0553511438175, 5920.171176035358, 6049.637021778707, 6050.092486127072, 5797.159411885253, 5968.731407086648, 6002.039673652194, 6038.607490513103, 6051.909221361683, 5279.340082489689, 5288.10102282609, 5288.101022826128, 5289.497497737709, 5290.867728306823, 17947.641047178982, 19970.10134543949, 20265.797342026537, 20490.5901881963, 20699.5860082799, 1857.1921214271836, 1877.558773688182, 1915.0137679095278, 2255.526339468697, 2416.6979127609047, 8819.29445644347, 8977.192052715222, 9253.0, 9487.857682134774, 9495.05049495052, 1655.5447252005674, 1678.8992660440413, 1706.9146542672818, 1766.1081154017138, 1785.57146284892, 67530.3246967529, 68368.0, 68452.31547684509, 70009.2999070008, 71042.64478677574, 9333.766655833522, 9519.428834269966, 9779.168770654574, 9784.804303914025, 9891.60433582663, 13483.932580337232, 13490.797638035438, 13538.0, 13552.289542091621, 13554.254516001518, 6293.590916590407, 6487.448566871774, 6683.532152749358, 6722.5798712463475, 6741.8651626967185, 5973.104034394875, 6022.909656355158, 6217.875642487125, 6236.438720515175, 6263.655498947511, 4183.5398106208295, 4199.68502362324, 4240.406343111967, 4287.571242875688, 4333.631641310524, 1714.5113642611796, 1771.3526420428866, 1787.356551641408, 1839.981600184008, 1855.6752568300494, 794.4716763352421, 805.2229598437536, 834.4242472693821, 850.7660393391867, 891.7101941868918, 15918.92040539813, 17150.914245428692, 17220.913895430444, 17340.30638774435, 17590.38433654816, 795.1928792275845, 808.5714571277115, 820.4830956497368, 860.337540094124, 866.5623859950684, 9251.953740231256, 9309.162175404246, 9628.374155679858, 9663.420194788336, 9806.803863922682, 345043.0, 345671.0, 349397.0, 350976.0, 351437.0, 45282.54717452849, 70782.2921770786, 72427.27572724206, 73049.0, 74864.62567687126, 897.1566727276339, 914.0402577293814, 914.5610107148606, 920.1718453392001, 946.8532377481501, 15302.395477752048, 15413.306401212196, 15812.367505300119, 16164.595885102966, 16513.091779952218, 36573.45139822851, 36795.81602091972, 37091.443628345056, 38026.239475210896, 38058.61941380661, 42882.35676464918, 45052.907276061575, 50861.491385085676, 50888.49111508838, 52407.73796130995, 4677.368555244999, 5500.834974950758, 7077.504574679723, 7498.58757768328, 7515.924840751522, 10772.461376930965, 11823.052562391877, 11936.343501107174, 12441.813372799596, 12476.0, 9676.95161524216, 10407.47962601882, 10458.424786636808, 10797.028267455968, 10946.671599852018, 9990.100890919852, 10218.540165692413, 10376.429296388771, 10473.31923424975, 10604.204684648836, 10372.222083343628, 10450.42522661261, 10563.788724225626, 10649.8935010652, 10848.891511085103, 7417.0, 7495.43784216175, 7686.46194766361, 7691.615419228904, 7760.68957241704, 9506.47714375716, 10233.48832558384, 10512.26414151002, 10709.839352409565, 10752.569897204337], "value": 8020.906087371267, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1175.9294442333467, 1284.3385656386959, 1325.0261058122278, 1336.2183122873118, 1618.5225358519235, 6504.804855854326, 7222.277772222782, 7525.096988361404, 7528.924710752891, 7770.883436748439, 7564.357029652486, 7641.044869391326, 7644.46488745788, 7646.6941322347175, 7648.770536883889, 2099.128861522466, 2123.034019521122, 2123.225022866658, 2123.5646692428013, 2125.90433430496, 2027.2296527319672, 2027.401916434648, 2030.9187632494682, 2035.928742494013, 2091.9267825626107, 2041.510037590975, 2056.979430205701, 2067.8138967492923, 2069.0689189864547, 2075.0973326602902, 1998.4903849518425, 2009.8693584916934, 2014.1339224133617, 2016.7781544030145, 2017.2838642281924, 1987.076009655517, 1990.1044529961575, 2017.4956260934766, 2024.068928292987, 2025.584755125196, 7380.926190738078, 7504.0, 7558.01745773046, 7606.733764318277, 7615.31462168402, 4107.0, 4296.656267498593, 4300.827966881321, 4302.0, 4304.548022457629, 2646.655934728473, 2737.986310068457, 2804.5232310507263, 2811.409603983166, 2813.4935711571907, 851.3614788908319, 877.32007694037, 877.6884206106804, 1705.7782488276569, 1750.8774385793, 9869.60521579136, 9997.700068997869, 10139.746506337327, 10140.797184056277, 10171.288009839314, 3732.42147467143, 3819.1597848473293, 3832.5400951885954, 3958.0, 3985.1830374773103, 8075.717349892726, 8090.231428014329, 8107.675692972215, 8117.391195660349, 8124.228198321268, 4122.752634841919, 4150.501939767187, 4150.522689890701, 4162.687798415131, 4167.229062623424, 3285.589301337333, 3384.6446123157207, 3633.291508155937, 3855.575886652466, 3865.903352416156, 3120.391523652866, 3132.843357832099, 3220.710136087763, 3280.442324804741, 3283.244853683618, 966.1256562810668, 966.6370417711134, 970.9514524273758, 972.7324985629009, 974.2303580171726, 658.4600627485416, 742.1242933338605, 787.4487858498959, 811.5942028985507, 852.2883392367319, 5009.12340340439, 5078.568321692697, 5084.669496482717, 5110.514501122462, 5241.872997305598, 788.9447738658354, 814.0760237130899, 828.3828547731978, 854.0264098927228, 915.4598786715869, 3357.5131605917004, 3389.9491507627404, 3420.6579342065593, 3423.0, 3524.3479956208184, 9114.772130696785, 9482.194013508792, 9492.857607135898, 9501.762455938657, 9504.857427138599, 9239.30705197113, 9259.814803703888, 9338.719838404859, 9349.158575728217, 9427.387219830689, 6993.300669932966, 7026.473014523931, 7034.718611255493, 7126.857462850714, 7138.892916606255, 4769.642276829321, 4906.790780580737, 4979.228219625964, 5024.221245706921, 5129.410117836496, 8310.127436619068, 8475.279601233964, 8478.788030299045, 8480.024797148408, 8519.488830669932, 8148.796280093045, 8433.87349189775, 8448.408611397143, 8602.655893764178, 8698.0, 5520.199571062254, 6289.7169627365965, 6432.710528026157, 6435.613863168225, 6438.871222575616, 5974.641521508724, 6131.509479241739, 6154.230721159855, 6159.1069294951085, 6166.876662466636, 6225.28409232944, 6261.043174444721, 6493.675316234075, 6496.9025464617125, 6520.282768895512, 6443.0, 6516.957286834084, 6549.181352330958, 6556.18047744032, 6562.0, 5929.377415371497, 6051.667158306335, 6052.727627256696, 6052.788152414821, 6057.485113765203, 4179.623833854967, 4223.915521689488, 4232.36514522824, 4299.935500967551, 4317.913641727211, 4332.393464914851, 4377.343398490252, 4411.889702757457, 4558.316252562142, 4629.560191781776], "value": 3902.6289409884644, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [273.84938283943825, 275.5453501722158, 279.3978975308209, 283.71203228722845, 291.2340544368311, 4588.632909367243, 4759.643026772993, 4760.642951778613, 4785.138675038496, 4804.846836759179, 4526.434195725535, 4651.9767401163035, 4674.041821426608, 4678.929816052762, 4702.623790096793, 3734.9253014939686, 3738.0, 3745.8876233712963, 3750.3436898542645, 3756.1173124315765, 3544.4328907374825, 3600.0796257589436, 3742.9893928639253, 3754.7371683982133, 3759.774413535197, 3500.824958752052, 3708.2768860072297, 3723.1250656095795, 3724.8323825427783, 3738.9065273368246, 3712.7215458840697, 3716.5540135183683, 3725.5156829612247, 3726.142987112966, 3726.4410338449447, 3284.277458959049, 3284.770066095374, 3289.5723555937575, 3289.753268504872, 3294.1929227339456, 4536.931946020813, 4561.908761824745, 4606.124836281096, 4638.933045399577, 4669.556392142741, 4209.684273679456, 4211.536730959592, 4212.283911735012, 4213.019880656087, 4218.303979843322, 4936.851894443173, 4941.516231057132, 4957.628177886637, 4957.826476073356, 4957.950420495821, 3466.480027995796, 3511.280187561569, 3559.519464872235, 3567.3411863483607, 3567.6967457766123, 5144.819931302386, 5146.3824341078935, 5157.329547158883, 5167.191482980964, 5169.475004873534, 3630.237650093457, 3634.909127271839, 3635.9091022724115, 3649.872254471134, 3663.4504824276037, 3696.7227457940226, 3705.555333360014, 3712.2575484903127, 3736.252749450121, 3738.4953031340965, 4106.322456794655, 4171.561985991488, 4198.160367926427, 4222.176675548239, 4238.36424536322, 4924.8276310328965, 4935.185694360391, 4941.777620007108, 4947.777350019258, 4952.777125029383, 1200.7958647030025, 1239.3431481314917, 1267.6070418170398, 1278.5013844600612, 1284.4220100954421, 863.0765081363007, 886.7339798060556, 894.3024440936081, 898.1602201941206, 900.428228075177, 4407.162639098561, 4429.534898835575, 4431.202383570923, 4445.911081778411, 4453.576910193527, 5032.647714659939, 5046.571041461443, 5056.216286475602, 5075.441701412841, 5077.746112694351, 4271.167122411162, 4412.470503539532, 4501.932471012938, 4516.390287311171, 4545.522720114406, 2707.632645514003, 2728.2770065932546, 2734.1387462949106, 2739.1508632323644, 2739.2330147558714, 4870.001649661811, 4886.511348865156, 4892.290617860391, 4912.508749125059, 4913.656044076952, 5112.437631860566, 5193.428722840485, 5242.213667949762, 5247.868803279948, 5269.55208807248, 4880.6827556210155, 4885.828995985124, 4886.584640305614, 4889.706617602955, 4897.755112244445, 4977.328060711902, 5110.437851836221, 5118.769655365443, 5121.974390128025, 5153.3815942087185, 4990.401151861654, 5011.874703132451, 5034.270030845433, 5053.59571234293, 5062.215356619729, 4837.0, 4845.328361715203, 4856.39295088114, 4864.537868902448, 4881.267809828554, 3493.301339732013, 3495.7727747696317, 3497.3529896969144, 3497.5691894133333, 3503.404421248445, 4953.306537084739, 5059.822906198266, 5106.948930510796, 5123.718195499283, 5125.564327032244, 4923.261510773269, 4948.38145231846, 4979.178435558238, 4986.177280748636, 5010.799568017239, 4979.460475157768, 4987.927595566971, 4996.950030499794, 5002.349694539686, 5007.524285192901, 4670.439547254351, 4694.201985662377, 4789.616830653609, 4863.173260545645, 4899.951000490092, 4835.8065677372515, 4981.3026176334615, 4987.72567508776, 4997.675151115166, 4999.0, 4865.343178670976, 4876.78054487556, 4882.6338024649, 4883.023395320879, 4891.682040667345], "value": 3748.036658341481, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.1825054804574, 643.4498503779267, 673.3703986772372, 681.1009467502895, 721.5850885740697, 12030.0, 12892.548760793374, 12931.159474634142, 12955.09314347996, 12960.83352498275, 11956.103292253094, 11967.281963082221, 11974.640760777169, 11974.700632484191, 11994.16040877139, 620.0575125808768, 637.2003136064257, 746.2388363868864, 756.7805336452423, 776.3866545429104, 775.2712450296731, 779.302524240807, 780.3756994404482, 780.9453338266323, 781.3631890009652, 832.7335252719132, 838.1953324808161, 838.5010918503481, 839.1063517354029, 840.3193413335188, 644.561698045329, 662.2913482573648, 825.3438516379463, 825.9380546459009, 826.4338927834452, 579.956503262257, 593.4955288005204, 596.5317225977631, 598.3597550620838, 598.8742364103543, 13046.739065218642, 13075.150115242479, 13089.541866034642, 13094.148880322844, 13102.27937463439, 11879.406029698566, 12231.510739570496, 12282.815757763641, 12494.0, 12986.09097363185, 11655.533778648844, 11736.589219377282, 11754.05967522596, 11910.702232444171, 12060.939695301555, 4080.510338759368, 4096.262672718909, 4102.487189101363, 4299.91400171998, 4301.892452688677, 60480.27665843526, 61639.0, 61686.383136168515, 62457.37542624561, 62942.0, 9843.753906152404, 9998.15015723657, 10202.591896324064, 10248.948755256177, 10564.0, 16936.322547097978, 16939.068351240552, 17110.743338849927, 17165.141742912805, 17287.222075006655, 6708.262091169968, 6761.594304341756, 6837.3162683731225, 7021.0, 7026.894596581055, 3579.2304654498885, 3640.0899775056237, 3686.668199862025, 3814.961850381461, 3829.942550861739, 2648.854313012764, 2708.891644334244, 2740.7670348020642, 2740.9588856167175, 2743.9451210975667, 493.28227429091305, 542.0432935868196, 567.690608618304, 568.5338022821247, 583.3262581718122, 525.0, 550.2159422822461, 565.1268789719893, 616.4390404731762, 617.5985609353955, 8075.717349892726, 8462.788430289293, 8603.870941935877, 8935.955320223356, 9303.581338839633, 496.3919198981219, 516.9250458683545, 557.5177471487216, 589.8377946064867, 602.072807875875, 3936.5866584008268, 4015.1768887378016, 4205.537390887, 4232.513260974965, 4322.589354011364, 97707.51146244223, 98336.59148746888, 99949.0, 101442.0, 101620.49189754152, 46228.306575400726, 46984.7650761744, 47283.0, 49504.0, 81623.0, 53322.73338633282, 73166.0, 73643.63178184076, 73788.63105684437, 74583.0, 7420.295071968154, 8782.824343513223, 8993.865092023756, 9055.637774488947, 9233.169014788702, 29941.850290748407, 30302.393952120394, 32430.675693242767, 36237.27525449529, 40515.79742101271, 49562.75218623884, 50114.24828627647, 51552.74223628858, 56764.71617641886, 57909.0, 11004.954529319702, 11374.886251137383, 11396.316221026766, 11417.257878237888, 11466.484008219817, 13313.800292995418, 13389.66525836862, 13558.79661805054, 13606.93196534011, 13639.045266831623, 12433.0, 12479.875201248235, 12563.811542827048, 12682.619521414372, 13268.800967985295, 11731.824022639497, 12100.152989290666, 12481.500739970663, 13048.086633935533, 13223.471061157446, 12079.698007549881, 12143.453544590338, 12236.694082648006, 12428.502859885864, 12725.172863763826, 9625.229981601595, 9715.951420242853, 9957.900420995697, 10277.84583231267, 10380.093573799348, 9914.950425248117, 10402.531886064993, 10593.576256949636, 10657.680269591925, 10868.728281793019], "value": 6462.5974061982415, "unit": "score"}], "name": "dromaeo_css", "value": 6235.137082504487, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 116.0, 116.0, 115.0, 117.0, 115.0, 115.0, 118.0, 115.0], "value": 115.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 131.0, 129.0, 174.0, 127.0, 126.0, 131.0, 125.0, 160.0, 132.0], "value": 138.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 161.0, 164.0, 164.0, 162.0, 162.0, 160.0, 160.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 105.0, 76.0, 77.0, 77.0, 76.0, 118.0, 77.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 127.0, 84.0, 85.0, 83.0, 106.0, 82.0, 82.0, 113.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 148.0, 147.0, 146.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 94.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 64.0, 68.0, 65.0, 64.0, 65.0, 64.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 68.0], "value": 67.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0, 83.0, 83.0, 83.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 140.0, 143.0, 147.0, 148.0, 150.0, 147.0, 144.0, 182.0, 146.0], "value": 149.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 178.0, 176.0, 180.0, 185.0, 172.0, 177.0, 178.0, 176.0, 177.0], "value": 178.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 70.0, 70.0, 72.0, 73.0, 74.0, 70.0, 69.0], "value": 70.6, "unit": "score"}], "name": "kraken", "value": 1565.3999999999999, "alertThreshold": 2.0}]} 21:42:23 INFO - Return code: 0 21:42:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:42:23 INFO - # TBPL SUCCESS # 21:42:23 INFO - Running post-action listener: _resource_record_post_action 21:42:23 INFO - [mozharness: 2016-10-07 04:42:23.425182Z] Finished run-tests step (success) 21:42:23 INFO - Running post-run listener: _resource_record_post_run 21:42:23 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 499712; Write bytes: 403001344; Read time: 44; Write time: 207908 21:42:23 INFO - TinderboxPrint: CPU usage
13.0% 21:42:23 INFO - TinderboxPrint: I/O read bytes / time
499,712 / 44 21:42:23 INFO - TinderboxPrint: I/O write bytes / time
403,001,344 / 207,908 21:42:23 INFO - TinderboxPrint: CPU idle
8,356.1 (87.0%) 21:42:23 INFO - TinderboxPrint: CPU user
1,204.9 (12.5%) 21:42:23 INFO - TinderboxPrint: Swap in / out
0 / 0 21:42:23 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110596096; Read time: 0; Write time: 60124 21:42:23 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 495616; Write bytes: 291336192; Read time: 32; Write time: 147756 21:42:24 INFO - Running post-run listener: _upload_blobber_files 21:42:24 INFO - Blob upload gear active. 21:42:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:42:24 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 21:42:24 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:42:24 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:42:24 INFO - (blobuploader) - INFO - Open directory for files ... 21:42:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:42:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:42:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:42:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:42:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:42:25 INFO - (blobuploader) - INFO - Done attempting. 21:42:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:42:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:42:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:42:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:42:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:42:25 INFO - (blobuploader) - INFO - Done attempting. 21:42:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:42:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:42:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:42:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:42:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:42:30 INFO - (blobuploader) - INFO - Done attempting. 21:42:30 INFO - (blobuploader) - INFO - Iteration through files over. 21:42:30 INFO - Return code: 0 21:42:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:42:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:42:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab0e367762ad907290d03d39ca33250534c6c946ba531530511ba28117739e9c7fc36118ff8e2241523d8a9a2c89865af18885b9223ee18486938fdf19438f6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fac4c08504a6864c47c402e451f44e366401cd2f0b3b95ab51cba4833e160360df5b8013da4725e651f5c927f7f9d2795a8a95703f08d1545172f1071d3e306a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e8d4d0089800fc44fabc473db8b733c195bfe3cec5847160c6a173b2ad402fcf920f059d9f01bbcc6871391270ff234bb0773e8e54248ed0782deb2bd86fb44e"} 21:42:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:42:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:42:30 INFO - Contents: 21:42:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab0e367762ad907290d03d39ca33250534c6c946ba531530511ba28117739e9c7fc36118ff8e2241523d8a9a2c89865af18885b9223ee18486938fdf19438f6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fac4c08504a6864c47c402e451f44e366401cd2f0b3b95ab51cba4833e160360df5b8013da4725e651f5c927f7f9d2795a8a95703f08d1545172f1071d3e306a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e8d4d0089800fc44fabc473db8b733c195bfe3cec5847160c6a173b2ad402fcf920f059d9f01bbcc6871391270ff234bb0773e8e54248ed0782deb2bd86fb44e"} 21:42:30 INFO - Running post-run listener: copy_logs_to_upload_dir 21:42:30 INFO - Copying logs to upload dir... 21:42:30 INFO - mkdir: /builds/slave/test/build/upload/logs 21:42:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.045127 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-06 21:42:30.101684) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 21:42:30.108671) ========= 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=bb9b54edd4a927dc735d112f000001d9-1475811857.462648-2078148260 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-Non-PGO/sha512/ab0e367762ad907290d03d39ca33250534c6c946ba531530511ba28117739e9c7fc36118ff8e2241523d8a9a2c89865af18885b9223ee18486938fdf19438f6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fac4c08504a6864c47c402e451f44e366401cd2f0b3b95ab51cba4833e160360df5b8013da4725e651f5c927f7f9d2795a8a95703f08d1545172f1071d3e306a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e8d4d0089800fc44fabc473db8b733c195bfe3cec5847160c6a173b2ad402fcf920f059d9f01bbcc6871391270ff234bb0773e8e54248ed0782deb2bd86fb44e"} build_url:https://queue.taskcluster.net/v1/task/IbGk_ujvRt-eWxpDu7V-RQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011326 build_url: 'https://queue.taskcluster.net/v1/task/IbGk_ujvRt-eWxpDu7V-RQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab0e367762ad907290d03d39ca33250534c6c946ba531530511ba28117739e9c7fc36118ff8e2241523d8a9a2c89865af18885b9223ee18486938fdf19438f6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fac4c08504a6864c47c402e451f44e366401cd2f0b3b95ab51cba4833e160360df5b8013da4725e651f5c927f7f9d2795a8a95703f08d1545172f1071d3e306a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e8d4d0089800fc44fabc473db8b733c195bfe3cec5847160c6a173b2ad402fcf920f059d9f01bbcc6871391270ff234bb0773e8e54248ed0782deb2bd86fb44e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 21:42:30.139991) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:42:30.140406) ========= 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=bb9b54edd4a927dc735d112f000001d9-1475811857.462648-2078148260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004435 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:42:30.224735) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 21:42:30.225115) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 21:42:30.225494) ========= ========= Total master_lag: 0.25 =========