builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1480010322.28 results: success (0) buildid: 20161124071419 builduid: 193a634596464284b078693c4532ee4f revision: 12a7e9d627b5ef91b8c1a9061012cd48ae1a6df0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 09:58:42.279573) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 09:58:42.280052) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 09:58:42.280351) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 09:58:42.295058) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 09:58:42.295425) ========= 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=3836458cccd887f2d2de3cf1000001de-1480010321.679390-1993003949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-24 09:58:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.3M=0s 2016-11-24 09:58:42 (42.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.099163 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 09:58:42.408521) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 09:58:42.408851) ========= 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=3836458cccd887f2d2de3cf1000001de-1480010321.679390-1993003949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017271 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 09:58:42.458255) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 09:58:42.458627) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 12a7e9d627b5ef91b8c1a9061012cd48ae1a6df0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 12a7e9d627b5ef91b8c1a9061012cd48ae1a6df0 --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=3836458cccd887f2d2de3cf1000001de-1480010321.679390-1993003949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-24 09:58:42,780 truncating revision to first 12 chars 2016-11-24 09:58:42,780 Setting DEBUG logging. 2016-11-24 09:58:42,780 attempt 1/10 2016-11-24 09:58:42,780 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/12a7e9d627b5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-24 09:58:43,105 unpacking tar archive at: mozilla-aurora-12a7e9d627b5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.660897 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 09:58:43.132971) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 09:58:43.133329) ========= script_repo_revision: 12a7e9d627b5ef91b8c1a9061012cd48ae1a6df0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 09:58:43.133733) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 09:58:43.134011) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 09:58:43.143917) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-24 09:58:43.144318) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=3836458cccd887f2d2de3cf1000001de-1480010321.679390-1993003949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:58:43 INFO - MultiFileLogger online at 20161124 09:58:43 in /builds/slave/test 09:58:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:58:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:58:43 INFO - {'append_to_log': False, 09:58:43 INFO - 'base_work_dir': '/builds/slave/test', 09:58:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:58:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:58:43 INFO - 'branch': 'Mozilla-Aurora', 09:58:43 INFO - 'buildbot_json_path': 'buildprops.json', 09:58:43 INFO - 'config_files': ('talos/linux_config.py',), 09:58:43 INFO - 'default_actions': ('clobber', 09:58:43 INFO - 'read-buildbot-config', 09:58:43 INFO - 'download-and-extract', 09:58:43 INFO - 'populate-webroot', 09:58:43 INFO - 'create-virtualenv', 09:58:43 INFO - 'install', 09:58:43 INFO - 'run-tests'), 09:58:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:58:43 INFO - 'download_minidump_stackwalk': True, 09:58:43 INFO - 'download_symbols': 'ondemand', 09:58:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:58:43 INFO - 'tooltool.py': '/tools/tooltool.py', 09:58:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:58:43 INFO - '/tools/misc-python/virtualenv.py')}, 09:58:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:58:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:58:43 INFO - 'installer_path': 'installer.exe', 09:58:43 INFO - 'log_level': 'info', 09:58:43 INFO - 'log_name': 'talos', 09:58:43 INFO - 'log_to_console': True, 09:58:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:58:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:58:43 INFO - 'opt_config_files': (), 09:58:43 INFO - 'pip_index': False, 09:58:43 INFO - 'sps_profile': False, 09:58:43 INFO - 'sps_profile_interval': 0, 09:58:43 INFO - 'suite': 'dromaeojs', 09:58:43 INFO - 'system_bits': '32', 09:58:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:58:43 INFO - 'title': 'talos-linux64-ix-030', 09:58:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:58:43 INFO - 'use_talos_json': True, 09:58:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:58:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:58:43 INFO - 'work_dir': 'build'} 09:58:43 INFO - [mozharness: 2016-11-24 17:58:43.556696Z] Running clobber step. 09:58:43 INFO - Running pre-action listener: _resource_record_pre_action 09:58:43 INFO - Running main action method: clobber 09:58:43 INFO - rmtree: /builds/slave/test/build 09:58:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:58:44 INFO - Running post-action listener: _resource_record_post_action 09:58:44 INFO - [mozharness: 2016-11-24 17:58:44.535836Z] Finished clobber step (success) 09:58:44 INFO - [mozharness: 2016-11-24 17:58:44.535935Z] Running read-buildbot-config step. 09:58:44 INFO - Running pre-action listener: _resource_record_pre_action 09:58:44 INFO - Running main action method: read_buildbot_config 09:58:44 INFO - Using buildbot properties: 09:58:44 INFO - { 09:58:44 INFO - "project": "", 09:58:44 INFO - "product": "firefox", 09:58:44 INFO - "script_repo_revision": "production", 09:58:44 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:58:44 INFO - "repository": "", 09:58:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:58:44 INFO - "buildid": "20161124071419", 09:58:44 INFO - "pgo_build": "True", 09:58:44 INFO - "basedir": "/builds/slave/test", 09:58:44 INFO - "buildnumber": 643, 09:58:44 INFO - "slavename": "talos-linux64-ix-030", 09:58:44 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:58:44 INFO - "platform": "ubuntu64_hw", 09:58:44 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:58:44 INFO - "branch": "mozilla-aurora", 09:58:44 INFO - "repo_path": "releases/mozilla-aurora", 09:58:44 INFO - "revision": "12a7e9d627b5ef91b8c1a9061012cd48ae1a6df0", 09:58:44 INFO - "stage_platform": "linux64-pgo", 09:58:44 INFO - "builduid": "193a634596464284b078693c4532ee4f", 09:58:44 INFO - "slavebuilddir": "test" 09:58:44 INFO - } 09:58:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 09:58:44 INFO - Running post-action listener: _resource_record_post_action 09:58:44 INFO - [mozharness: 2016-11-24 17:58:44.538412Z] Finished read-buildbot-config step (success) 09:58:44 INFO - [mozharness: 2016-11-24 17:58:44.538500Z] Running download-and-extract step. 09:58:44 INFO - Running pre-action listener: _resource_record_pre_action 09:58:44 INFO - Running main action method: download_and_extract 09:58:44 INFO - mkdir: /builds/slave/test/build/tests 09:58:44 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')]} 09:58:44 INFO - trying https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:58:44 INFO - Downloading https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:58:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:58:45 INFO - Downloaded 1361 bytes. 09:58:45 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:58:45 INFO - Using the following test package requirements: 09:58:45 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:58:45 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:58:45 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:58:45 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:58:45 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:58:45 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:58:45 INFO - u'jsshell-linux-x86_64.zip'], 09:58:45 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:58:45 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:58:45 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:58:45 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:58:45 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:58:45 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:58:45 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:58:45 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:58:45 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:58:45 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:58:45 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:58:45 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:58:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:58:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:58:45 INFO - Fetch https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:58:45 INFO - Http code: 200 09:58:45 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 09:58:45 INFO - x-amz-cf-id: 5Z0YDoZkcr_cJSjNm7VvvM794c1Lp_hjzzVOIuo-z0nk7txnHH-ARA== 09:58:45 INFO - x-amz-version-id: Wtbp.YOQiHNFemIs7Q0uF_2sHQCYK3WJ 09:58:45 INFO - Expected file size: 21949723 09:58:45 INFO - Obtained file size: 21949723 09:58:49 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:58:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:58:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:58:49 INFO - Fetch https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:58:50 INFO - Http code: 200 09:58:50 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 09:58:50 INFO - x-amz-cf-id: K2JxRI2YNBmul4SF2FzM20XaTAyrJCJXQ8U6OOB-dixueYqjXPPnQw== 09:58:50 INFO - x-amz-version-id: Wtbp.YOQiHNFemIs7Q0uF_2sHQCYK3WJ 09:58:50 INFO - Expected file size: 21949723 09:58:50 INFO - Obtained file size: 21949723 09:58:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 09:58:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:58:55 INFO - Fetch https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 09:58:55 INFO - Http code: 200 09:58:55 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 09:58:55 INFO - x-amz-cf-id: MLFNpPjgqdQwctJoNld1MyMBjxJQWhuNRh8vEj8kKuZj_F_WLknx1Q== 09:58:55 INFO - x-amz-version-id: DZjj2iUNBKPvBJqppPMCCk29aHRM7qKz 09:58:55 INFO - Expected file size: 14409038 09:58:55 INFO - Obtained file size: 14409038 09:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:56 INFO - trying https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:58:56 INFO - Downloading https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:58:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:58:57 INFO - Downloaded 63968237 bytes. 09:58:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:58:57 INFO - mkdir: /builds/slave/test/properties 09:58:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:58:57 INFO - Writing to file /builds/slave/test/properties/build_url 09:58:57 INFO - Contents: 09:58:57 INFO - build_url:https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:58:57 INFO - Running post-action listener: _resource_record_post_action 09:58:57 INFO - Running post-action listener: set_extra_try_arguments 09:58:57 INFO - [mozharness: 2016-11-24 17:58:57.859717Z] Finished download-and-extract step (success) 09:58:57 INFO - [mozharness: 2016-11-24 17:58:57.859943Z] Running populate-webroot step. 09:58:57 INFO - Running pre-action listener: _resource_record_pre_action 09:58:57 INFO - Running main action method: populate_webroot 09:58:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:58:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:58:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:58:57 INFO - '--tppagecycles', 09:58:57 INFO - '7'], 09:58:57 INFO - 'tests': ['tsvgm']}}, 09:58:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:58:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:58:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:58:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:58:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:58:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:58:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:57 INFO - 'talos_options': ['--disable-e10s'], 09:58:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:58:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:58:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:57 INFO - 'talos_options': ['--disable-e10s'], 09:58:57 INFO - 'tests': ['damp', 'tps']}, 09:58:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:57 INFO - 'tests': ['damp', 'tps']}, 09:58:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:58:57 INFO - 'tests': ['dromaeo_dom']}, 09:58:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:58:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:58:57 INFO - 'tests': ['basic_compositor_video']}, 09:58:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:58:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:58:57 INFO - 'tests': ['a11yr', 09:58:57 INFO - 'ts_paint', 09:58:57 INFO - 'tpaint', 09:58:57 INFO - 'sessionrestore', 09:58:57 INFO - 'sessionrestore_no_auto_restore', 09:58:57 INFO - 'tabpaint']}, 09:58:57 INFO - 'other-e10s': {'tests': ['a11yr', 09:58:57 INFO - 'ts_paint', 09:58:57 INFO - 'tpaint', 09:58:57 INFO - 'sessionrestore', 09:58:57 INFO - 'sessionrestore_no_auto_restore', 09:58:57 INFO - 'tabpaint']}, 09:58:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:58:57 INFO - 'ts_paint', 09:58:57 INFO - 'tpaint', 09:58:57 INFO - 'sessionrestore', 09:58:57 INFO - 'sessionrestore_no_auto_restore', 09:58:57 INFO - 'tabpaint']}, 09:58:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:58:57 INFO - 'ts_paint', 09:58:57 INFO - 'tpaint', 09:58:57 INFO - 'sessionrestore', 09:58:57 INFO - 'sessionrestore_no_auto_restore', 09:58:57 INFO - 'tabpaint']}, 09:58:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:58:57 INFO - 'tests': ['a11yr', 09:58:57 INFO - 'ts_paint', 09:58:57 INFO - 'tpaint', 09:58:57 INFO - 'sessionrestore', 09:58:57 INFO - 'sessionrestore_no_auto_restore', 09:58:57 INFO - 'tabpaint']}, 09:58:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:58:57 INFO - 'tests': ['a11yr', 09:58:57 INFO - 'ts_paint', 09:58:57 INFO - 'tpaint', 09:58:57 INFO - 'sessionrestore', 09:58:57 INFO - 'sessionrestore_no_auto_restore', 09:58:57 INFO - 'tabpaint']}, 09:58:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:58:57 INFO - 'tests': ['tsvgx', 09:58:57 INFO - 'tsvgr_opacity', 09:58:57 INFO - 'tart', 09:58:57 INFO - 'tscrollx', 09:58:57 INFO - 'cart']}, 09:58:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:58:57 INFO - 'tsvgr_opacity', 09:58:57 INFO - 'tart', 09:58:57 INFO - 'tscrollx', 09:58:57 INFO - 'cart']}, 09:58:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:57 INFO - 'talos_options': ['--disable-e10s'], 09:58:57 INFO - 'tests': ['tp5o']}, 09:58:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:57 INFO - 'tests': ['tp5o']}, 09:58:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:57 INFO - 'talos_options': ['--disable-e10s', 09:58:57 INFO - '--xperf_path', 09:58:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:58:57 INFO - 'tests': ['tp5n']}, 09:58:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:57 INFO - 'talos_options': ['--xperf_path', 09:58:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:58:57 INFO - 'tests': ['tp5n']}}, 09:58:57 INFO - 'talos.zip': {'path': '', 09:58:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:58:57 INFO - Running post-action listener: _resource_record_post_action 09:58:57 INFO - [mozharness: 2016-11-24 17:58:57.878425Z] Finished populate-webroot step (success) 09:58:57 INFO - [mozharness: 2016-11-24 17:58:57.878513Z] Running create-virtualenv step. 09:58:57 INFO - Running pre-action listener: _resource_record_pre_action 09:58:57 INFO - Running main action method: create_virtualenv 09:58:57 INFO - Creating virtualenv /builds/slave/test/build/venv 09:58:57 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 09:58:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:58:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:58:57 INFO - Using real prefix '/usr' 09:58:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:58:58 INFO - Installing distribute.............................................................................................................................................................................................done. 09:59:00 INFO - Installing pip.................done. 09:59:00 INFO - Return code: 0 09:59:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:59:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:59:00 INFO - Reading from file tmpfile_stdout 09:59:00 INFO - Output received: 09:59:00 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) 09:59:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe32ea03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2167ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164f60>, '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 0x2165d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21661d0>, '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': '3836458cccd887f2d2de3cf1000001de-1480010321.679390-1993003949', '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 09:59:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:59:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:59:00 INFO - Using env: {'DISPLAY': ':0', 09:59:00 INFO - 'HOME': '/home/cltbld', 09:59:00 INFO - 'LANG': 'en_US.UTF-8', 09:59:00 INFO - 'LANGUAGE': 'en_US:en', 09:59:00 INFO - 'LOGNAME': 'cltbld', 09:59:00 INFO - 'MAIL': '/var/mail/cltbld', 09:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:00 INFO - 'MOZ_NO_REMOTE': '1', 09:59:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:00 INFO - 'NO_EM_RESTART': '1', 09:59:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:00 INFO - 'PWD': '/builds/slave/test', 09:59:00 INFO - 'SHELL': '/bin/bash', 09:59:00 INFO - 'SHLVL': '1', 09:59:00 INFO - 'TERM': 'linux', 09:59:00 INFO - 'TMOUT': '86400', 09:59:00 INFO - 'USER': 'cltbld', 09:59:00 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1480010321.679390-1993003949', 09:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:00 INFO - '_': '/tools/buildbot/bin/python'} 09:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:00 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 09:59:00 INFO - Cleaning up... 09:59:00 INFO - Return code: 0 09:59:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe32ea03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2167ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164f60>, '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 0x2165d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21661d0>, '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': '3836458cccd887f2d2de3cf1000001de-1480010321.679390-1993003949', '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 09:59:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:59:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:59:00 INFO - Using env: {'DISPLAY': ':0', 09:59:00 INFO - 'HOME': '/home/cltbld', 09:59:00 INFO - 'LANG': 'en_US.UTF-8', 09:59:00 INFO - 'LANGUAGE': 'en_US:en', 09:59:00 INFO - 'LOGNAME': 'cltbld', 09:59:00 INFO - 'MAIL': '/var/mail/cltbld', 09:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:00 INFO - 'MOZ_NO_REMOTE': '1', 09:59:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:00 INFO - 'NO_EM_RESTART': '1', 09:59:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:00 INFO - 'PWD': '/builds/slave/test', 09:59:00 INFO - 'SHELL': '/bin/bash', 09:59:00 INFO - 'SHLVL': '1', 09:59:00 INFO - 'TERM': 'linux', 09:59:00 INFO - 'TMOUT': '86400', 09:59:00 INFO - 'USER': 'cltbld', 09:59:00 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1480010321.679390-1993003949', 09:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:00 INFO - '_': '/tools/buildbot/bin/python'} 09:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:01 INFO - Downloading/unpacking psutil>=3.1.1 09:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:59:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:59:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:59:03 INFO - Installing collected packages: psutil 09:59:03 INFO - Running setup.py install for psutil 09:59:03 INFO - building 'psutil._psutil_linux' extension 09:59:03 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 09:59:03 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 09:59:03 INFO - building 'psutil._psutil_posix' extension 09:59:03 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 09:59:03 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 09:59:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:59:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:59:03 INFO - Successfully installed psutil 09:59:03 INFO - Cleaning up... 09:59:03 INFO - Return code: 0 09:59:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:59:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe32ea03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2167ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164f60>, '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 0x2165d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21661d0>, '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': '3836458cccd887f2d2de3cf1000001de-1480010321.679390-1993003949', '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 09:59:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:59:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:59:03 INFO - Using env: {'DISPLAY': ':0', 09:59:03 INFO - 'HOME': '/home/cltbld', 09:59:03 INFO - 'LANG': 'en_US.UTF-8', 09:59:03 INFO - 'LANGUAGE': 'en_US:en', 09:59:03 INFO - 'LOGNAME': 'cltbld', 09:59:03 INFO - 'MAIL': '/var/mail/cltbld', 09:59:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:03 INFO - 'MOZ_NO_REMOTE': '1', 09:59:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:03 INFO - 'NO_EM_RESTART': '1', 09:59:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:03 INFO - 'PWD': '/builds/slave/test', 09:59:03 INFO - 'SHELL': '/bin/bash', 09:59:03 INFO - 'SHLVL': '1', 09:59:03 INFO - 'TERM': 'linux', 09:59:03 INFO - 'TMOUT': '86400', 09:59:03 INFO - 'USER': 'cltbld', 09:59:03 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1480010321.679390-1993003949', 09:59:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:03 INFO - '_': '/tools/buildbot/bin/python'} 09:59:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:59:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:59:05 INFO - Installing collected packages: mozsystemmonitor 09:59:05 INFO - Running setup.py install for mozsystemmonitor 09:59:06 INFO - Successfully installed mozsystemmonitor 09:59:06 INFO - Cleaning up... 09:59:06 INFO - Return code: 0 09:59:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe32ea03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2167ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164f60>, '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 0x2165d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21661d0>, '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': '3836458cccd887f2d2de3cf1000001de-1480010321.679390-1993003949', '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 09:59:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:59:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:59:06 INFO - Using env: {'DISPLAY': ':0', 09:59:06 INFO - 'HOME': '/home/cltbld', 09:59:06 INFO - 'LANG': 'en_US.UTF-8', 09:59:06 INFO - 'LANGUAGE': 'en_US:en', 09:59:06 INFO - 'LOGNAME': 'cltbld', 09:59:06 INFO - 'MAIL': '/var/mail/cltbld', 09:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:06 INFO - 'MOZ_NO_REMOTE': '1', 09:59:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:06 INFO - 'NO_EM_RESTART': '1', 09:59:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:06 INFO - 'PWD': '/builds/slave/test', 09:59:06 INFO - 'SHELL': '/bin/bash', 09:59:06 INFO - 'SHLVL': '1', 09:59:06 INFO - 'TERM': 'linux', 09:59:06 INFO - 'TMOUT': '86400', 09:59:06 INFO - 'USER': 'cltbld', 09:59:06 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1480010321.679390-1993003949', 09:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:06 INFO - '_': '/tools/buildbot/bin/python'} 09:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:06 INFO - Downloading/unpacking jsonschema==2.5.1 09:59: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 09:59: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 09:59: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 09:59: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 09:59: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 09:59: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 09:59:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:59:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:59:08 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 09:59:08 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 09:59:08 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 09:59:08 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 09:59:08 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 09:59:08 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 09:59:08 INFO - Downloading functools32-3.2.3-2.tar.gz 09:59:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:59:08 INFO - warning: no files found matching '*.txt' 09:59:08 INFO - no previously-included directories found matching 'build' 09:59:08 INFO - no previously-included directories found matching 'dist' 09:59:08 INFO - no previously-included directories found matching '.git*' 09:59:08 INFO - Installing collected packages: jsonschema, functools32 09:59:08 INFO - Running setup.py install for functools32 09:59:08 INFO - warning: no files found matching '*.txt' 09:59:08 INFO - no previously-included directories found matching 'build' 09:59:08 INFO - no previously-included directories found matching 'dist' 09:59:08 INFO - no previously-included directories found matching '.git*' 09:59:08 INFO - Successfully installed jsonschema functools32 09:59:08 INFO - Cleaning up... 09:59:08 INFO - Return code: 0 09:59:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:08 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 0x7fe32ea03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2167ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164f60>, '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 0x2165d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21661d0>, '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': '3836458cccd887f2d2de3cf1000001de-1480010321.679390-1993003949', '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 09:59:08 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 09:59:08 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 09:59:08 INFO - Using env: {'DISPLAY': ':0', 09:59:08 INFO - 'HOME': '/home/cltbld', 09:59:08 INFO - 'LANG': 'en_US.UTF-8', 09:59:08 INFO - 'LANGUAGE': 'en_US:en', 09:59:08 INFO - 'LOGNAME': 'cltbld', 09:59:08 INFO - 'MAIL': '/var/mail/cltbld', 09:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:08 INFO - 'MOZ_NO_REMOTE': '1', 09:59:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:08 INFO - 'NO_EM_RESTART': '1', 09:59:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:08 INFO - 'PWD': '/builds/slave/test', 09:59:08 INFO - 'SHELL': '/bin/bash', 09:59:08 INFO - 'SHLVL': '1', 09:59:08 INFO - 'TERM': 'linux', 09:59:08 INFO - 'TMOUT': '86400', 09:59:08 INFO - 'USER': 'cltbld', 09:59:08 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1480010321.679390-1993003949', 09:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:08 INFO - '_': '/tools/buildbot/bin/python'} 09:59:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:59:08 INFO - Cleaning up... 09:59:08 INFO - Return code: 0 09:59:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:08 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 0x7fe32ea03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2167ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164f60>, '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 0x2165d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21661d0>, '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': '3836458cccd887f2d2de3cf1000001de-1480010321.679390-1993003949', '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 09:59:08 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 09:59:08 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 09:59:08 INFO - Using env: {'DISPLAY': ':0', 09:59:08 INFO - 'HOME': '/home/cltbld', 09:59:08 INFO - 'LANG': 'en_US.UTF-8', 09:59:08 INFO - 'LANGUAGE': 'en_US:en', 09:59:08 INFO - 'LOGNAME': 'cltbld', 09:59:08 INFO - 'MAIL': '/var/mail/cltbld', 09:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:08 INFO - 'MOZ_NO_REMOTE': '1', 09:59:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:08 INFO - 'NO_EM_RESTART': '1', 09:59:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:08 INFO - 'PWD': '/builds/slave/test', 09:59:08 INFO - 'SHELL': '/bin/bash', 09:59:08 INFO - 'SHLVL': '1', 09:59:08 INFO - 'TERM': 'linux', 09:59:08 INFO - 'TMOUT': '86400', 09:59:08 INFO - 'USER': 'cltbld', 09:59:08 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1480010321.679390-1993003949', 09:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:08 INFO - '_': '/tools/buildbot/bin/python'} 09:59:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:09 INFO - Downloading/unpacking blobuploader==1.2.4 09:59: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 09:59: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 09:59: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 09:59: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 09:59: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 09:59: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 09:59:11 INFO - Downloading blobuploader-1.2.4.tar.gz 09:59:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:59:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:59:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:11 INFO - Downloading docopt-0.6.1.tar.gz 09:59:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:59:11 INFO - Installing collected packages: blobuploader, requests, docopt 09:59:11 INFO - Running setup.py install for blobuploader 09:59:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:59:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:59:11 INFO - Running setup.py install for requests 09:59:12 INFO - Running setup.py install for docopt 09:59:12 INFO - Successfully installed blobuploader requests docopt 09:59:12 INFO - Cleaning up... 09:59:12 INFO - Return code: 0 09:59:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59:12 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')]} 09:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:12 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')]} 09:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:12 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 0x7fe32ea03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2167ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164f60>, '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 0x2165d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21661d0>, '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': '3836458cccd887f2d2de3cf1000001de-1480010321.679390-1993003949', '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 09:59:12 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 09:59:12 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 09:59:12 INFO - Using env: {'DISPLAY': ':0', 09:59:12 INFO - 'HOME': '/home/cltbld', 09:59:12 INFO - 'LANG': 'en_US.UTF-8', 09:59:12 INFO - 'LANGUAGE': 'en_US:en', 09:59:12 INFO - 'LOGNAME': 'cltbld', 09:59:12 INFO - 'MAIL': '/var/mail/cltbld', 09:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:12 INFO - 'MOZ_NO_REMOTE': '1', 09:59:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:12 INFO - 'NO_EM_RESTART': '1', 09:59:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:12 INFO - 'PWD': '/builds/slave/test', 09:59:12 INFO - 'SHELL': '/bin/bash', 09:59:12 INFO - 'SHLVL': '1', 09:59:12 INFO - 'TERM': 'linux', 09:59:12 INFO - 'TMOUT': '86400', 09:59:12 INFO - 'USER': 'cltbld', 09:59:12 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1480010321.679390-1993003949', 09:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:12 INFO - '_': '/tools/buildbot/bin/python'} 09:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:59:12 INFO - Running setup.py (path:/tmp/pip-GjmALa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:59:12 INFO - Running setup.py (path:/tmp/pip-1eQYy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:59:12 INFO - Running setup.py (path:/tmp/pip-CegzFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:59:12 INFO - Running setup.py (path:/tmp/pip-RSkhoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:59:12 INFO - Running setup.py (path:/tmp/pip-4Tdq9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:59:13 INFO - Running setup.py (path:/tmp/pip-i4rMye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:59:13 INFO - Running setup.py (path:/tmp/pip-LZg5ek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:59:13 INFO - Running setup.py (path:/tmp/pip-E9Tse2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:59:13 INFO - Running setup.py (path:/tmp/pip-wtUkd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:59:13 INFO - Running setup.py (path:/tmp/pip-dThT6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:59:13 INFO - Running setup.py (path:/tmp/pip-wu2UZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:59:13 INFO - Running setup.py (path:/tmp/pip-zlgkMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:59:13 INFO - Running setup.py (path:/tmp/pip-87By7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:59:13 INFO - Running setup.py (path:/tmp/pip-HV2_f_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:13 INFO - Running setup.py (path:/tmp/pip-6cOY55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:59:13 INFO - Running setup.py (path:/tmp/pip-Au_Pxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:59:13 INFO - Running setup.py (path:/tmp/pip-SeegWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:59:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:59:13 INFO - Running setup.py install for manifestparser 09:59:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:59:14 INFO - Running setup.py install for mozcrash 09:59:14 INFO - Running setup.py install for mozdebug 09:59:14 INFO - Running setup.py install for mozdevice 09:59:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:59:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:59:14 INFO - Running setup.py install for mozfile 09:59:14 INFO - Running setup.py install for mozhttpd 09:59:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:59:14 INFO - Running setup.py install for mozinfo 09:59:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:59:14 INFO - Running setup.py install for mozInstall 09:59:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:59:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:59:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:59:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:59:14 INFO - Running setup.py install for mozleak 09:59:14 INFO - Running setup.py install for mozlog 09:59:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:59:14 INFO - Running setup.py install for moznetwork 09:59:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:59:15 INFO - Running setup.py install for mozprocess 09:59:15 INFO - Running setup.py install for mozprofile 09:59:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:59:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:59:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:59:15 INFO - Running setup.py install for mozrunner 09:59:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:59:15 INFO - Running setup.py install for mozscreenshot 09:59:15 INFO - Running setup.py install for moztest 09:59:15 INFO - Running setup.py install for mozversion 09:59:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:59:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:59:15 INFO - Cleaning up... 09:59:15 INFO - Return code: 0 09:59:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:15 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 0x7fe32ea03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2167ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164f60>, '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 0x2165d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21661d0>, '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': '3836458cccd887f2d2de3cf1000001de-1480010321.679390-1993003949', '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 09:59:15 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 09:59:15 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 09:59:15 INFO - Using env: {'DISPLAY': ':0', 09:59:15 INFO - 'HOME': '/home/cltbld', 09:59:15 INFO - 'LANG': 'en_US.UTF-8', 09:59:15 INFO - 'LANGUAGE': 'en_US:en', 09:59:15 INFO - 'LOGNAME': 'cltbld', 09:59:15 INFO - 'MAIL': '/var/mail/cltbld', 09:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:15 INFO - 'MOZ_NO_REMOTE': '1', 09:59:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:15 INFO - 'NO_EM_RESTART': '1', 09:59:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:15 INFO - 'PWD': '/builds/slave/test', 09:59:15 INFO - 'SHELL': '/bin/bash', 09:59:15 INFO - 'SHLVL': '1', 09:59:15 INFO - 'TERM': 'linux', 09:59:15 INFO - 'TMOUT': '86400', 09:59:15 INFO - 'USER': 'cltbld', 09:59:15 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1480010321.679390-1993003949', 09:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:15 INFO - '_': '/tools/buildbot/bin/python'} 09:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:59:15 INFO - Running setup.py (path:/tmp/pip-r86sSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:59:16 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)) 09:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:59:16 INFO - Running setup.py (path:/tmp/pip-n9YpHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:59:16 INFO - Running setup.py (path:/tmp/pip-YQ3uvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:59:16 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)) 09:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:59:16 INFO - Running setup.py (path:/tmp/pip-m9nNSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:59:16 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)) 09:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:59:16 INFO - Running setup.py (path:/tmp/pip-uWOLAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:59:16 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)) 09:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:59:16 INFO - Running setup.py (path:/tmp/pip-nO_xWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:59:16 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)) 09:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:59:16 INFO - Running setup.py (path:/tmp/pip-bN8SVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:59:16 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)) 09:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:59:16 INFO - Running setup.py (path:/tmp/pip-3xnCzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:59:16 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)) 09:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:59:16 INFO - Running setup.py (path:/tmp/pip-GTBFFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:59:16 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)) 09:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:59:16 INFO - Running setup.py (path:/tmp/pip-41PEJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:59:16 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)) 09:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:59:16 INFO - Running setup.py (path:/tmp/pip-_fAowS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:59:16 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)) 09:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:59:16 INFO - Running setup.py (path:/tmp/pip-ibjgm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:59:16 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)) 09:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:59:16 INFO - Running setup.py (path:/tmp/pip-dJ2ybL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:59:16 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)) 09:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:59:16 INFO - Running setup.py (path:/tmp/pip-a2CwhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:16 INFO - Running setup.py (path:/tmp/pip-ke72cJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:17 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)) 09:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:59:17 INFO - Running setup.py (path:/tmp/pip-dDDhVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:59:17 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)) 09:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:59:17 INFO - Running setup.py (path:/tmp/pip-7jOvmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:59:17 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)) 09:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:59:17 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)) 09:59:17 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)) 09:59:17 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)) 09:59:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:59:17 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 09:59:17 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 09:59:17 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 09:59:17 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 09:59:17 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 09:59:17 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 09:59:19 INFO - Downloading blessings-1.6.tar.gz 09:59:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:59:19 INFO - Installing collected packages: blessings 09:59:19 INFO - Running setup.py install for blessings 09:59:19 INFO - Successfully installed blessings 09:59:19 INFO - Cleaning up... 09:59:19 INFO - Return code: 0 09:59:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:59:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:59:19 INFO - Reading from file tmpfile_stdout 09:59:19 INFO - Current package versions: 09:59:19 INFO - argparse == 1.2.1 09:59:19 INFO - blessings == 1.6 09:59:19 INFO - blobuploader == 1.2.4 09:59:19 INFO - docopt == 0.6.1 09:59:19 INFO - functools32 == 3.2.3-2 09:59:19 INFO - jsonschema == 2.5.1 09:59:19 INFO - manifestparser == 1.1 09:59:19 INFO - mozInstall == 1.12 09:59:19 INFO - mozcrash == 1.0 09:59:19 INFO - mozdebug == 0.1 09:59:19 INFO - mozdevice == 0.48 09:59:19 INFO - mozfile == 1.2 09:59:19 INFO - mozhttpd == 0.7 09:59:19 INFO - mozinfo == 0.9 09:59:19 INFO - mozleak == 0.1 09:59:19 INFO - mozlog == 3.4 09:59:19 INFO - moznetwork == 0.27 09:59:19 INFO - mozprocess == 0.23 09:59:19 INFO - mozprofile == 0.28 09:59:19 INFO - mozrunner == 6.13 09:59:19 INFO - mozscreenshot == 0.1 09:59:19 INFO - mozsystemmonitor == 0.3 09:59:19 INFO - moztest == 0.7 09:59:19 INFO - mozversion == 1.4 09:59:19 INFO - psutil == 3.1.1 09:59:19 INFO - requests == 1.2.3 09:59:19 INFO - wsgiref == 0.1.2 09:59:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59:19 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')]} 09:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:19 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')]} 09:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:19 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 0x7fe32ea03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2167ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164f60>, '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 0x2165d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21661d0>, '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': '3836458cccd887f2d2de3cf1000001de-1480010321.679390-1993003949', '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 09:59:19 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 09:59:19 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 09:59:19 INFO - Using env: {'DISPLAY': ':0', 09:59:19 INFO - 'HOME': '/home/cltbld', 09:59:19 INFO - 'LANG': 'en_US.UTF-8', 09:59:19 INFO - 'LANGUAGE': 'en_US:en', 09:59:19 INFO - 'LOGNAME': 'cltbld', 09:59:19 INFO - 'MAIL': '/var/mail/cltbld', 09:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:19 INFO - 'MOZ_NO_REMOTE': '1', 09:59:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:19 INFO - 'NO_EM_RESTART': '1', 09:59:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:19 INFO - 'PWD': '/builds/slave/test', 09:59:19 INFO - 'SHELL': '/bin/bash', 09:59:19 INFO - 'SHLVL': '1', 09:59:19 INFO - 'TERM': 'linux', 09:59:19 INFO - 'TMOUT': '86400', 09:59:19 INFO - 'USER': 'cltbld', 09:59:19 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1480010321.679390-1993003949', 09:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:19 INFO - '_': '/tools/buildbot/bin/python'} 09:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:19 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)) 09:59:19 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)) 09:59:19 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)) 09:59:19 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)) 09:59:19 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)) 09:59:19 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)) 09:59:19 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)) 09:59:19 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)) 09:59:19 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)) 09:59:19 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)) 09:59:19 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)) 09:59:19 INFO - Cleaning up... 09:59:19 INFO - Return code: 0 09:59:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:59:19 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')]} 09:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:19 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')]} 09:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:19 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 0x7fe32ea03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2167ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164f60>, '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 0x2165d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21661d0>, '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': '3836458cccd887f2d2de3cf1000001de-1480010321.679390-1993003949', '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 09:59:19 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 09:59:19 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 09:59:19 INFO - Using env: {'DISPLAY': ':0', 09:59:19 INFO - 'HOME': '/home/cltbld', 09:59:19 INFO - 'LANG': 'en_US.UTF-8', 09:59:19 INFO - 'LANGUAGE': 'en_US:en', 09:59:19 INFO - 'LOGNAME': 'cltbld', 09:59:19 INFO - 'MAIL': '/var/mail/cltbld', 09:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:19 INFO - 'MOZ_NO_REMOTE': '1', 09:59:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:19 INFO - 'NO_EM_RESTART': '1', 09:59:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:19 INFO - 'PWD': '/builds/slave/test', 09:59:19 INFO - 'SHELL': '/bin/bash', 09:59:19 INFO - 'SHLVL': '1', 09:59:19 INFO - 'TERM': 'linux', 09:59:19 INFO - 'TMOUT': '86400', 09:59:19 INFO - 'USER': 'cltbld', 09:59:19 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1480010321.679390-1993003949', 09:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:19 INFO - '_': '/tools/buildbot/bin/python'} 09:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:59:20 INFO - Cleaning up... 09:59:20 INFO - Return code: 0 09:59:20 INFO - Running post-action listener: _resource_record_post_action 09:59:20 INFO - Running post-action listener: _start_resource_monitoring 09:59:20 INFO - Starting resource monitoring. 09:59:20 INFO - [mozharness: 2016-11-24 17:59:20.073361Z] Finished create-virtualenv step (success) 09:59:20 INFO - [mozharness: 2016-11-24 17:59:20.073874Z] Running install step. 09:59:20 INFO - Running pre-action listener: _resource_record_pre_action 09:59:20 INFO - Running main action method: install 09:59:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:59:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:59:20 INFO - Reading from file tmpfile_stdout 09:59:20 INFO - Detecting whether we're running mozinstall >=1.0... 09:59:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:59:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:59:20 INFO - Reading from file tmpfile_stdout 09:59:20 INFO - Output received: 09:59:20 INFO - Usage: mozinstall [options] installer 09:59:20 INFO - Options: 09:59:20 INFO - -h, --help show this help message and exit 09:59:20 INFO - -d DEST, --destination=DEST 09:59:20 INFO - Directory to install application into. [default: 09:59:20 INFO - "/builds/slave/test"] 09:59:20 INFO - --app=APP Application being installed. [default: firefox] 09:59:20 INFO - mkdir: /builds/slave/test/build/application 09:59:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:59:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:59:36 INFO - Reading from file tmpfile_stdout 09:59:36 INFO - Output received: 09:59:36 INFO - /builds/slave/test/build/application/firefox/firefox 09:59:36 INFO - Running post-action listener: _resource_record_post_action 09:59:36 INFO - [mozharness: 2016-11-24 17:59:36.280487Z] Finished install step (success) 09:59:36 INFO - [mozharness: 2016-11-24 17:59:36.280729Z] Running run-tests step. 09:59:36 INFO - Running pre-action listener: _resource_record_pre_action 09:59:36 INFO - Running main action method: run_tests 09:59:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:59:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:59:36 INFO - Python 2.7.3 09:59:36 INFO - Return code: 0 09:59:36 INFO - grabbing minidump binary from tooltool 09:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:36 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 0x2164f60>, '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 0x2165d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21661d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:59:36 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 09:59:36 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 09:59:36 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 09:59:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:59:36 INFO - Return code: 0 09:59:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:59:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:59:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:59:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:59:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:59:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 09:59:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 09:59:36 INFO - Using env: {'DISPLAY': ':0', 09:59:36 INFO - 'HOME': '/home/cltbld', 09:59:36 INFO - 'LANG': 'en_US.UTF-8', 09:59:36 INFO - 'LANGUAGE': 'en_US:en', 09:59:36 INFO - 'LOGNAME': 'cltbld', 09:59:36 INFO - 'MAIL': '/var/mail/cltbld', 09:59:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:59:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:36 INFO - 'MOZ_NO_REMOTE': '1', 09:59:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:59:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:36 INFO - 'NO_EM_RESTART': '1', 09:59:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:36 INFO - 'PWD': '/builds/slave/test', 09:59:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:59:36 INFO - 'SHELL': '/bin/bash', 09:59:36 INFO - 'SHLVL': '1', 09:59:36 INFO - 'TERM': 'linux', 09:59:36 INFO - 'TMOUT': '86400', 09:59:36 INFO - 'USER': 'cltbld', 09:59:36 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1480010321.679390-1993003949', 09:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:36 INFO - '_': '/tools/buildbot/bin/python'} 09:59:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 09:59:36 INFO - mozversion application_buildid: 20161124071419 09:59:36 INFO - mozversion application_changeset: 12a7e9d627b5ef91b8c1a9061012cd48ae1a6df0 09:59:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:59:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:59:36 INFO - mozversion application_name: Firefox 09:59:36 INFO - mozversion application_remotingname: firefox-dev 09:59:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:59:36 INFO - mozversion application_vendor: Mozilla 09:59:36 INFO - mozversion application_version: 52.0a2 09:59:36 INFO - mozversion platform_buildid: 20161124071419 09:59:36 INFO - mozversion platform_changeset: 12a7e9d627b5ef91b8c1a9061012cd48ae1a6df0 09:59:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:59:36 INFO - mozversion platform_version: 52.0a2 09:59:36 INFO - using testdate: 1480010376 09:59:36 INFO - actual date: 1480010376 09:59:36 INFO - starting webserver on 'localhost:53380' 09:59:36 INFO - SUITE-START | Running 2 tests 09:59:36 INFO - TEST-START | dromaeo_css 09:59:36 INFO - operating with platform_type : linux_ 09:59:36 INFO - Initialising browser for dromaeo_css test... 09:59:36 INFO - TEST-INFO | started process 22820 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxUZmsj/profile http://localhost:53380/getInfo.html) 09:59:40 INFO - PROCESS | 22820 | __metrics Screen width/height:1600/1200 09:59:40 INFO - PROCESS | 22820 | colorDepth:24 09:59:40 INFO - PROCESS | 22820 | Browser inner width/height: 1024/697 09:59:40 INFO - PROCESS | 22820 | __metrics 09:59:41 INFO - PROCESS | 22820 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:59:41 INFO - PROCESS | 22820 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:59:41 INFO - PROCESS | 22820 | console.error: PushService: 09:59:41 INFO - PROCESS | 22820 | stateChangeProcessEnqueue: Error transitioning state 09:59:41 INFO - PROCESS | 22820 | UnknownError 09:59:42 INFO - TEST-INFO | 22820: exit 0 09:59:42 INFO - Browser initialized. 09:59:42 INFO - Running cycle 1/1 for dromaeo_css test... 09:59:42 INFO - TEST-INFO | started process 22912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxUZmsj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:59:54 INFO - PROCESS | 22912 | RSS: Main: 144609280 09:59:54 INFO - PROCESS | 22912 | 10:00:45 INFO - PROCESS | 22912 | 1480010445636 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:02:56 INFO - PROCESS | 22912 | Cycle 1(1): loaded http://localhost:53380/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53380/tests/dromaeo/cssquery-ext.html) 10:02:57 INFO - PROCESS | 22912 | RSS: Main: 247246848 10:02:57 INFO - PROCESS | 22912 | 10:05:59 INFO - PROCESS | 22912 | Cycle 1(1): loaded http://localhost:53380/tests/dromaeo/cssquery-ext.html (next: http://localhost:53380/tests/dromaeo/cssquery-jquery.html) 10:06:00 INFO - PROCESS | 22912 | RSS: Main: 232058880 10:06:00 INFO - PROCESS | 22912 | 10:09:02 INFO - PROCESS | 22912 | Cycle 1(1): loaded http://localhost:53380/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53380/tests/dromaeo/cssquery-mootools.html) 10:09:03 INFO - PROCESS | 22912 | RSS: Main: 174952448 10:09:03 INFO - PROCESS | 22912 | 10:12:05 INFO - PROCESS | 22912 | Cycle 1(1): loaded http://localhost:53380/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53380/tests/dromaeo/cssquery-prototype.html) 10:12:05 INFO - PROCESS | 22912 | RSS: Main: 172990464 10:12:05 INFO - PROCESS | 22912 | 10:15:08 INFO - PROCESS | 22912 | Cycle 1(1): loaded http://localhost:53380/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53380/tests/dromaeo/cssquery-yui.html) 10:15:08 INFO - PROCESS | 22912 | RSS: Main: 176558080 10:15:08 INFO - PROCESS | 22912 | 10:18:11 INFO - PROCESS | 22912 | Cycle 1(1): loaded http://localhost:53380/tests/dromaeo/cssquery-yui.html (next: http://localhost:53380/tests/dromaeo/cssquery-dojo.html) 10:18:11 INFO - PROCESS | 22912 | RSS: Main: 261885952 10:18:11 INFO - PROCESS | 22912 | 10:18:11 INFO - PROCESS | 22912 | __start_tp_report 10:18:11 INFO - PROCESS | 22912 | _x_x_mozilla_page_load 10:18:11 INFO - PROCESS | 22912 | _x_x_mozilla_page_load_details 10:18:11 INFO - PROCESS | 22912 | |i|pagename|runs| 10:18:11 INFO - PROCESS | 22912 | |0;dojo.html;3213.566168567243;3224.6775322467743;3249.009052239066;3262.3964566555187;3277.5903012123485;5542.22408862759;5577.86055348616;5644.209810626516;5649.12438572021;5660.235868157797;5617.0731829248225;5681.687507187103;5691.914621280674;5704.429557044294;5720.628159169651;5135.9743201283945;5166.380034395877;5187.48125187482;5189.299444574991;5230.424653288154;4877.926831097537;4898.975505122469;5062.924056139161;5239.13554263546;5253.44838791927;5099.260607211952;5173.9482605174035;5177.378714554259;5178.352705911761;5187.974060129713;5186.948130518703;5215.973920130413;5218.269442278084;5224.399194092652;5248.107821670325;4997.6001919846685;5012.548870601663;5111.514406131449;5115.667481613683;5185.299984502081;5327.680339179662;5337.866553336159;5507.9449205507835;5551.750171242304;5558.833235002957;5740.856478588069;5745.569082318801;5777.59556831022;5839.270091238595;5859.736311865976;5786.855328616818;5860.472557469806;5863.413658634145;5866.061430171152;5874.412558744134;5451.972740136313;5510.8071217507595;5573.777048918038;5589.301337332833;5614.214010038598;6133.26400831903;6133.570650054543;6146.877062458726;6149.200603921461;6152.16945712332;5791.305043394819;5905.970470147622;5913.083472061838;5921;5924.14099955504;5920.881582368328;5924.437178468039;5953.077273022688;5954.374790647006;6049.062395328731;5939.3763654816485;5986.341502434729;5991.161237426763;5993.940060599425;5994.250718660168;6020.397960203944;6020.819375418744;6021.307549631761;6030.246219222598;6058.394160583995;4524.23088075028;4556.863294101182;4577.702449340783;4617.007343421114;4617.907641847211;4134.090500089976;4134.751914885116;4160.3343465046055;4168.353905144708;4175.269327867611;5727.541796656257;5743.483086522233;5745.482906538348;5748.19525266463;5755.9424405756245;5861.5603829712945;5928.762849486058;5973.880522389528;6004.579679422486;6078.513718902477;5733.426657334317;5767.798127065533;5768;5780.855478613068;5801.187833703285;5263.131583288715;5266.7366631668265;5270.657407268515;5272.604554658416;5276.366835979707;6032.939670603326;6110.480609148272;6130.398136741914;6240.251169859646;6285.120083188357;5953.970230148821;6075.665838378932;6089.51283897296;6123.540734445023;6130.601510901777;6246.750129994749;6260.342664020212;6278.309385967448;6290;6293.527985401021;5717.37108918027;5731.684757338387;5965.109735509258;5971.58198926071;5976.163337132892;5957.642541447527;6004.42957918997;6008.429199226067;6074.149619053248;6116.755329786759;5893.6463812171405;5941.732622032106;5948.464638182584;5952.375000625046;5954.553408494467;5691.402402747652;5891.381404952418;5893.116032595145;5894.557908156819;5897.3807750185615;5739.655620662774;5793.9420605795085;5794.420557944172;5802.071668533014;5914.083317085859;5956.523478121827;5964.671943043174;5976.073708575178;5979.4917432018765;5986;5520.089185284543;5603.10350343943;5605.159226116115;5786.276715410574;5790.363060063474 10:18:11 INFO - PROCESS | 22912 | |1;ext.html;592.2448877680959;626.9592476489028;656.2387630348795;672.1631568696973;675.3955210086975;33760.15599610011;44580.554194458084;45655.31517027247;45801;45817.083658326854;46137.307940380924;46698.299525507144;46710.29934550985;46721.53278467214;46727;8261.958690206571;8474.322054235647;8822.029576746569;8976.057513961037;10685.091767199798;10456.163506919429;10881.401522916236;10885.945570272137;10888.727781805439;10890.509927053301;10994.505247263853;11032.834507482394;11041.503132359023;11051.944740276287;11052;8319.708810191645;8488;8499;8700.30397568193;10894.782104357908;10318.948405257926;10625.149988000941;10634.893651063468;10947.397893115876;10970.122390208844;43790;44198;44237.77881110574;44256.11487770259;44270;3686.502322186497;3797.6012518685416;3851.171998020411;3858.266929283427;4076.082881351702;32533.837330813432;32666.836665816758;32898.17754556131;33084.33831323384;33237.6676233237;4156.085661154541;4181.60274773896;4194.6853985951175;4206.978965105185;4213.810378532973;372521;373383;373542;373784;375442;61320.69339653273;61351.38648613546;61482.69258653678;61742.38257617456;61761.69119154375;39610.20779584392;40901.795491022356;41095;43234.56765432305;61418;18110.63778724418;18149.637007259782;18179.363722269656;18278.908605457153;18281.81718182828;12950.935245323713;13326.06717529783;13893.58319250424;14241.287935603179;14249.85750142506;20461.488462788253;20499.4875128123;20735.585288294453;20771.584568308852;20778;7267.30960558746;7319.487635865438;7420.703171873172;7565.962170189114;7569.3566046886635;1016.7254841192985;1087.211771465681;1095.5234473004268;1101.091599430473;1104.7127746785734;33467;33625.3046222687;33822.32355352879;33863.661363386054;33886.66113338884;1138.430784607696;1172.5837327748698;1199.7900367435664;1201.6575276046285;1227.4108427954632;17654.558636033944;17694.91152544255;17816.198271077832;17981.370652027115;17988.91005544964;516181;522276;523072;523256;525046;41953.79023104926;42634.57365426368;42649.78675106667;42656;42716.359254611205;1345.1256683156028;1370.6778906956856;1403.635054885737;1438.7985682004528;1444.5594093801492;30279.848600756854;33536.83231583826;34308.82845585756;34603.48094778631;35149.29701406009;50585.49414505808;59090.11364829445;60639;60898;66318.33681663121;519347;523461;523461;523760;526681;30204.395912081196;30872.84563577168;32425.35149297048;32475.67524324821;46096.53903461056;48349.5165048345;48690.5130948686;48970.510294896594;49003.509964899895;49022;40725.42379653742;41023.7948810254;41841.79079104585;42126.36810447907;42323;40315.79842100888;42189.57810421856;42530.362044568734;43128.35307470453;44418.77790611026;43055.1388972225;43358.13283734245;43842.56157438512;44466.11067778691;44503.77748111239;36519.26961460703;37172;38746.22507549889;38807.8357649271;38906;29043.419131617673;29058.564121538617;29246;29352.55971160477;29563.26091847721 10:18:11 INFO - PROCESS | 22912 | |2;jquery.html;401.82922258040327;412.15302553253053;422.5415424264673;439.7119886474358;443.65173338928946;15248.923755381222;19005.619887602257;19147.52131196719;19979.800201998012;20152.294669686566;19204.135813888373;19656.410307690756;19752.30866919658;19892.204311827547;20600.896995515002;5637.379888212304;5926.585139040248;5929.199558059671;5930.318013428447;5933.6439813611105;5544.6118771686;5808.506276966463;5853.941460585383;5855.76576936922;5860.531157507389;5849.239598852165;5856.385079566648;5862.970685146568;5869.266341707286;5869.442402971732;5693.857653558653;5899.616524925866;5929.822105336825;6026;6037.124616930564;5667.489925906647;5810.854728631776;5832.329282132567;5860.736266868002;5864.944310024194;14868.405263789435;15106.244687765568;15128.924355378153;16566.420175293926;23154;2346.941326466835;2385.2128797496785;2503.311589312935;2574.4336246025846;2665.6534650495505;11036.392998385085;11148;11214.831777523344;11484.310941343547;15522;1879.1168150969158;1917.3481016454332;1965.6167047425758;1978.9901050494655;2016.485796121994;78694.21305786983;87491.56254218688;87790.24419511638;88203;90246.09753902443;9894.752631184134;10446;10543.472826358651;10628.627998020032;11776.234544754563;14652.12087274767;15125.319360628579;15927;15956.840431595767;15958.60103497422;6552.3775241352;8026.959865200637;8316.043654979634;8355.373346998878;8409.705660301861;8024.919750802534;8067.677292908218;8235.629396677165;8235.8352832943;8263.462874913112;5103.311053007871;5181.663191892515;5193.922091168635;5237.397699264633;5289.153735402318;2036.1448191759496;2062.236972320251;2085.6975738518136;2103.8001389867936;2126.6172089024126;997.5858422617283;1015.7003683913264;1041.9270651054353;1051.027799285673;1085.2620218251507;19956.50108747293;20208.254899241158;20369.796302037088;20528.692069618966;20767.8961605194;998.83519219328;1024.0578667625803;1024.6004058417075;1074.9516271767789;1098.6649072033106;10581.629642962613;11039.116870650329;11039.178535541707;11109.83335249972;11128.777424451466;518342;519060;532544;543321;549756;96148;97573;99747.50126249323;103907;103936;1068.391017120234;1081.2539347849959;1082.9133669306436;1104.8563686720674;1110.6723516562633;17137.91431042837;17381.044042577778;17790.822091779435;17948;17978.460646180636;31335;45753.77123114363;46122.308165376875;47118;47247.76376118235;60855;61602.38397615967;62611;63177;63865.68067159635;8774.605142768463;8887.466751994902;8895.288376929959;9380.624775008922;9442.622295108118;9539.618415263312;12757.55348562833;13220.735585288432;13406.463741450232;13455.259960702255;11024.889751102386;11801.881981180079;11866.347350895783;12014.699632508908;12468.251904885736;10840.362542586883;11034.117270618171;11457.59898403552;11908.523659053888;12065.155439119177;12225.69435764113;12244.693882653006;12284.1401101922;12411.503539858304;12581.93709031449;9205.263578913537;9423.246140308896;9566.091221333962;9595.616175352907;9677.22582193437;11909.880901190878;12210.694732631755;12229.633111006684;12271.202371845802;12389.318587477415 10:18:11 INFO - PROCESS | 22912 | |3;mootools.html;1361.891048716103;1494.4619936822742;1529.461094582992;1704.8124706282315;1821.7540632014675;7192.352688258055;8232.711855085066;8447.535385553792;8481.151884811516;8735.868961965576;8539.78650533737;8596.054434012269;8604.956975215131;8608.139186081404;8618.138186181379;2468.802495800336;2496.0390249753887;2498.600223964166;2499.562576549097;2503.399184195789;2399.916002939897;2525.722170561237;2526.5831137862233;2531.9240422787348;2532.746725327471;2446.755324467557;2454.1165180534995;2499.212747984388;2499.6500489931423;2517.0183628384943;2341.4497593065616;2372.869492177921;2394.3535245483795;2396.2212281008656;2421.4672771990136;2441.9755802441928;2456.828022038458;2478.8264821462503;2484.503099380131;2484.527939691453;8629;8690.08754080825;8734.956325218396;8752.737417877473;8823.911760882373;5432.266644003088;5688.60179787415;5690.487856092972;5694.202811606378;5695.1741997410145;3414.146463384154;3488.5464889564446;3536.6286539913453;3549.112721819545;3586.497890295361;1091.3670071358592;1103.624767579027;1113.799516087104;1117.5082963496118;1151.2689442204178;11817;11866.881331186663;11926.105542084379;11927.582534611247;11955.521779128825;4590.9540904591195;4753.930365667767;4863.148948933923;4869.172240719086;4871.732054737024;9693.273004524548;9787.559559819825;9796.314258001872;9809.509524523888;9811.803763924681;5396.163594642837;5410.269613602113;5467;5486.478784515464;5487.807926722626;4251.766152861623;4505.932411013838;4571.26859702446;5010.799568017239;5131.435542090367;3935.779908228458;4024.3561030235023;4073.5926407359025;4114.280000999813;4128.6284234419045;1257.4718618180386;1266.069438962362;1266.6516707905216;1266.714989127439;1304.2565737529708;970.8106919150698;978.8629591857145;981.9754506137403;997.2249396074998;998.7453199434098;5821.912671309934;5868.002439585281;5908.320543137508;5957.523398128139;5993.970030149909;493.10747546940155;499.12901986033876;501.0905207049194;507.32019094412925;519.477924685696;4005.35914253718;4041.9797901010306;4080.9183816323507;4093.079057212163;4104.322786740155;10453.581856725797;10957.50691218897;10963.068139208097;10972.890271097347;11015.228933974706;10237.385756854612;10901.618443354602;10915.072218861485;10920.344779313267;10921.180911431515;7883;7947.205279472122;8006.559639219782;8018.83962320762;8025.759227223192;5691.2032315475035;5752;5838.94161058384;5861.296644402529;5945.613535120204;10080.243981701255;10086.949565252127;10110;10110.292279540361;10203.7449063774;8648.78378040554;8830.072842351461;10066.094051535398;10078.596856125672;10177.542010609688;7600.771976840703;7940.245676660708;8012.719554815553;8023.518588884685;8025.8796118059445;8475.83048339042;8484.406091573777;8526.488410695378;8529.14708529142;8541.829163416822;7582.279683430065;7699.191584883731;7701.383889288732;7732.265434783687;7746.690132394641;7438.814029649302;7527.736529221451;7569.886451703339;7589.734359297398;7767.1067827200595;7069.6111713856235;7194.280571942764;7197.1363436387965;7197.820054498679;7208.45936554771;4948.678335908155;5004.024215278131;5068.949310506995;5095.92356114666;5219.608529360237;5064.746762661778;5068.417132029716;5100.540951314251;5136.229565565195;5263.421023687468 10:18:11 INFO - PROCESS | 22912 | |4;prototype.html;361.4036839215295;362.3767120552649;363.94358874374467;365.9304732100899;371.0316075044136;5458.5087342139195;5462.562994960394;5468.644538105021;5484.149956756699;5491.725413729318;5383.650062745919;5394.298741163653;5400.864978375543;5403.78384864606;5419;4040.7271709411516;4217.325227963511;4229.7885105744745;4264.78676066197;4270.466191726035;4247.193033323674;4248;4254.532001479834;4258.6380157686635;4267.4025636410925;4231.724937879028;4232.74603523788;4249.44757181566;4256.829726810939;4279.058607106447;4162.8959276018195;4240.08838099807;4275.87172384829;4288.313869780835;4288.335308027261;3730.309892669865;3738.719596030309;3742.1954279829965;3742.3263812513737;3742.644448777362;5261.657992230493;5262.526372626482;5275.920861187085;5327.334083239595;5337.919931201035;4773.928391074137;4823.20417131173;4842.394700662418;4872.415310162768;4880.656750126175;5561;5585.748641311151;5625.71871406428;5658.603897727119;5666.971665141689;4111.444954931076;4129.174165166979;4145.54399016108;4149.211649786531;4161.126163505667;5622.32532096151;5769.740361683693;5799.449052339979;5891.43568141277;5905.763769449217;4191.580841915784;4196.328587425997;4198.85304014358;4224.239636865333;4227.534971153171;4242;4260.466232156421;4265.658747300208;4271.530131685512;4285.292926667127;4625.468071171858;4797.088553174885;4843.588294994965;4856.150173719585;4856.465788763233;5657.830265092054;5665.235193248941;5667.971660141673;5669.9794037073725;5671.744771485211;1419.7160567886465;1440.854520656081;1443.7762146867253;1444.6893917807722;1447.3269929482842;958.520739630185;1000.8048430556117;1002.4386343647581;1007.1992765751245;1019.7348689340677;5288.206768984683;5301.390340110936;5307.840764777063;5311.628186027018;5333.973330133324;5618.353889302701;5622.819207966373;5624.859378515488;5639.436056394327;5656.830295091154;5077.593792496666;5271.973640131775;5329.573634109262;5337.439568845293;5338.5442696360105;2980.538016607429;2982.3737015227043;2998.220462679719;3001.9249518761767;3011.518157094898;5784.161296611967;5825.825225243249;5862.179294898718;5895.322037965603;5905.173275741399;5608.906263278622;5686.459786320293;5930.466258036798;5932.3474417814;5952.434518720715;5916.881662366729;5992.67040312787;6037.245344331958;6059.8485037873525;6084.41805130678;5858.94141058584;5863.794767183128;5927.347991720993;5930.940690593039;5940.346561878277;5443.891122177613;5483.232347471437;5746.3966283541295;5772.249607550992;5835.4748072673665;6005.549583781147;6063.454289114001;6108.564487345559;6110.633361998294;6124.724387402666;4188;4243.957560424356;4249.3625956106835;4286.849960251377;4294.119705460435;5855.648661080349;5872.207252020922;5880.970595146997;5895.528357731457;5911.261092363455;5741.626794258527;5764.337101233412;5772.105323674669;5784.248047753765;5794.217780599565;5526.889462210653;5686.687232202268;5701.116326969326;5717.599768016199;5755.366909639853;5651.2935883014625;5694.800681976111;5714.628549144292;5719.599628025998;5724.198612194213;5622.269105016322;5757.5393968481585;5815.93534295319;5824.94175058244;5849.327327357239;5518.44815518461;5588.664680119044;5590.552755779447;5595.496405323541;5595.916061259003 10:18:11 INFO - PROCESS | 22912 | |5;yui.html;801.6913488307002;802.8193656427304;806.7821688144202;828.6685325869652;869.7347309070731;15255.313510892009;15841.603959900995;16309.266083026263;16529.090900000494;16604.999999999985;14620.4882829101;14703.19132447715;14863.851361486382;14942.178180200084;15029.32368043438;727.1165533876339;756.0662581711582;858.0261403307244;870.5951732444412;873.3668090634271;836.6277006732007;866.7659731872391;871.3464901324007;872.0973792125152;874.1564390363299;914.0402577293848;917.7430319510514;917.7843206846419;918.274563095154;919;760.3612965109279;785.5561607691636;913.7715571107224;914.1087439746261;914.3508109242413;648.4488185042724;662.9966850165719;667.6428110960661;668.9163854518185;669.6685140855259;14605.70788584233;14639.853601463956;14659;14671.33978970949;14678;13928.860711392857;14085.929570352186;14091.436342546285;14152;14213.43146274158;11858.644240672793;11928.284302941851;11996.160268781188;12108.636740897788;12250.938745306217;4389.231884420214;4433.401490798766;4458.3535387368975;4497.302918047708;4526.456825181;58655.82688346252;59952.40047599512;61687;63209;65506.672466637836;11197.384143872165;11446.08431325492;11642.185047046794;11651.417429128509;11887.524499020115;20900.477488062617;20926.267580634605;20939.79060209409;20959.37121886346;20988.055537500848;8366.58167091643;8449.408541402167;8521.659133634585;8755.124487551322;8891.155340242667;4591.150637132141;4591.655625828076;4603.470600880942;4649.651276154302;4760.64295177863;3513.94729079064;3611.2416392557857;3625.7643253188457;3627.981860090683;3631.9818400907825;619.3837132053545;632.8449529865212;649.2144505148823;662.6090606542164;672.2034389248756;725.0755287009106;732.739877343546;762.272030211147;782.8551717932087;821.9958900205461;9913;10146.644867429604;10316.587336506605;10402.531886064993;10760.838587421194;744.6872313628289;788.8461749958818;803.7869964459423;812.1391325195311;817.358373676661;4699.436067671902;4890.437599676083;4901.926471102936;4917.58200552957;4935.90128197434;91452;94599;94950.52524737471;95506;99027;79529.60235198903;79626.6018669903;81202.99999999882;81489;84383.57808211043;74446.62776686082;74728;75059.62470187614;75475.62262188653;76207;9675.854862177213;9705.17506011997;9851.704448866545;9949.602015919281;9981.850272246067;48155.75922120367;48498.27252591143;48513;48603.27095093505;49276;62098;64310;67339.3266067333;68080.6595967017;68881.65559172373;12739;12768.6807829805;12822.358882056047;12823.807642885178;13168.670783230496;13544.729105417638;13756.312184390941;13772.380242888894;13831.585052448443;14163.079399838978;12731.427085781348;12977.935110324388;13015.349232538525;13411.329433528479;13561.525346612822;12428.689282768004;12481.438335275116;12507;12660.303683297507;12774.425150868048;11759.118541033393;12139.817902731642;12161.635150945485;12259.938700306442;12368.690782730504;10231.693049208536;10368.857562700565;10417.270791044553;10436.895631043895;10461.68614941553;9906.306558540833;10653.201009924132;10729.517171727135;10747.838782418114;10885.945570272099 10:18:11 INFO - PROCESS | 22912 | __end_tp_report 10:18:11 INFO - PROCESS | 22912 | __start_cc_report 10:18:11 INFO - PROCESS | 22912 | _x_x_mozilla_cycle_collect,1072 10:18:11 INFO - PROCESS | 22912 | __end_cc_report 10:18:11 INFO - PROCESS | 22912 | __startTimestamp1480011491650__endTimestamp 10:18:11 INFO - PROCESS | 22912 | 10:18:11 INFO - PROCESS | 22912 | ------- Summary: start ------- 10:18:11 INFO - PROCESS | 22912 | Number of tests: 6 10:18:11 INFO - PROCESS | 22912 | 10:18:11 INFO - PROCESS | 22912 | [#0] dojo.html Cycles:165 Average:5577.15 Median:5777.60 stddev:622.83 (10.8%) stddev-sans-first:596.50 10:18:11 INFO - PROCESS | 22912 | Values: 3213.6 3224.7 3249.0 3262.4 3277.6 5542.2 5577.9 5644.2 5649.1 5660.2 5617.1 5681.7 5691.9 5704.4 5720.6 5136.0 5166.4 5187.5 5189.3 5230.4 4877.9 4899.0 5062.9 5239.1 5253.4 5099.3 5173.9 5177.4 5178.4 5188.0 5186.9 5216.0 5218.3 5224.4 5248.1 4997.6 5012.5 5111.5 5115.7 5185.3 5327.7 5337.9 5507.9 5551.8 5558.8 5740.9 5745.6 5777.6 5839.3 5859.7 5786.9 5860.5 5863.4 5866.1 5874.4 5452.0 5510.8 5573.8 5589.3 5614.2 6133.3 6133.6 6146.9 6149.2 6152.2 5791.3 5906.0 5913.1 5921.0 5924.1 5920.9 5924.4 5953.1 5954.4 6049.1 5939.4 5986.3 5991.2 5993.9 5994.3 6020.4 6020.8 6021.3 6030.2 6058.4 4524.2 4556.9 4577.7 4617.0 4617.9 4134.1 4134.8 4160.3 4168.4 4175.3 5727.5 5743.5 5745.5 5748.2 5755.9 5861.6 5928.8 5973.9 6004.6 6078.5 5733.4 5767.8 5768.0 5780.9 5801.2 5263.1 5266.7 5270.7 5272.6 5276.4 6032.9 6110.5 6130.4 6240.3 6285.1 5954.0 6075.7 6089.5 6123.5 6130.6 6246.8 6260.3 6278.3 6290.0 6293.5 5717.4 5731.7 5965.1 5971.6 5976.2 5957.6 6004.4 6008.4 6074.1 6116.8 5893.6 5941.7 5948.5 5952.4 5954.6 5691.4 5891.4 5893.1 5894.6 5897.4 5739.7 5793.9 5794.4 5802.1 5914.1 5956.5 5964.7 5976.1 5979.5 5986.0 5520.1 5603.1 5605.2 5786.3 5790.4 10:18:11 INFO - PROCESS | 22912 | 10:18:11 INFO - PROCESS | 22912 | [#1] ext.html Cycles:180 Average:63365.26 Median:39258.10 stddev:126772.70 (322.9%) stddev-sans-first:127040.72 10:18:11 INFO - PROCESS | 22912 | Values: 592.2 627.0 656.2 672.2 675.4 33760.2 44580.6 45655.3 45801.0 45817.1 46137.3 46698.3 46710.3 46721.5 46727.0 8262.0 8474.3 8822.0 8976.1 10685.1 10456.2 10881.4 10885.9 10888.7 10890.5 10994.5 11032.8 11041.5 11051.9 11052.0 8319.7 8488.0 8499.0 8700.3 10894.8 10318.9 10625.1 10634.9 10947.4 10970.1 43790.0 44198.0 44237.8 44256.1 44270.0 3686.5 3797.6 3851.2 3858.3 4076.1 32533.8 32666.8 32898.2 33084.3 33237.7 4156.1 4181.6 4194.7 4207.0 4213.8 372521.0 373383.0 373542.0 373784.0 375442.0 61320.7 61351.4 61482.7 61742.4 61761.7 39610.2 40901.8 41095.0 43234.6 61418.0 18110.6 18149.6 18179.4 18278.9 18281.8 12950.9 13326.1 13893.6 14241.3 14249.9 20461.5 20499.5 20735.6 20771.6 20778.0 7267.3 7319.5 7420.7 7566.0 7569.4 1016.7 1087.2 1095.5 1101.1 1104.7 33467.0 33625.3 33822.3 33863.7 33886.7 1138.4 1172.6 1199.8 1201.7 1227.4 17654.6 17694.9 17816.2 17981.4 17988.9 516181.0 522276.0 523072.0 523256.0 525046.0 41953.8 42634.6 42649.8 42656.0 42716.4 1345.1 1370.7 1403.6 1438.8 1444.6 30279.8 33536.8 34308.8 34603.5 35149.3 50585.5 59090.1 60639.0 60898.0 66318.3 519347.0 523461.0 523461.0 523760.0 526681.0 30204.4 30872.8 32425.4 32475.7 46096.5 48349.5 48690.5 48970.5 49003.5 49022.0 40725.4 41023.8 41841.8 42126.4 42323.0 40315.8 42189.6 42530.4 43128.4 44418.8 43055.1 43358.1 43842.6 44466.1 44503.8 36519.3 37172.0 38746.2 38807.8 38906.0 29043.4 29058.6 29246.0 29352.6 29563.3 10:18:11 INFO - PROCESS | 22912 | 10:18:11 INFO - PROCESS | 22912 | [#2] jquery.html Cycles:180 Average:30766.62 Median:2115.21 stddev:87928.06 (4156.9%) stddev-sans-first:88145.16 10:18:11 INFO - PROCESS | 22912 | Values: 401.8 412.2 422.5 439.7 443.7 15248.9 19005.6 19147.5 19979.8 20152.3 19204.1 19656.4 19752.3 19892.2 20600.9 5637.4 5926.6 5929.2 5930.3 5933.6 5544.6 5808.5 5853.9 5855.8 5860.5 5849.2 5856.4 5863.0 5869.3 5869.4 5693.9 5899.6 5929.8 6026.0 6037.1 5667.5 5810.9 5832.3 5860.7 5864.9 14868.4 15106.2 15128.9 16566.4 23154.0 2346.9 2385.2 2503.3 2574.4 2665.7 11036.4 11148.0 11214.8 11484.3 15522.0 1879.1 1917.3 1965.6 1979.0 2016.5 78694.2 87491.6 87790.2 88203.0 90246.1 9894.8 10446.0 10543.5 10628.6 11776.2 14652.1 15125.3 15927.0 15956.8 15958.6 6552.4 8027.0 8316.0 8355.4 8409.7 8024.9 8067.7 8235.6 8235.8 8263.5 5103.3 5181.7 5193.9 5237.4 5289.2 2036.1 2062.2 2085.7 2103.8 2126.6 997.6 1015.7 1041.9 1051.0 1085.3 19956.5 20208.3 20369.8 20528.7 20767.9 998.8 1024.1 1024.6 1075.0 1098.7 10581.6 11039.1 11039.2 11109.8 11128.8 518342.0 519060.0 532544.0 543321.0 549756.0 96148.0 97573.0 99747.5 103907.0 103936.0 1068.4 1081.3 1082.9 1104.9 1110.7 17137.9 17381.0 17790.8 17948.0 17978.5 31335.0 45753.8 46122.3 47118.0 47247.8 60855.0 61602.4 62611.0 63177.0 63865.7 8774.6 8887.5 8895.3 9380.6 9442.6 9539.6 12757.6 13220.7 13406.5 13455.3 11024.9 11801.9 11866.3 12014.7 12468.3 10840.4 11034.1 11457.6 11908.5 12065.2 12225.7 12244.7 12284.1 12411.5 12581.9 9205.3 9423.2 9566.1 9595.6 9677.2 11909.9 12210.7 12229.6 12271.2 12389.3 10:18:11 INFO - PROCESS | 22912 | 10:18:11 INFO - PROCESS | 22912 | [#3] mootools.html Cycles:180 Average:5759.00 Median:2755.95 stddev:3199.64 (116.1%) stddev-sans-first:3191.55 10:18:11 INFO - PROCESS | 22912 | Values: 1361.9 1494.5 1529.5 1704.8 1821.8 7192.4 8232.7 8447.5 8481.2 8735.9 8539.8 8596.1 8605.0 8608.1 8618.1 2468.8 2496.0 2498.6 2499.6 2503.4 2399.9 2525.7 2526.6 2531.9 2532.7 2446.8 2454.1 2499.2 2499.7 2517.0 2341.4 2372.9 2394.4 2396.2 2421.5 2442.0 2456.8 2478.8 2484.5 2484.5 8629.0 8690.1 8735.0 8752.7 8823.9 5432.3 5688.6 5690.5 5694.2 5695.2 3414.1 3488.5 3536.6 3549.1 3586.5 1091.4 1103.6 1113.8 1117.5 1151.3 11817.0 11866.9 11926.1 11927.6 11955.5 4591.0 4753.9 4863.1 4869.2 4871.7 9693.3 9787.6 9796.3 9809.5 9811.8 5396.2 5410.3 5467.0 5486.5 5487.8 4251.8 4505.9 4571.3 5010.8 5131.4 3935.8 4024.4 4073.6 4114.3 4128.6 1257.5 1266.1 1266.7 1266.7 1304.3 970.8 978.9 982.0 997.2 998.7 5821.9 5868.0 5908.3 5957.5 5994.0 493.1 499.1 501.1 507.3 519.5 4005.4 4042.0 4080.9 4093.1 4104.3 10453.6 10957.5 10963.1 10972.9 11015.2 10237.4 10901.6 10915.1 10920.3 10921.2 7883.0 7947.2 8006.6 8018.8 8025.8 5691.2 5752.0 5838.9 5861.3 5945.6 10080.2 10086.9 10110.0 10110.3 10203.7 8648.8 8830.1 10066.1 10078.6 10177.5 7600.8 7940.2 8012.7 8023.5 8025.9 8475.8 8484.4 8526.5 8529.1 8541.8 7582.3 7699.2 7701.4 7732.3 7746.7 7438.8 7527.7 7569.9 7589.7 7767.1 7069.6 7194.3 7197.1 7197.8 7208.5 4948.7 5004.0 5068.9 5095.9 5219.6 5064.7 5068.4 5100.5 5136.2 5263.4 10:18:11 INFO - PROCESS | 22912 | 10:18:11 INFO - PROCESS | 22912 | [#4] prototype.html Cycles:180 Average:4782.80 Median:5397.58 stddev:1395.12 (25.8%) stddev-sans-first:1358.99 10:18:11 INFO - PROCESS | 22912 | Values: 361.4 362.4 363.9 365.9 371.0 5458.5 5462.6 5468.6 5484.1 5491.7 5383.7 5394.3 5400.9 5403.8 5419.0 4040.7 4217.3 4229.8 4264.8 4270.5 4247.2 4248.0 4254.5 4258.6 4267.4 4231.7 4232.7 4249.4 4256.8 4279.1 4162.9 4240.1 4275.9 4288.3 4288.3 3730.3 3738.7 3742.2 3742.3 3742.6 5261.7 5262.5 5275.9 5327.3 5337.9 4773.9 4823.2 4842.4 4872.4 4880.7 5561.0 5585.7 5625.7 5658.6 5667.0 4111.4 4129.2 4145.5 4149.2 4161.1 5622.3 5769.7 5799.4 5891.4 5905.8 4191.6 4196.3 4198.9 4224.2 4227.5 4242.0 4260.5 4265.7 4271.5 4285.3 4625.5 4797.1 4843.6 4856.2 4856.5 5657.8 5665.2 5668.0 5670.0 5671.7 1419.7 1440.9 1443.8 1444.7 1447.3 958.5 1000.8 1002.4 1007.2 1019.7 5288.2 5301.4 5307.8 5311.6 5334.0 5618.4 5622.8 5624.9 5639.4 5656.8 5077.6 5272.0 5329.6 5337.4 5338.5 2980.5 2982.4 2998.2 3001.9 3011.5 5784.2 5825.8 5862.2 5895.3 5905.2 5608.9 5686.5 5930.5 5932.3 5952.4 5916.9 5992.7 6037.2 6059.8 6084.4 5858.9 5863.8 5927.3 5930.9 5940.3 5443.9 5483.2 5746.4 5772.2 5835.5 6005.5 6063.5 6108.6 6110.6 6124.7 4188.0 4244.0 4249.4 4286.8 4294.1 5855.6 5872.2 5881.0 5895.5 5911.3 5741.6 5764.3 5772.1 5784.2 5794.2 5526.9 5686.7 5701.1 5717.6 5755.4 5651.3 5694.8 5714.6 5719.6 5724.2 5622.3 5757.5 5815.9 5824.9 5849.3 5518.4 5588.7 5590.6 5595.5 5595.9 10:18:11 INFO - PROCESS | 22912 | 10:18:11 INFO - PROCESS | 22912 | [#5] yui.html Cycles:180 Average:18646.15 Median:48505.64 stddev:25006.55 (51.6%) stddev-sans-first:25040.80 10:18:11 INFO - PROCESS | 22912 | Values: 801.7 802.8 806.8 828.7 869.7 15255.3 15841.6 16309.3 16529.1 16605.0 14620.5 14703.2 14863.9 14942.2 15029.3 727.1 756.1 858.0 870.6 873.4 836.6 866.8 871.3 872.1 874.2 914.0 917.7 917.8 918.3 919.0 760.4 785.6 913.8 914.1 914.4 648.4 663.0 667.6 668.9 669.7 14605.7 14639.9 14659.0 14671.3 14678.0 13928.9 14085.9 14091.4 14152.0 14213.4 11858.6 11928.3 11996.2 12108.6 12250.9 4389.2 4433.4 4458.4 4497.3 4526.5 58655.8 59952.4 61687.0 63209.0 65506.7 11197.4 11446.1 11642.2 11651.4 11887.5 20900.5 20926.3 20939.8 20959.4 20988.1 8366.6 8449.4 8521.7 8755.1 8891.2 4591.2 4591.7 4603.5 4649.7 4760.6 3513.9 3611.2 3625.8 3628.0 3632.0 619.4 632.8 649.2 662.6 672.2 725.1 732.7 762.3 782.9 822.0 9913.0 10146.6 10316.6 10402.5 10760.8 744.7 788.8 803.8 812.1 817.4 4699.4 4890.4 4901.9 4917.6 4935.9 91452.0 94599.0 94950.5 95506.0 99027.0 79529.6 79626.6 81203.0 81489.0 84383.6 74446.6 74728.0 75059.6 75475.6 76207.0 9675.9 9705.2 9851.7 9949.6 9981.9 48155.8 48498.3 48513.0 48603.3 49276.0 62098.0 64310.0 67339.3 68080.7 68881.7 12739.0 12768.7 12822.4 12823.8 13168.7 13544.7 13756.3 13772.4 13831.6 14163.1 12731.4 12977.9 13015.3 13411.3 13561.5 12428.7 12481.4 12507.0 12660.3 12774.4 11759.1 12139.8 12161.6 12259.9 12368.7 10231.7 10368.9 10417.3 10436.9 10461.7 9906.3 10653.2 10729.5 10747.8 10885.9 10:18:11 INFO - PROCESS | 22912 | -------- Summary: end -------- 10:18:11 INFO - PROCESS | 22912 | 10:18:12 INFO - TEST-INFO | 22912: exit 0 10:18:12 INFO - TEST-OK | dromaeo_css | took 1115874ms 10:18:12 INFO - TEST-START | kraken 10:18:12 INFO - operating with platform_type : linux_ 10:18:12 INFO - Initialising browser for kraken test... 10:18:12 INFO - TEST-INFO | started process 23232 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLM1HZ2/profile http://localhost:53380/getInfo.html) 10:18:16 INFO - PROCESS | 23232 | __metrics Screen width/height:1600/1200 10:18:16 INFO - PROCESS | 23232 | colorDepth:24 10:18:16 INFO - PROCESS | 23232 | Browser inner width/height: 1024/697 10:18:16 INFO - PROCESS | 23232 | __metrics 10:18:17 INFO - PROCESS | 23232 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:18:17 INFO - PROCESS | 23232 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:18:17 INFO - PROCESS | 23232 | console.error: PushService: 10:18:17 INFO - PROCESS | 23232 | stateChangeProcessEnqueue: Error transitioning state 10:18:17 INFO - PROCESS | 23232 | UnknownError 10:18:18 INFO - TEST-INFO | 23232: exit 0 10:18:18 INFO - Browser initialized. 10:18:18 INFO - Running cycle 1/1 for kraken test... 10:18:18 INFO - TEST-INFO | started process 23324 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLM1HZ2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:18:30 INFO - PROCESS | 23324 | RSS: Main: 144490496 10:18:30 INFO - PROCESS | 23324 | 10:18:32 INFO - PROCESS | 23324 | Cycle 1(1): loaded http://localhost:53380/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53380/tests/kraken/driver.html?testName=audio-beat-detection) 10:18:33 INFO - PROCESS | 23324 | RSS: Main: 185815040 10:18:33 INFO - PROCESS | 23324 | 10:18:36 INFO - PROCESS | 23324 | Cycle 1(1): loaded http://localhost:53380/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53380/tests/kraken/driver.html?testName=audio-dft) 10:18:36 INFO - PROCESS | 23324 | RSS: Main: 175579136 10:18:36 INFO - PROCESS | 23324 | 10:18:39 INFO - PROCESS | 23324 | Cycle 1(1): loaded http://localhost:53380/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53380/tests/kraken/driver.html?testName=audio-fft) 10:18:40 INFO - PROCESS | 23324 | RSS: Main: 266735616 10:18:40 INFO - PROCESS | 23324 | 10:18:42 INFO - PROCESS | 23324 | Cycle 1(1): loaded http://localhost:53380/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53380/tests/kraken/driver.html?testName=audio-oscillator) 10:18:42 INFO - PROCESS | 23324 | RSS: Main: 173211648 10:18:42 INFO - PROCESS | 23324 | 10:18:44 INFO - PROCESS | 23324 | Cycle 1(1): loaded http://localhost:53380/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53380/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:18:45 INFO - PROCESS | 23324 | RSS: Main: 175337472 10:18:45 INFO - PROCESS | 23324 | 10:18:48 INFO - PROCESS | 23324 | Cycle 1(1): loaded http://localhost:53380/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53380/tests/kraken/driver.html?testName=imaging-darkroom) 10:18:49 INFO - PROCESS | 23324 | RSS: Main: 214380544 10:18:49 INFO - PROCESS | 23324 | 10:18:52 INFO - PROCESS | 23324 | Cycle 1(1): loaded http://localhost:53380/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53380/tests/kraken/driver.html?testName=imaging-desaturate) 10:18:53 INFO - PROCESS | 23324 | RSS: Main: 213319680 10:18:53 INFO - PROCESS | 23324 | 10:18:55 INFO - PROCESS | 23324 | Cycle 1(1): loaded http://localhost:53380/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53380/tests/kraken/driver.html?testName=json-parse-financial) 10:18:56 INFO - PROCESS | 23324 | RSS: Main: 211767296 10:18:56 INFO - PROCESS | 23324 | 10:18:57 INFO - PROCESS | 23324 | Cycle 1(1): loaded http://localhost:53380/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53380/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:18:58 INFO - PROCESS | 23324 | RSS: Main: 174206976 10:18:58 INFO - PROCESS | 23324 | 10:19:00 INFO - PROCESS | 23324 | Cycle 1(1): loaded http://localhost:53380/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53380/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:19:00 INFO - PROCESS | 23324 | RSS: Main: 181432320 10:19:00 INFO - PROCESS | 23324 | 10:19:02 INFO - PROCESS | 23324 | Cycle 1(1): loaded http://localhost:53380/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53380/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:19:03 INFO - PROCESS | 23324 | RSS: Main: 190271488 10:19:03 INFO - PROCESS | 23324 | 10:19:05 INFO - PROCESS | 23324 | Cycle 1(1): loaded http://localhost:53380/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53380/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:19:06 INFO - PROCESS | 23324 | RSS: Main: 198897664 10:19:06 INFO - PROCESS | 23324 | 10:19:09 INFO - PROCESS | 23324 | Cycle 1(1): loaded http://localhost:53380/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53380/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:19:09 INFO - PROCESS | 23324 | RSS: Main: 195678208 10:19:09 INFO - PROCESS | 23324 | 10:19:11 INFO - PROCESS | 23324 | Cycle 1(1): loaded http://localhost:53380/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53380/tests/kraken/driver.html?testName=ai-astar) 10:19:11 INFO - PROCESS | 23324 | RSS: Main: 246390784 10:19:11 INFO - PROCESS | 23324 | 10:19:11 INFO - PROCESS | 23324 | __start_tp_report 10:19:11 INFO - PROCESS | 23324 | _x_x_mozilla_page_load 10:19:11 INFO - PROCESS | 23324 | _x_x_mozilla_page_load_details 10:19:11 INFO - PROCESS | 23324 | |i|pagename|runs| 10:19:11 INFO - PROCESS | 23324 | |0;ai-astar;106;111;112;111;112;111;111;110;112;110 10:19:11 INFO - PROCESS | 23324 | |1;audio-beat-detection;142;125;121;150;120;122;121;126;150;119 10:19:11 INFO - PROCESS | 23324 | |2;audio-dft;161;161;161;160;161;160;161;160;161;162 10:19:11 INFO - PROCESS | 23324 | |3;audio-fft;75;76;75;123;75;75;74;75;104;75 10:19:11 INFO - PROCESS | 23324 | |4;audio-oscillator;82;81;129;82;82;81;107;81;81;100 10:19:11 INFO - PROCESS | 23324 | |5;imaging-gaussian-blur;117;117;116;118;117;116;116;117;117;116 10:19:11 INFO - PROCESS | 23324 | |6;imaging-darkroom;146;146;146;146;146;146;145;147;146;145 10:19:11 INFO - PROCESS | 23324 | |7;imaging-desaturate;84;84;85;84;85;84;84;84;84;85 10:19:11 INFO - PROCESS | 23324 | |8;json-parse-financial;51;58;49;51;50;49;50;49;49;50 10:19:11 INFO - PROCESS | 23324 | |9;json-stringify-tinderbox;59;60;60;60;61;61;60;61;60;60 10:19:11 INFO - PROCESS | 23324 | |10;stanford-crypto-aes;75;74;75;75;75;74;76;82;74;75 10:19:11 INFO - PROCESS | 23324 | |11;stanford-crypto-ccm;128;126;135;125;126;125;133;123;164;125 10:19:11 INFO - PROCESS | 23324 | |12;stanford-crypto-pbkdf2;159;154;159;152;157;155;154;152;157;156 10:19:11 INFO - PROCESS | 23324 | |13;stanford-crypto-sha256-iterative;65;64;62;61;62;61;61;60;61;59 10:19:11 INFO - PROCESS | 23324 | __end_tp_report 10:19:11 INFO - PROCESS | 23324 | __start_cc_report 10:19:11 INFO - PROCESS | 23324 | _x_x_mozilla_cycle_collect,1631 10:19:11 INFO - PROCESS | 23324 | __end_cc_report 10:19:11 INFO - PROCESS | 23324 | __startTimestamp1480011551610__endTimestamp 10:19:11 INFO - PROCESS | 23324 | 10:19:11 INFO - PROCESS | 23324 | ------- Summary: start ------- 10:19:11 INFO - PROCESS | 23324 | Number of tests: 14 10:19:11 INFO - PROCESS | 23324 | 10:19:11 INFO - PROCESS | 23324 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.78 (1.6%) stddev-sans-first:0.78 10:19:11 INFO - PROCESS | 23324 | Values: 106.0 111.0 112.0 111.0 112.0 111.0 111.0 110.0 112.0 110.0 10:19:11 INFO - PROCESS | 23324 | 10:19:11 INFO - PROCESS | 23324 | [#1] audio-beat-detection Cycles:10 Average:129.60 Median:125.50 stddev:12.61 (10.0%) stddev-sans-first:12.55 10:19:11 INFO - PROCESS | 23324 | Values: 142.0 125.0 121.0 150.0 120.0 122.0 121.0 126.0 150.0 119.0 10:19:11 INFO - PROCESS | 23324 | 10:19:11 INFO - PROCESS | 23324 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 10:19:11 INFO - PROCESS | 23324 | Values: 161.0 161.0 161.0 160.0 161.0 160.0 161.0 160.0 161.0 162.0 10:19:11 INFO - PROCESS | 23324 | 10:19:11 INFO - PROCESS | 23324 | [#3] audio-fft Cycles:10 Average:82.70 Median:75.00 stddev:16.85 (22.5%) stddev-sans-first:17.64 10:19:11 INFO - PROCESS | 23324 | Values: 75.0 76.0 75.0 123.0 75.0 75.0 74.0 75.0 104.0 75.0 10:19:11 INFO - PROCESS | 23324 | 10:19:11 INFO - PROCESS | 23324 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:81.00 stddev:16.41 (20.3%) stddev-sans-first:17.10 10:19:11 INFO - PROCESS | 23324 | Values: 82.0 81.0 129.0 82.0 82.0 81.0 107.0 81.0 81.0 100.0 10:19:11 INFO - PROCESS | 23324 | 10:19:11 INFO - PROCESS | 23324 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 10:19:11 INFO - PROCESS | 23324 | Values: 117.0 117.0 116.0 118.0 117.0 116.0 116.0 117.0 117.0 116.0 10:19:11 INFO - PROCESS | 23324 | 10:19:11 INFO - PROCESS | 23324 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 10:19:11 INFO - PROCESS | 23324 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 145.0 147.0 146.0 145.0 10:19:11 INFO - PROCESS | 23324 | 10:19:11 INFO - PROCESS | 23324 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 10:19:11 INFO - PROCESS | 23324 | Values: 84.0 84.0 85.0 84.0 85.0 84.0 84.0 84.0 84.0 85.0 10:19:11 INFO - PROCESS | 23324 | 10:19:11 INFO - PROCESS | 23324 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:50.00 stddev:2.72 (5.4%) stddev-sans-first:2.88 10:19:11 INFO - PROCESS | 23324 | Values: 51.0 58.0 49.0 51.0 50.0 49.0 50.0 49.0 49.0 50.0 10:19:11 INFO - PROCESS | 23324 | 10:19:11 INFO - PROCESS | 23324 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.50 10:19:11 INFO - PROCESS | 23324 | Values: 59.0 60.0 60.0 60.0 61.0 61.0 60.0 61.0 60.0 60.0 10:19:11 INFO - PROCESS | 23324 | 10:19:11 INFO - PROCESS | 23324 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:75.00 stddev:2.37 (3.2%) stddev-sans-first:2.51 10:19:11 INFO - PROCESS | 23324 | Values: 75.0 74.0 75.0 75.0 75.0 74.0 76.0 82.0 74.0 75.0 10:19:11 INFO - PROCESS | 23324 | 10:19:11 INFO - PROCESS | 23324 | [#11] stanford-crypto-ccm Cycles:10 Average:131.00 Median:127.00 stddev:12.20 (9.6%) stddev-sans-first:12.89 10:19:11 INFO - PROCESS | 23324 | Values: 128.0 126.0 135.0 125.0 126.0 125.0 133.0 123.0 164.0 125.0 10:19:11 INFO - PROCESS | 23324 | 10:19:11 INFO - PROCESS | 23324 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.50 Median:156.50 stddev:2.55 (1.6%) stddev-sans-first:2.37 10:19:11 INFO - PROCESS | 23324 | Values: 159.0 154.0 159.0 152.0 157.0 155.0 154.0 152.0 157.0 156.0 10:19:11 INFO - PROCESS | 23324 | 10:19:11 INFO - PROCESS | 23324 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.60 Median:61.50 stddev:1.78 (2.9%) stddev-sans-first:1.39 10:19:11 INFO - PROCESS | 23324 | Values: 65.0 64.0 62.0 61.0 62.0 61.0 61.0 60.0 61.0 59.0 10:19:11 INFO - PROCESS | 23324 | -------- Summary: end -------- 10:19:11 INFO - PROCESS | 23324 | 10:19:12 INFO - TEST-INFO | 23324: exit 0 10:19:12 INFO - TEST-OK | kraken | took 60237ms 10:19:12 INFO - SUITE-END | took 1176s 10:19:12 INFO - Completed test suite (00:19:36) 10:19:12 INFO - javascript benchmark 10:19:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3213.566168567243, 3224.6775322467743, 3249.009052239066, 3262.3964566555187, 3277.5903012123485, 5542.22408862759, 5577.86055348616, 5644.209810626516, 5649.12438572021, 5660.235868157797, 5617.0731829248225, 5681.687507187103, 5691.914621280674, 5704.429557044294, 5720.628159169651, 5135.9743201283945, 5166.380034395877, 5187.48125187482, 5189.299444574991, 5230.424653288154, 4877.926831097537, 4898.975505122469, 5062.924056139161, 5239.13554263546, 5253.44838791927, 5099.260607211952, 5173.9482605174035, 5177.378714554259, 5178.352705911761, 5187.974060129713, 5186.948130518703, 5215.973920130413, 5218.269442278084, 5224.399194092652, 5248.107821670325, 4997.6001919846685, 5012.548870601663, 5111.514406131449, 5115.667481613683, 5185.299984502081, 5327.680339179662, 5337.866553336159, 5507.9449205507835, 5551.750171242304, 5558.833235002957, 5740.856478588069, 5745.569082318801, 5777.59556831022, 5839.270091238595, 5859.736311865976, 5786.855328616818, 5860.472557469806, 5863.413658634145, 5866.061430171152, 5874.412558744134, 5451.972740136313, 5510.8071217507595, 5573.777048918038, 5589.301337332833, 5614.214010038598, 6133.26400831903, 6133.570650054543, 6146.877062458726, 6149.200603921461, 6152.16945712332, 5791.305043394819, 5905.970470147622, 5913.083472061838, 5921.0, 5924.14099955504, 5920.881582368328, 5924.437178468039, 5953.077273022688, 5954.374790647006, 6049.062395328731, 5939.3763654816485, 5986.341502434729, 5991.161237426763, 5993.940060599425, 5994.250718660168, 6020.397960203944, 6020.819375418744, 6021.307549631761, 6030.246219222598, 6058.394160583995, 4524.23088075028, 4556.863294101182, 4577.702449340783, 4617.007343421114, 4617.907641847211, 4134.090500089976, 4134.751914885116, 4160.3343465046055, 4168.353905144708, 4175.269327867611, 5727.541796656257, 5743.483086522233, 5745.482906538348, 5748.19525266463, 5755.9424405756245, 5861.5603829712945, 5928.762849486058, 5973.880522389528, 6004.579679422486, 6078.513718902477, 5733.426657334317, 5767.798127065533, 5768.0, 5780.855478613068, 5801.187833703285, 5263.131583288715, 5266.7366631668265, 5270.657407268515, 5272.604554658416, 5276.366835979707, 6032.939670603326, 6110.480609148272, 6130.398136741914, 6240.251169859646, 6285.120083188357, 5953.970230148821, 6075.665838378932, 6089.51283897296, 6123.540734445023, 6130.601510901777, 6246.750129994749, 6260.342664020212, 6278.309385967448, 6290.0, 6293.527985401021, 5717.37108918027, 5731.684757338387, 5965.109735509258, 5971.58198926071, 5976.163337132892, 5957.642541447527, 6004.42957918997, 6008.429199226067, 6074.149619053248, 6116.755329786759, 5893.6463812171405, 5941.732622032106, 5948.464638182584, 5952.375000625046, 5954.553408494467, 5691.402402747652, 5891.381404952418, 5893.116032595145, 5894.557908156819, 5897.3807750185615, 5739.655620662774, 5793.9420605795085, 5794.420557944172, 5802.071668533014, 5914.083317085859, 5956.523478121827, 5964.671943043174, 5976.073708575178, 5979.4917432018765, 5986.0, 5520.089185284543, 5603.10350343943, 5605.159226116115, 5786.276715410574, 5790.363060063474], "value": 5535.743490021275, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.2448877680959, 626.9592476489028, 656.2387630348795, 672.1631568696973, 675.3955210086975, 33760.15599610011, 44580.554194458084, 45655.31517027247, 45801.0, 45817.083658326854, 46137.307940380924, 46698.299525507144, 46710.29934550985, 46721.53278467214, 46727.0, 8261.958690206571, 8474.322054235647, 8822.029576746569, 8976.057513961037, 10685.091767199798, 10456.163506919429, 10881.401522916236, 10885.945570272137, 10888.727781805439, 10890.509927053301, 10994.505247263853, 11032.834507482394, 11041.503132359023, 11051.944740276287, 11052.0, 8319.708810191645, 8488.0, 8499.0, 8700.30397568193, 10894.782104357908, 10318.948405257926, 10625.149988000941, 10634.893651063468, 10947.397893115876, 10970.122390208844, 43790.0, 44198.0, 44237.77881110574, 44256.11487770259, 44270.0, 3686.502322186497, 3797.6012518685416, 3851.171998020411, 3858.266929283427, 4076.082881351702, 32533.837330813432, 32666.836665816758, 32898.17754556131, 33084.33831323384, 33237.6676233237, 4156.085661154541, 4181.60274773896, 4194.6853985951175, 4206.978965105185, 4213.810378532973, 372521.0, 373383.0, 373542.0, 373784.0, 375442.0, 61320.69339653273, 61351.38648613546, 61482.69258653678, 61742.38257617456, 61761.69119154375, 39610.20779584392, 40901.795491022356, 41095.0, 43234.56765432305, 61418.0, 18110.63778724418, 18149.637007259782, 18179.363722269656, 18278.908605457153, 18281.81718182828, 12950.935245323713, 13326.06717529783, 13893.58319250424, 14241.287935603179, 14249.85750142506, 20461.488462788253, 20499.4875128123, 20735.585288294453, 20771.584568308852, 20778.0, 7267.30960558746, 7319.487635865438, 7420.703171873172, 7565.962170189114, 7569.3566046886635, 1016.7254841192985, 1087.211771465681, 1095.5234473004268, 1101.091599430473, 1104.7127746785734, 33467.0, 33625.3046222687, 33822.32355352879, 33863.661363386054, 33886.66113338884, 1138.430784607696, 1172.5837327748698, 1199.7900367435664, 1201.6575276046285, 1227.4108427954632, 17654.558636033944, 17694.91152544255, 17816.198271077832, 17981.370652027115, 17988.91005544964, 516181.0, 522276.0, 523072.0, 523256.0, 525046.0, 41953.79023104926, 42634.57365426368, 42649.78675106667, 42656.0, 42716.359254611205, 1345.1256683156028, 1370.6778906956856, 1403.635054885737, 1438.7985682004528, 1444.5594093801492, 30279.848600756854, 33536.83231583826, 34308.82845585756, 34603.48094778631, 35149.29701406009, 50585.49414505808, 59090.11364829445, 60639.0, 60898.0, 66318.33681663121, 519347.0, 523461.0, 523461.0, 523760.0, 526681.0, 30204.395912081196, 30872.84563577168, 32425.35149297048, 32475.67524324821, 46096.53903461056, 48349.5165048345, 48690.5130948686, 48970.510294896594, 49003.509964899895, 49022.0, 40725.42379653742, 41023.7948810254, 41841.79079104585, 42126.36810447907, 42323.0, 40315.79842100888, 42189.57810421856, 42530.362044568734, 43128.35307470453, 44418.77790611026, 43055.1388972225, 43358.13283734245, 43842.56157438512, 44466.11067778691, 44503.77748111239, 36519.26961460703, 37172.0, 38746.22507549889, 38807.8357649271, 38906.0, 29043.419131617673, 29058.564121538617, 29246.0, 29352.55971160477, 29563.26091847721], "value": 21082.641288236708, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.82922258040327, 412.15302553253053, 422.5415424264673, 439.7119886474358, 443.65173338928946, 15248.923755381222, 19005.619887602257, 19147.52131196719, 19979.800201998012, 20152.294669686566, 19204.135813888373, 19656.410307690756, 19752.30866919658, 19892.204311827547, 20600.896995515002, 5637.379888212304, 5926.585139040248, 5929.199558059671, 5930.318013428447, 5933.6439813611105, 5544.6118771686, 5808.506276966463, 5853.941460585383, 5855.76576936922, 5860.531157507389, 5849.239598852165, 5856.385079566648, 5862.970685146568, 5869.266341707286, 5869.442402971732, 5693.857653558653, 5899.616524925866, 5929.822105336825, 6026.0, 6037.124616930564, 5667.489925906647, 5810.854728631776, 5832.329282132567, 5860.736266868002, 5864.944310024194, 14868.405263789435, 15106.244687765568, 15128.924355378153, 16566.420175293926, 23154.0, 2346.941326466835, 2385.2128797496785, 2503.311589312935, 2574.4336246025846, 2665.6534650495505, 11036.392998385085, 11148.0, 11214.831777523344, 11484.310941343547, 15522.0, 1879.1168150969158, 1917.3481016454332, 1965.6167047425758, 1978.9901050494655, 2016.485796121994, 78694.21305786983, 87491.56254218688, 87790.24419511638, 88203.0, 90246.09753902443, 9894.752631184134, 10446.0, 10543.472826358651, 10628.627998020032, 11776.234544754563, 14652.12087274767, 15125.319360628579, 15927.0, 15956.840431595767, 15958.60103497422, 6552.3775241352, 8026.959865200637, 8316.043654979634, 8355.373346998878, 8409.705660301861, 8024.919750802534, 8067.677292908218, 8235.629396677165, 8235.8352832943, 8263.462874913112, 5103.311053007871, 5181.663191892515, 5193.922091168635, 5237.397699264633, 5289.153735402318, 2036.1448191759496, 2062.236972320251, 2085.6975738518136, 2103.8001389867936, 2126.6172089024126, 997.5858422617283, 1015.7003683913264, 1041.9270651054353, 1051.027799285673, 1085.2620218251507, 19956.50108747293, 20208.254899241158, 20369.796302037088, 20528.692069618966, 20767.8961605194, 998.83519219328, 1024.0578667625803, 1024.6004058417075, 1074.9516271767789, 1098.6649072033106, 10581.629642962613, 11039.116870650329, 11039.178535541707, 11109.83335249972, 11128.777424451466, 518342.0, 519060.0, 532544.0, 543321.0, 549756.0, 96148.0, 97573.0, 99747.50126249323, 103907.0, 103936.0, 1068.391017120234, 1081.2539347849959, 1082.9133669306436, 1104.8563686720674, 1110.6723516562633, 17137.91431042837, 17381.044042577778, 17790.822091779435, 17948.0, 17978.460646180636, 31335.0, 45753.77123114363, 46122.308165376875, 47118.0, 47247.76376118235, 60855.0, 61602.38397615967, 62611.0, 63177.0, 63865.68067159635, 8774.605142768463, 8887.466751994902, 8895.288376929959, 9380.624775008922, 9442.622295108118, 9539.618415263312, 12757.55348562833, 13220.735585288432, 13406.463741450232, 13455.259960702255, 11024.889751102386, 11801.881981180079, 11866.347350895783, 12014.699632508908, 12468.251904885736, 10840.362542586883, 11034.117270618171, 11457.59898403552, 11908.523659053888, 12065.155439119177, 12225.69435764113, 12244.693882653006, 12284.1401101922, 12411.503539858304, 12581.93709031449, 9205.263578913537, 9423.246140308896, 9566.091221333962, 9595.616175352907, 9677.22582193437, 11909.880901190878, 12210.694732631755, 12229.633111006684, 12271.202371845802, 12389.318587477415], "value": 9505.3075497432, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1361.891048716103, 1494.4619936822742, 1529.461094582992, 1704.8124706282315, 1821.7540632014675, 7192.352688258055, 8232.711855085066, 8447.535385553792, 8481.151884811516, 8735.868961965576, 8539.78650533737, 8596.054434012269, 8604.956975215131, 8608.139186081404, 8618.138186181379, 2468.802495800336, 2496.0390249753887, 2498.600223964166, 2499.562576549097, 2503.399184195789, 2399.916002939897, 2525.722170561237, 2526.5831137862233, 2531.9240422787348, 2532.746725327471, 2446.755324467557, 2454.1165180534995, 2499.212747984388, 2499.6500489931423, 2517.0183628384943, 2341.4497593065616, 2372.869492177921, 2394.3535245483795, 2396.2212281008656, 2421.4672771990136, 2441.9755802441928, 2456.828022038458, 2478.8264821462503, 2484.503099380131, 2484.527939691453, 8629.0, 8690.08754080825, 8734.956325218396, 8752.737417877473, 8823.911760882373, 5432.266644003088, 5688.60179787415, 5690.487856092972, 5694.202811606378, 5695.1741997410145, 3414.146463384154, 3488.5464889564446, 3536.6286539913453, 3549.112721819545, 3586.497890295361, 1091.3670071358592, 1103.624767579027, 1113.799516087104, 1117.5082963496118, 1151.2689442204178, 11817.0, 11866.881331186663, 11926.105542084379, 11927.582534611247, 11955.521779128825, 4590.9540904591195, 4753.930365667767, 4863.148948933923, 4869.172240719086, 4871.732054737024, 9693.273004524548, 9787.559559819825, 9796.314258001872, 9809.509524523888, 9811.803763924681, 5396.163594642837, 5410.269613602113, 5467.0, 5486.478784515464, 5487.807926722626, 4251.766152861623, 4505.932411013838, 4571.26859702446, 5010.799568017239, 5131.435542090367, 3935.779908228458, 4024.3561030235023, 4073.5926407359025, 4114.280000999813, 4128.6284234419045, 1257.4718618180386, 1266.069438962362, 1266.6516707905216, 1266.714989127439, 1304.2565737529708, 970.8106919150698, 978.8629591857145, 981.9754506137403, 997.2249396074998, 998.7453199434098, 5821.912671309934, 5868.002439585281, 5908.320543137508, 5957.523398128139, 5993.970030149909, 493.10747546940155, 499.12901986033876, 501.0905207049194, 507.32019094412925, 519.477924685696, 4005.35914253718, 4041.9797901010306, 4080.9183816323507, 4093.079057212163, 4104.322786740155, 10453.581856725797, 10957.50691218897, 10963.068139208097, 10972.890271097347, 11015.228933974706, 10237.385756854612, 10901.618443354602, 10915.072218861485, 10920.344779313267, 10921.180911431515, 7883.0, 7947.205279472122, 8006.559639219782, 8018.83962320762, 8025.759227223192, 5691.2032315475035, 5752.0, 5838.94161058384, 5861.296644402529, 5945.613535120204, 10080.243981701255, 10086.949565252127, 10110.0, 10110.292279540361, 10203.7449063774, 8648.78378040554, 8830.072842351461, 10066.094051535398, 10078.596856125672, 10177.542010609688, 7600.771976840703, 7940.245676660708, 8012.719554815553, 8023.518588884685, 8025.8796118059445, 8475.83048339042, 8484.406091573777, 8526.488410695378, 8529.14708529142, 8541.829163416822, 7582.279683430065, 7699.191584883731, 7701.383889288732, 7732.265434783687, 7746.690132394641, 7438.814029649302, 7527.736529221451, 7569.886451703339, 7589.734359297398, 7767.1067827200595, 7069.6111713856235, 7194.280571942764, 7197.1363436387965, 7197.820054498679, 7208.45936554771, 4948.678335908155, 5004.024215278131, 5068.949310506995, 5095.92356114666, 5219.608529360237, 5064.746762661778, 5068.417132029716, 5100.540951314251, 5136.229565565195, 5263.421023687468], "value": 4589.922270810744, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.4036839215295, 362.3767120552649, 363.94358874374467, 365.9304732100899, 371.0316075044136, 5458.5087342139195, 5462.562994960394, 5468.644538105021, 5484.149956756699, 5491.725413729318, 5383.650062745919, 5394.298741163653, 5400.864978375543, 5403.78384864606, 5419.0, 4040.7271709411516, 4217.325227963511, 4229.7885105744745, 4264.78676066197, 4270.466191726035, 4247.193033323674, 4248.0, 4254.532001479834, 4258.6380157686635, 4267.4025636410925, 4231.724937879028, 4232.74603523788, 4249.44757181566, 4256.829726810939, 4279.058607106447, 4162.8959276018195, 4240.08838099807, 4275.87172384829, 4288.313869780835, 4288.335308027261, 3730.309892669865, 3738.719596030309, 3742.1954279829965, 3742.3263812513737, 3742.644448777362, 5261.657992230493, 5262.526372626482, 5275.920861187085, 5327.334083239595, 5337.919931201035, 4773.928391074137, 4823.20417131173, 4842.394700662418, 4872.415310162768, 4880.656750126175, 5561.0, 5585.748641311151, 5625.71871406428, 5658.603897727119, 5666.971665141689, 4111.444954931076, 4129.174165166979, 4145.54399016108, 4149.211649786531, 4161.126163505667, 5622.32532096151, 5769.740361683693, 5799.449052339979, 5891.43568141277, 5905.763769449217, 4191.580841915784, 4196.328587425997, 4198.85304014358, 4224.239636865333, 4227.534971153171, 4242.0, 4260.466232156421, 4265.658747300208, 4271.530131685512, 4285.292926667127, 4625.468071171858, 4797.088553174885, 4843.588294994965, 4856.150173719585, 4856.465788763233, 5657.830265092054, 5665.235193248941, 5667.971660141673, 5669.9794037073725, 5671.744771485211, 1419.7160567886465, 1440.854520656081, 1443.7762146867253, 1444.6893917807722, 1447.3269929482842, 958.520739630185, 1000.8048430556117, 1002.4386343647581, 1007.1992765751245, 1019.7348689340677, 5288.206768984683, 5301.390340110936, 5307.840764777063, 5311.628186027018, 5333.973330133324, 5618.353889302701, 5622.819207966373, 5624.859378515488, 5639.436056394327, 5656.830295091154, 5077.593792496666, 5271.973640131775, 5329.573634109262, 5337.439568845293, 5338.5442696360105, 2980.538016607429, 2982.3737015227043, 2998.220462679719, 3001.9249518761767, 3011.518157094898, 5784.161296611967, 5825.825225243249, 5862.179294898718, 5895.322037965603, 5905.173275741399, 5608.906263278622, 5686.459786320293, 5930.466258036798, 5932.3474417814, 5952.434518720715, 5916.881662366729, 5992.67040312787, 6037.245344331958, 6059.8485037873525, 6084.41805130678, 5858.94141058584, 5863.794767183128, 5927.347991720993, 5930.940690593039, 5940.346561878277, 5443.891122177613, 5483.232347471437, 5746.3966283541295, 5772.249607550992, 5835.4748072673665, 6005.549583781147, 6063.454289114001, 6108.564487345559, 6110.633361998294, 6124.724387402666, 4188.0, 4243.957560424356, 4249.3625956106835, 4286.849960251377, 4294.119705460435, 5855.648661080349, 5872.207252020922, 5880.970595146997, 5895.528357731457, 5911.261092363455, 5741.626794258527, 5764.337101233412, 5772.105323674669, 5784.248047753765, 5794.217780599565, 5526.889462210653, 5686.687232202268, 5701.116326969326, 5717.599768016199, 5755.366909639853, 5651.2935883014625, 5694.800681976111, 5714.628549144292, 5719.599628025998, 5724.198612194213, 5622.269105016322, 5757.5393968481585, 5815.93534295319, 5824.94175058244, 5849.327327357239, 5518.44815518461, 5588.664680119044, 5590.552755779447, 5595.496405323541, 5595.916061259003], "value": 4346.032086662299, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.6913488307002, 802.8193656427304, 806.7821688144202, 828.6685325869652, 869.7347309070731, 15255.313510892009, 15841.603959900995, 16309.266083026263, 16529.090900000494, 16604.999999999985, 14620.4882829101, 14703.19132447715, 14863.851361486382, 14942.178180200084, 15029.32368043438, 727.1165533876339, 756.0662581711582, 858.0261403307244, 870.5951732444412, 873.3668090634271, 836.6277006732007, 866.7659731872391, 871.3464901324007, 872.0973792125152, 874.1564390363299, 914.0402577293848, 917.7430319510514, 917.7843206846419, 918.274563095154, 919.0, 760.3612965109279, 785.5561607691636, 913.7715571107224, 914.1087439746261, 914.3508109242413, 648.4488185042724, 662.9966850165719, 667.6428110960661, 668.9163854518185, 669.6685140855259, 14605.70788584233, 14639.853601463956, 14659.0, 14671.33978970949, 14678.0, 13928.860711392857, 14085.929570352186, 14091.436342546285, 14152.0, 14213.43146274158, 11858.644240672793, 11928.284302941851, 11996.160268781188, 12108.636740897788, 12250.938745306217, 4389.231884420214, 4433.401490798766, 4458.3535387368975, 4497.302918047708, 4526.456825181, 58655.82688346252, 59952.40047599512, 61687.0, 63209.0, 65506.672466637836, 11197.384143872165, 11446.08431325492, 11642.185047046794, 11651.417429128509, 11887.524499020115, 20900.477488062617, 20926.267580634605, 20939.79060209409, 20959.37121886346, 20988.055537500848, 8366.58167091643, 8449.408541402167, 8521.659133634585, 8755.124487551322, 8891.155340242667, 4591.150637132141, 4591.655625828076, 4603.470600880942, 4649.651276154302, 4760.64295177863, 3513.94729079064, 3611.2416392557857, 3625.7643253188457, 3627.981860090683, 3631.9818400907825, 619.3837132053545, 632.8449529865212, 649.2144505148823, 662.6090606542164, 672.2034389248756, 725.0755287009106, 732.739877343546, 762.272030211147, 782.8551717932087, 821.9958900205461, 9913.0, 10146.644867429604, 10316.587336506605, 10402.531886064993, 10760.838587421194, 744.6872313628289, 788.8461749958818, 803.7869964459423, 812.1391325195311, 817.358373676661, 4699.436067671902, 4890.437599676083, 4901.926471102936, 4917.58200552957, 4935.90128197434, 91452.0, 94599.0, 94950.52524737471, 95506.0, 99027.0, 79529.60235198903, 79626.6018669903, 81202.99999999882, 81489.0, 84383.57808211043, 74446.62776686082, 74728.0, 75059.62470187614, 75475.62262188653, 76207.0, 9675.854862177213, 9705.17506011997, 9851.704448866545, 9949.602015919281, 9981.850272246067, 48155.75922120367, 48498.27252591143, 48513.0, 48603.27095093505, 49276.0, 62098.0, 64310.0, 67339.3266067333, 68080.6595967017, 68881.65559172373, 12739.0, 12768.6807829805, 12822.358882056047, 12823.807642885178, 13168.670783230496, 13544.729105417638, 13756.312184390941, 13772.380242888894, 13831.585052448443, 14163.079399838978, 12731.427085781348, 12977.935110324388, 13015.349232538525, 13411.329433528479, 13561.525346612822, 12428.689282768004, 12481.438335275116, 12507.0, 12660.303683297507, 12774.425150868048, 11759.118541033393, 12139.817902731642, 12161.635150945485, 12259.938700306442, 12368.690782730504, 10231.693049208536, 10368.857562700565, 10417.270791044553, 10436.895631043895, 10461.68614941553, 9906.306558540833, 10653.201009924132, 10729.517171727135, 10747.838782418114, 10885.945570272099], "value": 7447.435578307584, "unit": "score"}], "name": "dromaeo_css", "value": 7404.623389898391, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 111.0, 112.0, 111.0, 112.0, 111.0, 111.0, 110.0, 112.0, 110.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 125.0, 121.0, 150.0, 120.0, 122.0, 121.0, 126.0, 150.0, 119.0], "value": 129.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 161.0, 160.0, 161.0, 160.0, 161.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 123.0, 75.0, 75.0, 74.0, 75.0, 104.0, 75.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 129.0, 82.0, 82.0, 81.0, 107.0, 81.0, 81.0, 100.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 118.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0, 85.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 58.0, 49.0, 51.0, 50.0, 49.0, 50.0, 49.0, 49.0, 50.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 61.0, 61.0, 60.0, 61.0, 60.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 75.0, 75.0, 74.0, 76.0, 82.0, 74.0, 75.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 126.0, 135.0, 125.0, 126.0, 125.0, 133.0, 123.0, 164.0, 125.0], "value": 131.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 154.0, 159.0, 152.0, 157.0, 155.0, 154.0, 152.0, 157.0, 156.0], "value": 155.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 62.0, 61.0, 62.0, 61.0, 61.0, 60.0, 61.0, 59.0], "value": 61.6, "unit": "score"}], "name": "kraken", "value": 1455.6, "alertThreshold": 2.0}]} 10:19:12 INFO - Return code: 0 10:19:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:19:12 INFO - # TBPL SUCCESS # 10:19:12 INFO - Running post-action listener: _resource_record_post_action 10:19:12 INFO - [mozharness: 2016-11-24 18:19:12.920899Z] Finished run-tests step (success) 10:19:12 INFO - Running post-run listener: _resource_record_post_run 10:19:12 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 355340288; Read time: 0; Write time: 207148 10:19:12 INFO - TinderboxPrint: CPU usage
13.0% 10:19:12 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 10:19:12 INFO - TinderboxPrint: I/O write bytes / time
355,340,288 / 207,148 10:19:12 INFO - TinderboxPrint: CPU idle
8,279.7 (87.0%) 10:19:12 INFO - TinderboxPrint: CPU user
1,188.7 (12.5%) 10:19:12 INFO - TinderboxPrint: Swap in / out
0 / 0 10:19:12 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 109273088; Read time: 0; Write time: 65176 10:19:13 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 244822016; Read time: 0; Write time: 141912 10:19:13 INFO - Running post-run listener: _upload_blobber_files 10:19:13 INFO - Blob upload gear active. 10:19:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:19:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:19:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:19:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:19:13 INFO - (blobuploader) - INFO - Open directory for files ... 10:19:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:19:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:19:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:19:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:17 INFO - (blobuploader) - INFO - Done attempting. 10:19:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:19:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:19:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:19:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:19 INFO - (blobuploader) - INFO - Done attempting. 10:19:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:19:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:19:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:19:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:19 INFO - (blobuploader) - INFO - Done attempting. 10:19:19 INFO - (blobuploader) - INFO - Iteration through files over. 10:19:19 INFO - Return code: 0 10:19:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:19:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:19:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/212de49bbf18da5dd4cb14f45bf86bd9b5ec30d3d1b8fdc156e9b19151c5f9e170efc0393045f70966328ccb7db4bd6ba81652fb8a034046fbe243792ba2dd6c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c50fe01570da0a20abbda10640c3e0fa06c8be63545c0494d95d64d9b91a8c320300c8920ef7df5bf356d8b88ebdf9f9aaea814595fecbf6ad41f9e0903a499", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/87206860fb5a6a319400ce3f84158ef14b2939dbd28b60914f67b96cf2aa46a21a0859bde53f05e0756309c54b2b5ea0c67a81275a952e927bb261c53e9352b9"} 10:19:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:19:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:19:19 INFO - Contents: 10:19:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/212de49bbf18da5dd4cb14f45bf86bd9b5ec30d3d1b8fdc156e9b19151c5f9e170efc0393045f70966328ccb7db4bd6ba81652fb8a034046fbe243792ba2dd6c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c50fe01570da0a20abbda10640c3e0fa06c8be63545c0494d95d64d9b91a8c320300c8920ef7df5bf356d8b88ebdf9f9aaea814595fecbf6ad41f9e0903a499", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/87206860fb5a6a319400ce3f84158ef14b2939dbd28b60914f67b96cf2aa46a21a0859bde53f05e0756309c54b2b5ea0c67a81275a952e927bb261c53e9352b9"} 10:19:19 INFO - Running post-run listener: copy_logs_to_upload_dir 10:19:19 INFO - Copying logs to upload dir... 10:19:19 INFO - mkdir: /builds/slave/test/build/upload/logs 10:19:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.434975 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-24 10:19:19.608811) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 10:19:19.612696) ========= 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=3836458cccd887f2d2de3cf1000001de-1480010321.679390-1993003949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/212de49bbf18da5dd4cb14f45bf86bd9b5ec30d3d1b8fdc156e9b19151c5f9e170efc0393045f70966328ccb7db4bd6ba81652fb8a034046fbe243792ba2dd6c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c50fe01570da0a20abbda10640c3e0fa06c8be63545c0494d95d64d9b91a8c320300c8920ef7df5bf356d8b88ebdf9f9aaea814595fecbf6ad41f9e0903a499", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/87206860fb5a6a319400ce3f84158ef14b2939dbd28b60914f67b96cf2aa46a21a0859bde53f05e0756309c54b2b5ea0c67a81275a952e927bb261c53e9352b9"} build_url:https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011768 build_url: 'https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/212de49bbf18da5dd4cb14f45bf86bd9b5ec30d3d1b8fdc156e9b19151c5f9e170efc0393045f70966328ccb7db4bd6ba81652fb8a034046fbe243792ba2dd6c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c50fe01570da0a20abbda10640c3e0fa06c8be63545c0494d95d64d9b91a8c320300c8920ef7df5bf356d8b88ebdf9f9aaea814595fecbf6ad41f9e0903a499", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/87206860fb5a6a319400ce3f84158ef14b2939dbd28b60914f67b96cf2aa46a21a0859bde53f05e0756309c54b2b5ea0c67a81275a952e927bb261c53e9352b9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 10:19:19.640682) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 10:19:19.641365) ========= 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=3836458cccd887f2d2de3cf1000001de-1480010321.679390-1993003949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 10:19:19.726627) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 10:19:19.727357) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 10:19:19.727970) ========= ========= Total master_lag: 0.19 =========