builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1479228555.51 results: success (0) buildid: 20161115060313 builduid: 849d8dca843243caa0d5767b9fc26ccf revision: bfaa16ab61ee71dd05d27e2b07244032207b5dad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 08:49:15.508855) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 08:49:15.509370) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-15 08:49:15.509671) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-15 08:49:15.525881) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 08:49:15.526237) ========= 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=14ef55db36f7623abb31b9cf000001d5-1479227690.149988-730682823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-15 08:49:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 101M=0s 2016-11-15 08:49:15 (101 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.182948 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 08:49:15.723101) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 08:49:15.723433) ========= 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=14ef55db36f7623abb31b9cf000001d5-1479227690.149988-730682823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015296 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 08:49:15.773098) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 08:49:15.773456) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bfaa16ab61ee71dd05d27e2b07244032207b5dad --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 bfaa16ab61ee71dd05d27e2b07244032207b5dad --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=14ef55db36f7623abb31b9cf000001d5-1479227690.149988-730682823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-15 08:49:16,080 truncating revision to first 12 chars 2016-11-15 08:49:16,080 Setting DEBUG logging. 2016-11-15 08:49:16,080 attempt 1/10 2016-11-15 08:49:16,080 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bfaa16ab61ee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-15 08:49:16,401 unpacking tar archive at: mozilla-aurora-bfaa16ab61ee/testing/mozharness/ program finished with exit code 0 elapsedTime=0.769457 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 08:49:16.557028) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 08:49:16.557361) ========= script_repo_revision: bfaa16ab61ee71dd05d27e2b07244032207b5dad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 08:49:16.557844) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 08:49:16.558196) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 08:49:16.567757) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-11-15 08:49:16.568206) ========= /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=14ef55db36f7623abb31b9cf000001d5-1479227690.149988-730682823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:49:16 INFO - MultiFileLogger online at 20161115 08:49:16 in /builds/slave/test 08:49:16 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 08:49:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:49:16 INFO - {'append_to_log': False, 08:49:16 INFO - 'base_work_dir': '/builds/slave/test', 08:49:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:49:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:49:16 INFO - 'branch': 'Mozilla-Aurora', 08:49:16 INFO - 'buildbot_json_path': 'buildprops.json', 08:49:16 INFO - 'config_files': ('talos/linux_config.py',), 08:49:16 INFO - 'default_actions': ('clobber', 08:49:16 INFO - 'read-buildbot-config', 08:49:16 INFO - 'download-and-extract', 08:49:16 INFO - 'populate-webroot', 08:49:16 INFO - 'create-virtualenv', 08:49:16 INFO - 'install', 08:49:16 INFO - 'run-tests'), 08:49:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:49:16 INFO - 'download_minidump_stackwalk': True, 08:49:16 INFO - 'download_symbols': 'ondemand', 08:49:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:49:16 INFO - 'tooltool.py': '/tools/tooltool.py', 08:49:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:49:16 INFO - '/tools/misc-python/virtualenv.py')}, 08:49:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:49:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:49:16 INFO - 'installer_path': 'installer.exe', 08:49:16 INFO - 'log_level': 'info', 08:49:16 INFO - 'log_name': 'talos', 08:49:16 INFO - 'log_to_console': True, 08:49:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:49:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:49:16 INFO - 'opt_config_files': (), 08:49:16 INFO - 'pip_index': False, 08:49:16 INFO - 'sps_profile': False, 08:49:16 INFO - 'sps_profile_interval': 0, 08:49:16 INFO - 'suite': 'dromaeojs', 08:49:16 INFO - 'system_bits': '32', 08:49:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:49:16 INFO - 'title': 'talos-linux64-ix-036', 08:49:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:49:16 INFO - 'use_talos_json': True, 08:49:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:49:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:49:16 INFO - 'work_dir': 'build'} 08:49:16 INFO - [mozharness: 2016-11-15 16:49:16.974286Z] Running clobber step. 08:49:16 INFO - Running pre-action listener: _resource_record_pre_action 08:49:16 INFO - Running main action method: clobber 08:49:16 INFO - rmtree: /builds/slave/test/build 08:49:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:49:17 INFO - Running post-action listener: _resource_record_post_action 08:49:17 INFO - [mozharness: 2016-11-15 16:49:17.438457Z] Finished clobber step (success) 08:49:17 INFO - [mozharness: 2016-11-15 16:49:17.438556Z] Running read-buildbot-config step. 08:49:17 INFO - Running pre-action listener: _resource_record_pre_action 08:49:17 INFO - Running main action method: read_buildbot_config 08:49:17 INFO - Using buildbot properties: 08:49:17 INFO - { 08:49:17 INFO - "project": "", 08:49:17 INFO - "product": "firefox", 08:49:17 INFO - "script_repo_revision": "production", 08:49:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:49:17 INFO - "repository": "", 08:49:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:49:17 INFO - "buildid": "20161115060313", 08:49:17 INFO - "pgo_build": "True", 08:49:17 INFO - "basedir": "/builds/slave/test", 08:49:17 INFO - "buildnumber": 599, 08:49:17 INFO - "slavename": "talos-linux64-ix-036", 08:49:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:49:17 INFO - "platform": "ubuntu64_hw", 08:49:17 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:49:17 INFO - "branch": "mozilla-aurora", 08:49:17 INFO - "repo_path": "releases/mozilla-aurora", 08:49:17 INFO - "revision": "bfaa16ab61ee71dd05d27e2b07244032207b5dad", 08:49:17 INFO - "stage_platform": "linux64-pgo", 08:49:17 INFO - "builduid": "849d8dca843243caa0d5767b9fc26ccf", 08:49:17 INFO - "slavebuilddir": "test" 08:49:17 INFO - } 08:49:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/bfvqbkAhSJiRCA19KXeKLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 08:49:17 INFO - Running post-action listener: _resource_record_post_action 08:49:17 INFO - [mozharness: 2016-11-15 16:49:17.441423Z] Finished read-buildbot-config step (success) 08:49:17 INFO - [mozharness: 2016-11-15 16:49:17.441512Z] Running download-and-extract step. 08:49:17 INFO - Running pre-action listener: _resource_record_pre_action 08:49:17 INFO - Running main action method: download_and_extract 08:49:17 INFO - mkdir: /builds/slave/test/build/tests 08:49:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:17 INFO - trying https://queue.taskcluster.net/v1/task/bfvqbkAhSJiRCA19KXeKLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:49:17 INFO - Downloading https://queue.taskcluster.net/v1/task/bfvqbkAhSJiRCA19KXeKLg/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 08:49:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bfvqbkAhSJiRCA19KXeKLg/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 08:49:18 INFO - Downloaded 1361 bytes. 08:49:18 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:49:18 INFO - Using the following test package requirements: 08:49:18 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:49:18 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:49:18 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:49:18 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:49:18 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:49:18 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:49:18 INFO - u'jsshell-linux-x86_64.zip'], 08:49:18 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:49:18 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:49:18 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:49:18 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:49:18 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:49:18 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:49:18 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:49:18 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:49:18 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:49:18 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:49:18 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:49:18 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:49:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bfvqbkAhSJiRCA19KXeKLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:49:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bfvqbkAhSJiRCA19KXeKLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:49:18 INFO - Fetch https://queue.taskcluster.net/v1/task/bfvqbkAhSJiRCA19KXeKLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:49:18 INFO - Http code: 200 08:49:18 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 08:49:18 INFO - x-amz-cf-id: kt_okj-vEVAZ8BJr4oX62nd8jKbTSLUEtN4dTk0D-al4y1GCbYoH6w== 08:49:18 INFO - x-amz-version-id: 8epFLZFlcQ49LOyWPyQS0WXR2FjRYEpx 08:49:19 INFO - Expected file size: 21998441 08:49:19 INFO - Obtained file size: 21998441 08:49:23 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 08:49:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bfvqbkAhSJiRCA19KXeKLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:49:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bfvqbkAhSJiRCA19KXeKLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:49:23 INFO - Fetch https://queue.taskcluster.net/v1/task/bfvqbkAhSJiRCA19KXeKLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:49:23 INFO - Http code: 200 08:49:23 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 08:49:23 INFO - x-amz-cf-id: eUBpzbY0M6jH_a2jTQfCz_wLtUjodhvtG6J8ScWc_WVJb7QtDxzX5g== 08:49:23 INFO - x-amz-version-id: 8epFLZFlcQ49LOyWPyQS0WXR2FjRYEpx 08:49:24 INFO - Expected file size: 21998441 08:49:24 INFO - Obtained file size: 21998441 08:49:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bfvqbkAhSJiRCA19KXeKLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 08:49:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bfvqbkAhSJiRCA19KXeKLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:49:28 INFO - Fetch https://queue.taskcluster.net/v1/task/bfvqbkAhSJiRCA19KXeKLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 08:49:28 INFO - Http code: 200 08:49:28 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 08:49:28 INFO - x-amz-cf-id: 6RDsnJvw4k7ikYa-FaS4Dn2mPe7JbgS2fjruxQ7-zkf5Rj18oPg7oA== 08:49:28 INFO - x-amz-version-id: IYqicrbCbylR2h5b5HkGkwfy7tFz598P 08:49:29 INFO - Expected file size: 14409038 08:49:29 INFO - Obtained file size: 14409038 08:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:29 INFO - trying https://queue.taskcluster.net/v1/task/bfvqbkAhSJiRCA19KXeKLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:49:29 INFO - Downloading https://queue.taskcluster.net/v1/task/bfvqbkAhSJiRCA19KXeKLg/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 08:49:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bfvqbkAhSJiRCA19KXeKLg/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 08:49:30 INFO - Downloaded 63935477 bytes. 08:49:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bfvqbkAhSJiRCA19KXeKLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:49:30 INFO - mkdir: /builds/slave/test/properties 08:49:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:49:30 INFO - Writing to file /builds/slave/test/properties/build_url 08:49:30 INFO - Contents: 08:49:30 INFO - build_url:https://queue.taskcluster.net/v1/task/bfvqbkAhSJiRCA19KXeKLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:49:31 INFO - Running post-action listener: _resource_record_post_action 08:49:31 INFO - Running post-action listener: set_extra_try_arguments 08:49:31 INFO - [mozharness: 2016-11-15 16:49:31.206073Z] Finished download-and-extract step (success) 08:49:31 INFO - [mozharness: 2016-11-15 16:49:31.206301Z] Running populate-webroot step. 08:49:31 INFO - Running pre-action listener: _resource_record_pre_action 08:49:31 INFO - Running main action method: populate_webroot 08:49:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:49:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:49:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:49:31 INFO - '--tppagecycles', 08:49:31 INFO - '7'], 08:49:31 INFO - 'tests': ['tsvgm']}}, 08:49:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:49:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:49:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:49:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:49:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:49:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:49:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:31 INFO - 'talos_options': ['--disable-e10s'], 08:49:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:49:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:49:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:31 INFO - 'talos_options': ['--disable-e10s'], 08:49:31 INFO - 'tests': ['damp', 'tps']}, 08:49:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:31 INFO - 'tests': ['damp', 'tps']}, 08:49:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:49:31 INFO - 'tests': ['dromaeo_dom']}, 08:49:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:49:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:49:31 INFO - 'tests': ['basic_compositor_video']}, 08:49:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:49:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:49:31 INFO - 'tests': ['a11yr', 08:49:31 INFO - 'ts_paint', 08:49:31 INFO - 'tpaint', 08:49:31 INFO - 'sessionrestore', 08:49:31 INFO - 'sessionrestore_no_auto_restore', 08:49:31 INFO - 'tabpaint']}, 08:49:31 INFO - 'other-e10s': {'tests': ['a11yr', 08:49:31 INFO - 'ts_paint', 08:49:31 INFO - 'tpaint', 08:49:31 INFO - 'sessionrestore', 08:49:31 INFO - 'sessionrestore_no_auto_restore', 08:49:31 INFO - 'tabpaint']}, 08:49:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:49:31 INFO - 'ts_paint', 08:49:31 INFO - 'tpaint', 08:49:31 INFO - 'sessionrestore', 08:49:31 INFO - 'sessionrestore_no_auto_restore', 08:49:31 INFO - 'tabpaint']}, 08:49:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:49:31 INFO - 'ts_paint', 08:49:31 INFO - 'tpaint', 08:49:31 INFO - 'sessionrestore', 08:49:31 INFO - 'sessionrestore_no_auto_restore', 08:49:31 INFO - 'tabpaint']}, 08:49:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:49:31 INFO - 'tests': ['a11yr', 08:49:31 INFO - 'ts_paint', 08:49:31 INFO - 'tpaint', 08:49:31 INFO - 'sessionrestore', 08:49:31 INFO - 'sessionrestore_no_auto_restore', 08:49:31 INFO - 'tabpaint']}, 08:49:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:49:31 INFO - 'tests': ['a11yr', 08:49:31 INFO - 'ts_paint', 08:49:31 INFO - 'tpaint', 08:49:31 INFO - 'sessionrestore', 08:49:31 INFO - 'sessionrestore_no_auto_restore', 08:49:31 INFO - 'tabpaint']}, 08:49:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:49:31 INFO - 'tests': ['tsvgx', 08:49:31 INFO - 'tsvgr_opacity', 08:49:31 INFO - 'tart', 08:49:31 INFO - 'tscrollx', 08:49:31 INFO - 'cart']}, 08:49:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:49:31 INFO - 'tsvgr_opacity', 08:49:31 INFO - 'tart', 08:49:31 INFO - 'tscrollx', 08:49:31 INFO - 'cart']}, 08:49:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:31 INFO - 'talos_options': ['--disable-e10s'], 08:49:31 INFO - 'tests': ['tp5o']}, 08:49:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:31 INFO - 'tests': ['tp5o']}, 08:49:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:31 INFO - 'talos_options': ['--disable-e10s', 08:49:31 INFO - '--xperf_path', 08:49:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:49:31 INFO - 'tests': ['tp5n']}, 08:49:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:31 INFO - 'talos_options': ['--xperf_path', 08:49:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:49:31 INFO - 'tests': ['tp5n']}}, 08:49:31 INFO - 'talos.zip': {'path': '', 08:49:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:49:31 INFO - Running post-action listener: _resource_record_post_action 08:49:31 INFO - [mozharness: 2016-11-15 16:49:31.225377Z] Finished populate-webroot step (success) 08:49:31 INFO - [mozharness: 2016-11-15 16:49:31.225469Z] Running create-virtualenv step. 08:49:31 INFO - Running pre-action listener: _resource_record_pre_action 08:49:31 INFO - Running main action method: create_virtualenv 08:49:31 INFO - Creating virtualenv /builds/slave/test/build/venv 08:49:31 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 08:49:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:49:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:49:31 INFO - Using real prefix '/usr' 08:49:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:49:31 INFO - Installing distribute.............................................................................................................................................................................................done. 08:49:33 INFO - Installing pip.................done. 08:49:33 INFO - Return code: 0 08:49:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:49:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:49:34 INFO - Reading from file tmpfile_stdout 08:49:34 INFO - Output received: 08:49:34 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) 08:49:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:34 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 0x7f2125f0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0df60>, '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 0xd0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0f1d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479227690.149988-730682823', '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 08:49:34 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 08:49:34 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 08:49:34 INFO - Using env: {'DISPLAY': ':0', 08:49:34 INFO - 'HOME': '/home/cltbld', 08:49:34 INFO - 'LANG': 'en_US.UTF-8', 08:49:34 INFO - 'LANGUAGE': 'en_US:en', 08:49:34 INFO - 'LOGNAME': 'cltbld', 08:49:34 INFO - 'MAIL': '/var/mail/cltbld', 08:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:34 INFO - 'MOZ_NO_REMOTE': '1', 08:49:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:34 INFO - 'NO_EM_RESTART': '1', 08:49:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:34 INFO - 'PWD': '/builds/slave/test', 08:49:34 INFO - 'SHELL': '/bin/bash', 08:49:34 INFO - 'SHLVL': '1', 08:49:34 INFO - 'TERM': 'linux', 08:49:34 INFO - 'TMOUT': '86400', 08:49:34 INFO - 'USER': 'cltbld', 08:49:34 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479227690.149988-730682823', 08:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:34 INFO - '_': '/tools/buildbot/bin/python'} 08:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:34 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 08:49:34 INFO - Cleaning up... 08:49:34 INFO - Return code: 0 08:49:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:34 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 0x7f2125f0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0df60>, '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 0xd0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0f1d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479227690.149988-730682823', '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 08:49:34 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 08:49:34 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 08:49:34 INFO - Using env: {'DISPLAY': ':0', 08:49:34 INFO - 'HOME': '/home/cltbld', 08:49:34 INFO - 'LANG': 'en_US.UTF-8', 08:49:34 INFO - 'LANGUAGE': 'en_US:en', 08:49:34 INFO - 'LOGNAME': 'cltbld', 08:49:34 INFO - 'MAIL': '/var/mail/cltbld', 08:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:34 INFO - 'MOZ_NO_REMOTE': '1', 08:49:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:34 INFO - 'NO_EM_RESTART': '1', 08:49:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:34 INFO - 'PWD': '/builds/slave/test', 08:49:34 INFO - 'SHELL': '/bin/bash', 08:49:34 INFO - 'SHLVL': '1', 08:49:34 INFO - 'TERM': 'linux', 08:49:34 INFO - 'TMOUT': '86400', 08:49:34 INFO - 'USER': 'cltbld', 08:49:34 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479227690.149988-730682823', 08:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:34 INFO - '_': '/tools/buildbot/bin/python'} 08:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:34 INFO - Downloading/unpacking psutil>=3.1.1 08:49:34 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 08:49:34 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 08:49:34 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 08:49:34 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 08:49:34 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 08:49:34 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 08:49:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:49:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:49:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:49:36 INFO - Installing collected packages: psutil 08:49:36 INFO - Running setup.py install for psutil 08:49:36 INFO - building 'psutil._psutil_linux' extension 08:49:36 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 08:49:36 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 08:49:36 INFO - building 'psutil._psutil_posix' extension 08:49:36 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 08:49:36 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 08:49:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:49:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:49:36 INFO - Successfully installed psutil 08:49:36 INFO - Cleaning up... 08:49:37 INFO - Return code: 0 08:49:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:49:37 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')]} 08:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:37 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')]} 08:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:37 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 0x7f2125f0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0df60>, '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 0xd0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0f1d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479227690.149988-730682823', '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 08:49:37 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 08:49:37 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 08:49:37 INFO - Using env: {'DISPLAY': ':0', 08:49:37 INFO - 'HOME': '/home/cltbld', 08:49:37 INFO - 'LANG': 'en_US.UTF-8', 08:49:37 INFO - 'LANGUAGE': 'en_US:en', 08:49:37 INFO - 'LOGNAME': 'cltbld', 08:49:37 INFO - 'MAIL': '/var/mail/cltbld', 08:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:37 INFO - 'MOZ_NO_REMOTE': '1', 08:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:37 INFO - 'NO_EM_RESTART': '1', 08:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:37 INFO - 'PWD': '/builds/slave/test', 08:49:37 INFO - 'SHELL': '/bin/bash', 08:49:37 INFO - 'SHLVL': '1', 08:49:37 INFO - 'TERM': 'linux', 08:49:37 INFO - 'TMOUT': '86400', 08:49:37 INFO - 'USER': 'cltbld', 08:49:37 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479227690.149988-730682823', 08:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:37 INFO - '_': '/tools/buildbot/bin/python'} 08:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:49:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:49:39 INFO - Installing collected packages: mozsystemmonitor 08:49:39 INFO - Running setup.py install for mozsystemmonitor 08:49:39 INFO - Successfully installed mozsystemmonitor 08:49:39 INFO - Cleaning up... 08:49:39 INFO - Return code: 0 08:49:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:49:39 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')]} 08:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:39 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')]} 08:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:39 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 0x7f2125f0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0df60>, '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 0xd0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0f1d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479227690.149988-730682823', '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 08:49:39 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 08:49:39 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 08:49:39 INFO - Using env: {'DISPLAY': ':0', 08:49:39 INFO - 'HOME': '/home/cltbld', 08:49:39 INFO - 'LANG': 'en_US.UTF-8', 08:49:39 INFO - 'LANGUAGE': 'en_US:en', 08:49:39 INFO - 'LOGNAME': 'cltbld', 08:49:39 INFO - 'MAIL': '/var/mail/cltbld', 08:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:39 INFO - 'MOZ_NO_REMOTE': '1', 08:49:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:39 INFO - 'NO_EM_RESTART': '1', 08:49:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:39 INFO - 'PWD': '/builds/slave/test', 08:49:39 INFO - 'SHELL': '/bin/bash', 08:49:39 INFO - 'SHLVL': '1', 08:49:39 INFO - 'TERM': 'linux', 08:49:39 INFO - 'TMOUT': '86400', 08:49:39 INFO - 'USER': 'cltbld', 08:49:39 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479227690.149988-730682823', 08:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:39 INFO - '_': '/tools/buildbot/bin/python'} 08:49:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:39 INFO - Downloading/unpacking jsonschema==2.5.1 08:49:39 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 08:49:39 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 08:49:39 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 08:49:39 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 08:49:39 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 08:49:39 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 08:49:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:49:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:49:41 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 08:49:41 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 08:49:41 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 08:49:41 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 08:49:41 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 08:49:41 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 08:49:41 INFO - Downloading functools32-3.2.3-2.tar.gz 08:49:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:49:41 INFO - warning: no files found matching '*.txt' 08:49:41 INFO - no previously-included directories found matching 'build' 08:49:41 INFO - no previously-included directories found matching 'dist' 08:49:41 INFO - no previously-included directories found matching '.git*' 08:49:41 INFO - Installing collected packages: jsonschema, functools32 08:49:41 INFO - Running setup.py install for functools32 08:49:41 INFO - warning: no files found matching '*.txt' 08:49:41 INFO - no previously-included directories found matching 'build' 08:49:41 INFO - no previously-included directories found matching 'dist' 08:49:41 INFO - no previously-included directories found matching '.git*' 08:49:41 INFO - Successfully installed jsonschema functools32 08:49:41 INFO - Cleaning up... 08:49:42 INFO - Return code: 0 08:49:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:49:42 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')]} 08:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:42 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')]} 08:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:42 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 0x7f2125f0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0df60>, '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 0xd0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0f1d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479227690.149988-730682823', '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 08:49:42 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 08:49:42 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 08:49:42 INFO - Using env: {'DISPLAY': ':0', 08:49:42 INFO - 'HOME': '/home/cltbld', 08:49:42 INFO - 'LANG': 'en_US.UTF-8', 08:49:42 INFO - 'LANGUAGE': 'en_US:en', 08:49:42 INFO - 'LOGNAME': 'cltbld', 08:49:42 INFO - 'MAIL': '/var/mail/cltbld', 08:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:42 INFO - 'MOZ_NO_REMOTE': '1', 08:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:42 INFO - 'NO_EM_RESTART': '1', 08:49:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:42 INFO - 'PWD': '/builds/slave/test', 08:49:42 INFO - 'SHELL': '/bin/bash', 08:49:42 INFO - 'SHLVL': '1', 08:49:42 INFO - 'TERM': 'linux', 08:49:42 INFO - 'TMOUT': '86400', 08:49:42 INFO - 'USER': 'cltbld', 08:49:42 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479227690.149988-730682823', 08:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:42 INFO - '_': '/tools/buildbot/bin/python'} 08:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:49:42 INFO - Cleaning up... 08:49:42 INFO - Return code: 0 08:49:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:49:42 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')]} 08:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:42 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')]} 08:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:42 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 0x7f2125f0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0df60>, '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 0xd0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0f1d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479227690.149988-730682823', '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 08:49:42 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 08:49:42 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 08:49:42 INFO - Using env: {'DISPLAY': ':0', 08:49:42 INFO - 'HOME': '/home/cltbld', 08:49:42 INFO - 'LANG': 'en_US.UTF-8', 08:49:42 INFO - 'LANGUAGE': 'en_US:en', 08:49:42 INFO - 'LOGNAME': 'cltbld', 08:49:42 INFO - 'MAIL': '/var/mail/cltbld', 08:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:42 INFO - 'MOZ_NO_REMOTE': '1', 08:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:42 INFO - 'NO_EM_RESTART': '1', 08:49:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:42 INFO - 'PWD': '/builds/slave/test', 08:49:42 INFO - 'SHELL': '/bin/bash', 08:49:42 INFO - 'SHLVL': '1', 08:49:42 INFO - 'TERM': 'linux', 08:49:42 INFO - 'TMOUT': '86400', 08:49:42 INFO - 'USER': 'cltbld', 08:49:42 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479227690.149988-730682823', 08:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:42 INFO - '_': '/tools/buildbot/bin/python'} 08:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:42 INFO - Downloading/unpacking blobuploader==1.2.4 08:49:42 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 08:49:42 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 08:49:42 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 08:49:42 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 08:49:42 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 08:49:42 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 08:49:44 INFO - Downloading blobuploader-1.2.4.tar.gz 08:49:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:49:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:49:44 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 08:49:44 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 08:49:44 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 08:49:44 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 08:49:44 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 08:49:44 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 08:49:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:49:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:49:44 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 08:49:44 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 08:49:44 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 08:49:44 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 08:49:44 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 08:49:44 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 08:49:45 INFO - Downloading docopt-0.6.1.tar.gz 08:49:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:49:45 INFO - Installing collected packages: blobuploader, requests, docopt 08:49:45 INFO - Running setup.py install for blobuploader 08:49:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:49:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:49:45 INFO - Running setup.py install for requests 08:49:45 INFO - Running setup.py install for docopt 08:49:45 INFO - Successfully installed blobuploader requests docopt 08:49:45 INFO - Cleaning up... 08:49:45 INFO - Return code: 0 08:49:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49:45 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')]} 08:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:45 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')]} 08:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:45 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 0x7f2125f0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0df60>, '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 0xd0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0f1d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479227690.149988-730682823', '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 08:49:45 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 08:49:45 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 08:49:45 INFO - Using env: {'DISPLAY': ':0', 08:49:45 INFO - 'HOME': '/home/cltbld', 08:49:45 INFO - 'LANG': 'en_US.UTF-8', 08:49:45 INFO - 'LANGUAGE': 'en_US:en', 08:49:45 INFO - 'LOGNAME': 'cltbld', 08:49:45 INFO - 'MAIL': '/var/mail/cltbld', 08:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:45 INFO - 'MOZ_NO_REMOTE': '1', 08:49:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:45 INFO - 'NO_EM_RESTART': '1', 08:49:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:45 INFO - 'PWD': '/builds/slave/test', 08:49:45 INFO - 'SHELL': '/bin/bash', 08:49:45 INFO - 'SHLVL': '1', 08:49:45 INFO - 'TERM': 'linux', 08:49:45 INFO - 'TMOUT': '86400', 08:49:45 INFO - 'USER': 'cltbld', 08:49:45 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479227690.149988-730682823', 08:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:45 INFO - '_': '/tools/buildbot/bin/python'} 08:49:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:49:46 INFO - Running setup.py (path:/tmp/pip-mRo8oK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:49:46 INFO - Running setup.py (path:/tmp/pip-AyXxi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:49:46 INFO - Running setup.py (path:/tmp/pip-UnIn35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:49:46 INFO - Running setup.py (path:/tmp/pip-0u5VhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:49:46 INFO - Running setup.py (path:/tmp/pip-S7P_IH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:49:46 INFO - Running setup.py (path:/tmp/pip-w2eAPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:49:46 INFO - Running setup.py (path:/tmp/pip-JAB7Pf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:49:46 INFO - Running setup.py (path:/tmp/pip-ksYXnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:49:46 INFO - Running setup.py (path:/tmp/pip-CqSXol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:49:46 INFO - Running setup.py (path:/tmp/pip-_WbK52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:49:46 INFO - Running setup.py (path:/tmp/pip-UTM8XA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:49:46 INFO - Running setup.py (path:/tmp/pip-394FhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:49:46 INFO - Running setup.py (path:/tmp/pip-qVIgUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:49:46 INFO - Running setup.py (path:/tmp/pip-suKKLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:47 INFO - Running setup.py (path:/tmp/pip-nIiifN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:49:47 INFO - Running setup.py (path:/tmp/pip-buwC5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:49:47 INFO - Running setup.py (path:/tmp/pip-HbQ5Gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:49:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:49:47 INFO - Running setup.py install for manifestparser 08:49:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:49:47 INFO - Running setup.py install for mozcrash 08:49:47 INFO - Running setup.py install for mozdebug 08:49:47 INFO - Running setup.py install for mozdevice 08:49:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:49:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:49:47 INFO - Running setup.py install for mozfile 08:49:47 INFO - Running setup.py install for mozhttpd 08:49:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:49:47 INFO - Running setup.py install for mozinfo 08:49:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:49:47 INFO - Running setup.py install for mozInstall 08:49:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:49:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:49:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:49:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:49:48 INFO - Running setup.py install for mozleak 08:49:48 INFO - Running setup.py install for mozlog 08:49:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:49:48 INFO - Running setup.py install for moznetwork 08:49:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:49:48 INFO - Running setup.py install for mozprocess 08:49:48 INFO - Running setup.py install for mozprofile 08:49:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:49:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:49:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:49:48 INFO - Running setup.py install for mozrunner 08:49:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:49:48 INFO - Running setup.py install for mozscreenshot 08:49:48 INFO - Running setup.py install for moztest 08:49:48 INFO - Running setup.py install for mozversion 08:49:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:49:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:49:48 INFO - Cleaning up... 08:49:49 INFO - Return code: 0 08:49:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49:49 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')]} 08:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:49 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')]} 08:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:49 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 0x7f2125f0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0df60>, '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 0xd0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0f1d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479227690.149988-730682823', '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 08:49:49 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 08:49:49 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 08:49:49 INFO - Using env: {'DISPLAY': ':0', 08:49:49 INFO - 'HOME': '/home/cltbld', 08:49:49 INFO - 'LANG': 'en_US.UTF-8', 08:49:49 INFO - 'LANGUAGE': 'en_US:en', 08:49:49 INFO - 'LOGNAME': 'cltbld', 08:49:49 INFO - 'MAIL': '/var/mail/cltbld', 08:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:49 INFO - 'MOZ_NO_REMOTE': '1', 08:49:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:49 INFO - 'NO_EM_RESTART': '1', 08:49:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:49 INFO - 'PWD': '/builds/slave/test', 08:49:49 INFO - 'SHELL': '/bin/bash', 08:49:49 INFO - 'SHLVL': '1', 08:49:49 INFO - 'TERM': 'linux', 08:49:49 INFO - 'TMOUT': '86400', 08:49:49 INFO - 'USER': 'cltbld', 08:49:49 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479227690.149988-730682823', 08:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:49 INFO - '_': '/tools/buildbot/bin/python'} 08:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:49:49 INFO - Running setup.py (path:/tmp/pip-xqpYyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:49:49 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)) 08:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:49:49 INFO - Running setup.py (path:/tmp/pip-VVXdJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:49:49 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)) 08:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:49:49 INFO - Running setup.py (path:/tmp/pip-NXqCJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:49:49 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)) 08:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:49:49 INFO - Running setup.py (path:/tmp/pip-vSqdBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:49:49 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)) 08:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:49:49 INFO - Running setup.py (path:/tmp/pip-of6zND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:49:49 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)) 08:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:49:49 INFO - Running setup.py (path:/tmp/pip-0qYNqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:49:49 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)) 08:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:49:49 INFO - Running setup.py (path:/tmp/pip-izCfjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:49:49 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)) 08:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:49:49 INFO - Running setup.py (path:/tmp/pip-6uU7im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:49:49 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)) 08:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:49:49 INFO - Running setup.py (path:/tmp/pip-4iaVm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:49:49 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)) 08:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:49:49 INFO - Running setup.py (path:/tmp/pip-uV6cAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:49:49 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)) 08:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:49:49 INFO - Running setup.py (path:/tmp/pip-jhrkb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:49:50 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)) 08:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:49:50 INFO - Running setup.py (path:/tmp/pip-Fcpcyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:49:50 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)) 08:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:49:50 INFO - Running setup.py (path:/tmp/pip-9EIFUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:49:50 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)) 08:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:49:50 INFO - Running setup.py (path:/tmp/pip-5oBJ_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:49:50 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)) 08:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:50 INFO - Running setup.py (path:/tmp/pip-9Ln3qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:50 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)) 08:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:49:50 INFO - Running setup.py (path:/tmp/pip-tzvais-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:49:50 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)) 08:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:49:50 INFO - Running setup.py (path:/tmp/pip-ZIRME3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:49:50 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)) 08:49:50 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)) 08:49:50 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)) 08:49:50 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)) 08:49:50 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)) 08:49:50 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)) 08:49:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:49:50 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 08:49:50 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 08:49:50 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 08:49:50 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 08:49:50 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 08:49:50 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 08:49:52 INFO - Downloading blessings-1.6.tar.gz 08:49:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:49:52 INFO - Installing collected packages: blessings 08:49:52 INFO - Running setup.py install for blessings 08:49:52 INFO - Successfully installed blessings 08:49:52 INFO - Cleaning up... 08:49:52 INFO - Return code: 0 08:49:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:49:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:49:52 INFO - Reading from file tmpfile_stdout 08:49:52 INFO - Current package versions: 08:49:52 INFO - argparse == 1.2.1 08:49:52 INFO - blessings == 1.6 08:49:52 INFO - blobuploader == 1.2.4 08:49:52 INFO - docopt == 0.6.1 08:49:52 INFO - functools32 == 3.2.3-2 08:49:52 INFO - jsonschema == 2.5.1 08:49:52 INFO - manifestparser == 1.1 08:49:52 INFO - mozInstall == 1.12 08:49:52 INFO - mozcrash == 1.0 08:49:52 INFO - mozdebug == 0.1 08:49:52 INFO - mozdevice == 0.48 08:49:52 INFO - mozfile == 1.2 08:49:52 INFO - mozhttpd == 0.7 08:49:52 INFO - mozinfo == 0.9 08:49:52 INFO - mozleak == 0.1 08:49:52 INFO - mozlog == 3.4 08:49:52 INFO - moznetwork == 0.27 08:49:52 INFO - mozprocess == 0.23 08:49:52 INFO - mozprofile == 0.28 08:49:52 INFO - mozrunner == 6.13 08:49:52 INFO - mozscreenshot == 0.1 08:49:52 INFO - mozsystemmonitor == 0.3 08:49:52 INFO - moztest == 0.7 08:49:52 INFO - mozversion == 1.4 08:49:52 INFO - psutil == 3.1.1 08:49:52 INFO - requests == 1.2.3 08:49:52 INFO - wsgiref == 0.1.2 08:49:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49:52 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')]} 08:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:52 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')]} 08:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:52 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 0x7f2125f0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0df60>, '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 0xd0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0f1d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479227690.149988-730682823', '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 08:49:52 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 08:49:52 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 08:49:52 INFO - Using env: {'DISPLAY': ':0', 08:49:52 INFO - 'HOME': '/home/cltbld', 08:49:52 INFO - 'LANG': 'en_US.UTF-8', 08:49:52 INFO - 'LANGUAGE': 'en_US:en', 08:49:52 INFO - 'LOGNAME': 'cltbld', 08:49:52 INFO - 'MAIL': '/var/mail/cltbld', 08:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:52 INFO - 'MOZ_NO_REMOTE': '1', 08:49:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:52 INFO - 'NO_EM_RESTART': '1', 08:49:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:52 INFO - 'PWD': '/builds/slave/test', 08:49:52 INFO - 'SHELL': '/bin/bash', 08:49:52 INFO - 'SHLVL': '1', 08:49:52 INFO - 'TERM': 'linux', 08:49:52 INFO - 'TMOUT': '86400', 08:49:52 INFO - 'USER': 'cltbld', 08:49:52 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479227690.149988-730682823', 08:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:52 INFO - '_': '/tools/buildbot/bin/python'} 08:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:53 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)) 08:49:53 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)) 08:49:53 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)) 08:49:53 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)) 08:49:53 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)) 08:49:53 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)) 08:49:53 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)) 08:49:53 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)) 08:49:53 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)) 08:49:53 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)) 08:49:53 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)) 08:49:53 INFO - Cleaning up... 08:49:53 INFO - Return code: 0 08:49:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:49:53 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')]} 08:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:53 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')]} 08:49:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:53 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 0x7f2125f0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0df60>, '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 0xd0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0f1d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479227690.149988-730682823', '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 08:49:53 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 08:49:53 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 08:49:53 INFO - Using env: {'DISPLAY': ':0', 08:49:53 INFO - 'HOME': '/home/cltbld', 08:49:53 INFO - 'LANG': 'en_US.UTF-8', 08:49:53 INFO - 'LANGUAGE': 'en_US:en', 08:49:53 INFO - 'LOGNAME': 'cltbld', 08:49:53 INFO - 'MAIL': '/var/mail/cltbld', 08:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:53 INFO - 'MOZ_NO_REMOTE': '1', 08:49:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:53 INFO - 'NO_EM_RESTART': '1', 08:49:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:53 INFO - 'PWD': '/builds/slave/test', 08:49:53 INFO - 'SHELL': '/bin/bash', 08:49:53 INFO - 'SHLVL': '1', 08:49:53 INFO - 'TERM': 'linux', 08:49:53 INFO - 'TMOUT': '86400', 08:49:53 INFO - 'USER': 'cltbld', 08:49:53 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479227690.149988-730682823', 08:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:53 INFO - '_': '/tools/buildbot/bin/python'} 08:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:49:53 INFO - Cleaning up... 08:49:53 INFO - Return code: 0 08:49:53 INFO - Running post-action listener: _resource_record_post_action 08:49:53 INFO - Running post-action listener: _start_resource_monitoring 08:49:53 INFO - Starting resource monitoring. 08:49:53 INFO - [mozharness: 2016-11-15 16:49:53.444251Z] Finished create-virtualenv step (success) 08:49:53 INFO - [mozharness: 2016-11-15 16:49:53.444750Z] Running install step. 08:49:53 INFO - Running pre-action listener: _resource_record_pre_action 08:49:53 INFO - Running main action method: install 08:49:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:49:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:49:53 INFO - Reading from file tmpfile_stdout 08:49:53 INFO - Detecting whether we're running mozinstall >=1.0... 08:49:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:49:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:49:53 INFO - Reading from file tmpfile_stdout 08:49:53 INFO - Output received: 08:49:53 INFO - Usage: mozinstall [options] installer 08:49:53 INFO - Options: 08:49:53 INFO - -h, --help show this help message and exit 08:49:53 INFO - -d DEST, --destination=DEST 08:49:53 INFO - Directory to install application into. [default: 08:49:53 INFO - "/builds/slave/test"] 08:49:53 INFO - --app=APP Application being installed. [default: firefox] 08:49:53 INFO - mkdir: /builds/slave/test/build/application 08:49:53 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'] 08:49:53 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 08:50:09 INFO - Reading from file tmpfile_stdout 08:50:09 INFO - Output received: 08:50:09 INFO - /builds/slave/test/build/application/firefox/firefox 08:50:09 INFO - Running post-action listener: _resource_record_post_action 08:50:09 INFO - [mozharness: 2016-11-15 16:50:09.708234Z] Finished install step (success) 08:50:09 INFO - [mozharness: 2016-11-15 16:50:09.708476Z] Running run-tests step. 08:50:09 INFO - Running pre-action listener: _resource_record_pre_action 08:50:09 INFO - Running main action method: run_tests 08:50:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:50:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:50:09 INFO - Python 2.7.3 08:50:09 INFO - Return code: 0 08:50:09 INFO - grabbing minidump binary from tooltool 08:50:09 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')]} 08:50:09 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 0xd0df60>, '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 0xd0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0f1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:50:09 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 08:50:09 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 08:50:09 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 08:50:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:50:09 INFO - Return code: 0 08:50:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:50:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:50:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:50:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:50:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:50:09 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/bfvqbkAhSJiRCA19KXeKLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 08:50:09 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/bfvqbkAhSJiRCA19KXeKLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 08:50:09 INFO - Using env: {'DISPLAY': ':0', 08:50:09 INFO - 'HOME': '/home/cltbld', 08:50:09 INFO - 'LANG': 'en_US.UTF-8', 08:50:09 INFO - 'LANGUAGE': 'en_US:en', 08:50:09 INFO - 'LOGNAME': 'cltbld', 08:50:09 INFO - 'MAIL': '/var/mail/cltbld', 08:50:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:50:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:09 INFO - 'MOZ_NO_REMOTE': '1', 08:50:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:50:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:09 INFO - 'NO_EM_RESTART': '1', 08:50:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:09 INFO - 'PWD': '/builds/slave/test', 08:50:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:50:09 INFO - 'SHELL': '/bin/bash', 08:50:09 INFO - 'SHLVL': '1', 08:50:09 INFO - 'TERM': 'linux', 08:50:09 INFO - 'TMOUT': '86400', 08:50:09 INFO - 'USER': 'cltbld', 08:50:09 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479227690.149988-730682823', 08:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:09 INFO - '_': '/tools/buildbot/bin/python'} 08:50:09 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/bfvqbkAhSJiRCA19KXeKLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 08:50:09 INFO - mozversion application_buildid: 20161115060313 08:50:09 INFO - mozversion application_changeset: bfaa16ab61ee71dd05d27e2b07244032207b5dad 08:50:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:50:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:50:09 INFO - mozversion application_name: Firefox 08:50:09 INFO - mozversion application_remotingname: firefox-dev 08:50:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:50:09 INFO - mozversion application_vendor: Mozilla 08:50:09 INFO - mozversion application_version: 52.0a2 08:50:09 INFO - mozversion platform_buildid: 20161115060313 08:50:09 INFO - mozversion platform_changeset: bfaa16ab61ee71dd05d27e2b07244032207b5dad 08:50:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:50:09 INFO - mozversion platform_version: 52.0a2 08:50:09 INFO - using testdate: 1479228609 08:50:09 INFO - actual date: 1479228609 08:50:09 INFO - starting webserver on 'localhost:46476' 08:50:09 INFO - SUITE-START | Running 2 tests 08:50:09 INFO - TEST-START | dromaeo_css 08:50:09 INFO - operating with platform_type : linux_ 08:50:09 INFO - Initialising browser for dromaeo_css test... 08:50:09 INFO - TEST-INFO | started process 13899 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWilgyQ/profile http://localhost:46476/getInfo.html) 08:50:13 ERROR - PROCESS | 13899 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 08:50:14 INFO - PROCESS | 13899 | __metrics Screen width/height:1600/1200 08:50:14 INFO - PROCESS | 13899 | colorDepth:24 08:50:14 INFO - PROCESS | 13899 | Browser inner width/height: 1024/697 08:50:14 INFO - PROCESS | 13899 | __metrics 08:50:14 INFO - PROCESS | 13899 | 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" 08:50:14 INFO - PROCESS | 13899 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:50:15 INFO - PROCESS | 13899 | console.error: PushService: 08:50:15 INFO - PROCESS | 13899 | stateChangeProcessEnqueue: Error transitioning state 08:50:15 INFO - PROCESS | 13899 | UnknownError 08:50:15 INFO - TEST-INFO | 13899: exit 0 08:50:15 INFO - Browser initialized. 08:50:15 INFO - Running cycle 1/1 for dromaeo_css test... 08:50:15 INFO - TEST-INFO | started process 13990 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWilgyQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:50:27 INFO - PROCESS | 13990 | RSS: Main: 144314368 08:50:27 INFO - PROCESS | 13990 | 08:51:19 INFO - PROCESS | 13990 | 1479228679251 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] 08:53:29 INFO - PROCESS | 13990 | Cycle 1(1): loaded http://localhost:46476/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46476/tests/dromaeo/cssquery-ext.html) 08:53:30 INFO - PROCESS | 13990 | RSS: Main: 234209280 08:53:30 INFO - PROCESS | 13990 | 08:56:32 INFO - PROCESS | 13990 | Cycle 1(1): loaded http://localhost:46476/tests/dromaeo/cssquery-ext.html (next: http://localhost:46476/tests/dromaeo/cssquery-jquery.html) 08:56:33 INFO - PROCESS | 13990 | RSS: Main: 234762240 08:56:33 INFO - PROCESS | 13990 | 08:59:35 INFO - PROCESS | 13990 | Cycle 1(1): loaded http://localhost:46476/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46476/tests/dromaeo/cssquery-mootools.html) 08:59:36 INFO - PROCESS | 13990 | RSS: Main: 174501888 08:59:36 INFO - PROCESS | 13990 | 09:02:38 INFO - PROCESS | 13990 | Cycle 1(1): loaded http://localhost:46476/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46476/tests/dromaeo/cssquery-prototype.html) 09:02:38 INFO - PROCESS | 13990 | RSS: Main: 230125568 09:02:38 INFO - PROCESS | 13990 | 09:05:41 INFO - PROCESS | 13990 | Cycle 1(1): loaded http://localhost:46476/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46476/tests/dromaeo/cssquery-yui.html) 09:05:41 INFO - PROCESS | 13990 | RSS: Main: 174845952 09:05:41 INFO - PROCESS | 13990 | 09:08:44 INFO - PROCESS | 13990 | Cycle 1(1): loaded http://localhost:46476/tests/dromaeo/cssquery-yui.html (next: http://localhost:46476/tests/dromaeo/cssquery-dojo.html) 09:08:44 INFO - PROCESS | 13990 | RSS: Main: 264187904 09:08:44 INFO - PROCESS | 13990 | 09:08:44 INFO - PROCESS | 13990 | __start_tp_report 09:08:44 INFO - PROCESS | 13990 | _x_x_mozilla_page_load 09:08:44 INFO - PROCESS | 13990 | _x_x_mozilla_page_load_details 09:08:44 INFO - PROCESS | 13990 | |i|pagename|runs| 09:08:44 INFO - PROCESS | 13990 | |0;dojo.html;3185.076327864919;3233.240188555689;3233.692799184078;3251.821149836758;3262.054004338742;5469.753861076251;5548.44515548445;5555.638883472571;5573.108302671573;5584.441555844413;5581.302337207849;5608.298962629671;5613.045782217023;5615.073512870382;5621.269234999455;5063.670861394007;5078.187490001582;5107.387113546361;5121.564667003309;5173.974130129344;4967.801287948478;4994.550490455858;5107.719075450848;5155.355580552431;5159;4946.9752651236695;4983.252512123175;5020.121478741224;5022.146235140017;5024.196128619422;5022.321986531808;5081.8475445736685;5088.440271570162;5092.668976516515;5115.897682046376;4860.295257187688;4990.2764099205415;5001.749912504397;5024.874378140539;5054.9241761373605;5414.025475414423;5469.480399362094;5519.917201241985;5540.889182216373;5558.277423934863;5991.101334799771;6022.457978781887;6022.789202377896;6024.668643224621;6028.246469191351;5864.70676466175;6042.335343112254;6048.334683184846;6054.909176362358;6072.149899014142;5514.448555144493;5572.944270557324;5606.97196514023;5615.129654903497;5675.829725108253;6127.571070025056;6162.044883043135;6172.814815555541;6173.567850250529;6174.44430001302;5908.20239267702;5910.34986151523;5920.703964801829;5929.0217114175675;5935.080062590306;5722.7710891563875;5827;5901.793437229677;5940.34656187819;5969.641821490724;5988.700564971734;5999.640021598718;6002.6698531580305;6004.219451471281;6039.124326972652;5998.850028749316;6000.759969601167;6007.849803754941;6008.729607167688;6030.4572588467245;4421.889452763642;4516.638668906479;4523.660725445605;4603.769811509411;4606.539346065367;4056.513218413809;4076.8916318533907;4079.7756123413496;4105.856295029719;4122.484689413824;5617.803376881871;5679.574031947621;5679.716014199274;5681.403452637496;5711.485966263056;5756.65460072397;5790.305163380337;5980.132880732356;5982.551308651869;5990.251218597676;5582.637128586629;5596.748146333425;5641.633293835887;5671.914921276184;5713.885722285531;5108.540231379194;5109.846704598794;5111.667741596784;5128.153854614022;5137.614678899097;6154.446099851035;6171.105189747551;6174.475169610633;6221.06683997395;6222.066689996536;5776.075827867521;5846.356900741001;5895.351511333664;5915.112733090071;5928.8814223716145;6116.449519543263;6125.754969801336;6129.969350153221;6137.46891820379;6164.568480206342;5765.164051212634;5793.420657934173;5831.650100993954;5832.533397328119;5836.533077353886;5848.064309710426;5854.151148083419;5891.911621325769;5921.437463440966;5928.881422371443;5809.331926828469;5888.234529511136;5889.204957330706;5912.49743771767;5920.111983202554;5872.970635146797;5878.441548052928;5879.353271140257;5882.117682347682;5884.411558844081;5601.355844077983;5643.66138031703;5797.768089276382;5805.332386775575;5811.53507719373;5738.540916726568;5738.626989245853;5772.624779389326;5792.710364481674;5875.794347197828;5698.0598201296325;5712.685802280915;5718.399568045295;5719.714014299185;5725.2843394575675 09:08:44 INFO - PROCESS | 13990 | |1;ext.html;582.1239035251945;613.1538476901875;645.6190847400034;653.2520264297376;657.3722095398895;33268.33463330735;44578.33132503015;44912;44913;44934.5506544934;47396.0520789584;47835;47857.282140767915;47870;47900;8952.597133129026;9076.183143517082;9079.046700096495;9086.409383390059;9086.77283067922;8893.73318800437;8988.460692358447;8994.955025224865;9001.864972025425;9003.909960900406;8991.100889911022;9036.36745427817;9038.819223615525;9043.819123617524;9053.728388148333;8931.151540603665;8951.104889511029;8984.640614375417;8994.41536300145;8995.235404990552;8713.433626814236;8799.076097009785;8810;8813.294936405073;8815.647374105029;43319.35020974688;43503;43773.78113109414;43837.78081109574;43919;3405.5062016007787;3655.4882316475714;4172.207280616703;4179.540250572434;4200.516940551845;33330;33421.83289083539;33542.1614459638;33599.16002099943;33717.831410843035;4425.141031401347;4488.214562451591;4567.063751930847;4582.6104781093645;4589.613242097636;332912;333800;334087;334218;334497;63484.682576587744;63991.680041599495;64050.35949640444;64058.35941640524;64172.35827641757;40557.59442405538;67219;67220.66389668119;67440.32559674438;67458.32541674521;17644;18755.812441875678;18756.81243187578;18773.90613046926;18817.341393051178;14102.224377659328;14111.2944352784;14142.929285353714;14143.64640883986;14151.575452736435;20443.897780511;20713.27503537369;20812.27157049496;20864.791352086286;20924.790752092587;7280.490365674458;7328.3404493595835;7511.3615342696485;7563.886541701879;7699.230076992368;966.8259713251682;1056.884986339404;1062.7715041266165;1085.9945700271448;1089.5260561655705;32562.348753024806;32726.345473090405;32834.835825821196;32981.67018329786;33063.84276550309;961.3895176562933;1109.4730003248392;1125.1954852280658;1138.3568283919724;1170.023030769317;16397.42609008703;17093.316267349415;17182.828171718375;17279;17279.56801079983;253749;255795;256056;256060;256234;61713;62636.68681656654;62670.68664656648;62671.37328626656;62698.68650656717;1231.5504840733067;1272.7327261275236;1376.3737499437732;1397.573740009307;1459.569427019032;29484.852575736983;33394.666053339155;34192;34495.620175192715;34945.30109397747;53153.7342313286;54225.72887135539;54328.45671543234;54334.45665543294;54367.18449223344;417984;418188;419124;419412;420296;30336.241593960327;30896.227594310323;31015.68984310128;31025.224369390944;31107.844460777553;50153;50912.23631645602;50983.81726059655;51029.74485127551;51396.74301628468;41570.376444352754;43145;43895.56104438915;44816;45524.54475455335;42171.156576867674;42478;42499.36250956176;43584.12831743411;43896.12207755891;41971.37042944297;42659.786701066296;42904.57095429006;46296.305555416024;46647.76676116598;41959.790201048796;46285.76857115693;46641.53358466508;47013.52986470229;47829.76085119552;33256.833715831264;35431.468527971585;35808.28383432265;35907.28185436329;35929.64070359263 09:08:44 INFO - PROCESS | 13990 | |2;jquery.html;390.9120447899225;399;422.39597375752675;423.30155243847645;434.7130893610218;15912.840871591281;19229.84979481256;19518.121684524194;19673.901630491844;19689.113989870453;19554.70667939982;19690.409287721355;19886.602267954633;20079.196832126734;20163.2942847;4728.645351598627;5674.3190817102;5815.38938411467;5861.7948371807;5902.76042031174;5769.682667453289;5856.385079566648;5867.090600956859;5870.0314448116005;5870.207521984542;5780.682062486561;5836.737346819404;6058.848528786772;6063.2724073111285;6146.815595532141;5899.498542623882;6078.392160783908;6107.236595425572;6121.510279177677;6122;5814.709264536798;5881.9705901470215;5884.588078834483;5896.027155519334;5896.64620122794;15985;23089;23411.76588234113;23945.16191933274;24075.9165837536;2326.3835083702834;2349.2717257650183;2414.3119211024773;2656.6546348974703;2753.2428582139873;11148.275362101438;11405.429728513542;11732.072529537614;15711.764323535157;15831.683366332609;2028.4117605894273;2053.7946205379494;2066.9379918602467;2103.074647155247;2115.418259978518;67954.32045679529;70981.64509177473;74457.25542744558;81911.59044204741;87000.56499717524;11365.715857103638;11460.484278207501;11642.476088576035;11675.357855317869;12050.457729402198;16612.83387166113;16623.584410389838;16625.418110366078;16651;16653.750193747102;8546.102659220816;8649.1350864913;8694.17405346491;8700.825983480296;8865.734027979172;8246.917530824734;8325.66697332112;8478.364122690822;8510.574471276412;8551.657933682583;5022.447530771612;5071.087204303187;5089.185730283137;5118.667286626357;5166.844994650167;2124.893755312228;2132.3496333618396;2134.903929323184;2151.8278537716947;2182.701292730823;809.5587904592012;914.4696076275744;926.9953650231706;993.3940296419179;1064.7284942339654;19370;19909.701354479694;20222.292219772236;21523.892380537996;21809.781902180774;1022.8979447236002;1047.9476026198658;1062.6015244283394;1096.5339730614617;1118.0775859915602;10352.482375881176;11180.776384472265;11181.72045698864;11249.156313276537;11337.943310283395;388139;393990;396980;500284;519017;96546;104489;108952;109575;109859.45070274598;1052.2003277508995;1067.3755852826027;1092.2736380307008;1105.3533682795494;1107.1364335818075;13828.723425531232;16725.247363868413;17351.56621084483;17404.912975435043;18699.906500467412;44486;44997.875053123935;45257.77371113123;45640.54359456496;46660;56192.15711764245;61317.080243795484;65278;65643.67178164079;66089.33910661025;8156.776483527518;8550.05949345559;8721.345899057469;8769.736907892773;8800.559972001502;10621.884702106168;12326.691832703895;12371.876281237432;12526.561570344995;12581.182223155465;10697.732556686145;10720.892791071989;10949.726256843642;11041.613543525938;11042.944785276022;10549.525271362654;10579.10077643409;10681.786364272826;10886.129109671048;10948.671539853816;10255.282130250811;10715.678529644123;10717.196210284104;10843.240973131806;11087.06192858877;8059.314958228616;8616;8665.176808203463;8671.34964877624;8767.473951562926;8589.484630922165;10479.738006549896;10667.839982400115;10829.025387715143;10935.890641093487 09:08:44 INFO - PROCESS | 13990 | |3;mootools.html;1525.4050920141144;1568.0748358468504;1720.277483456948;1834.5963887944665;1865.1233920057578;8452.492850428978;8955.238804701592;8960.820783584324;8973.102689731024;8980.101989801016;7769.533827970312;7989.480683755552;8390.83218335633;8619.91380086199;8833.867491987608;2480.5410998965203;2508.799296056311;2511.033252197908;2520.7227205007434;2523.3691577105724;2462.2613216035206;2535.024015753939;2535.290118766748;2539.9238022859345;2539.9492010159784;2439.146298795425;2449.8162637802147;2485.7389974052735;2488.6515887775727;2502.2118032819603;2377.5482658294954;2382.2019623426086;2398.520295940819;2409.6626472293806;2414.263649586875;2414.7826695597305;2414.9396265093337;2426.417659761662;2447.645091461728;2447.9510409791883;8369.414141010131;8440.451370660949;8587.398882078258;8592.785180370478;8598.828023439497;5318.468153184689;5456.645318054314;5461.5357694596005;5466.207399926989;5468.9726551367385;3496.7377446691344;3522.9119272018406;3558.1460449492192;3604.6755791978585;3605.7836529808296;1121.8205087186093;1131.7736452709491;1169.0243488504486;1175.177375836909;1233.4511142541573;12629.936850315782;12644.30456324911;12655.240685558896;12676.80984785229;12679.112462127654;4605.447346318396;4715.269133284346;4768.213244814567;4789.114013907439;4917.139500587383;10536.262461627766;10542.683719488428;10545.261831671709;10567.418791966362;10569.418681972411;5457.045017122067;5484.8354549363585;5489.835304940858;5496.422875598085;5500.367457742411;4341.327094300388;4539.296409056601;4949.876253093701;4972.8756781080765;5005.674631148963;4078.7756673382655;4107.0553772631865;4164.271252530795;4198.433211516406;4201.705880588391;1351.9932400337934;1360.2042804959012;1361.455417832855;1364.2155760437788;1380.1718968618748;811.3752410643772;869.8956125265008;943.4858002388714;1002.7944271424341;1021.4688362051692;5829.475347218686;5897.262842144732;5905.734241959122;6010.909836352458;6013.428724271187;929.9163075323254;954.1126752120595;958.5542722633869;974.1670871404989;980.3333733061587;4139.834406623761;4235.830566777356;4241.151769646083;4267.8079486423185;4296.226679197712;10779;11117.555297787998;11163.441827908735;11201.66395008151;11252.66242012741;10773.83839242412;10898.182636302308;11121.27711698737;11140.33158010522;11147.498362573704;8409.32725381968;8546.188112129337;8550.615222315011;8552.657893684183;8558.529280889486;5705.686187259741;5882.058870580858;5882.764689412375;5892.616979896293;6036.698165091816;9898.10917017472;9963.651272205438;10066.69799906004;10127.139193168663;10159.695209143738;10400.323978941648;10464.738381540217;10521.684349469528;10559.04968552834;10573.9471302643;7402.7409040683315;7587.317141457295;7667.539947603162;7674.884876726742;7709.768706938801;8400.117987611213;8530.74407767768;8621.612027458905;8643.654253829776;8921.420107692978;7404.333609975128;8005.3995950305125;8161.143079976517;8248.092709802037;8402.70590529353;7881.369490440866;7899.210078992055;7984.401169912164;8027.438079334391;8033.799155021171;6997.05539752127;7026.824329391806;7086.326798954091;7087.929120708727;7156.141263048467;5276.604254680838;5282.630215885005;5315.973420132875;5340.679559226459;5346.652467589594;5437.782488700566;5484.314460692413;5495.148252020943;5543;5580.107182850725 09:08:44 INFO - PROCESS | 13990 | |4;prototype.html;340.7938197390579;353.2370080625848;354.14827340246705;360.46111063959387;362.03698162886724;5195.090859099652;5345.412004679482;5385.246065550826;5407.296351824088;5429.511343979037;5222.007818514479;5304.655197412166;5356.54469370104;5366;5374.301340825697;4210.936835947456;4214.557471465498;4270.210011147932;4271.316589345705;4279.40088387626;4144.730592511492;4240.448741663579;4244.299690551055;4271.679624028195;4280.165367753274;4236.428082208909;4241.830326786925;4249.08644641402;4249.25638013348;4253.8085786139545;4222.662187025031;4230.725002874803;4237.957620423803;4250.426192464009;4262.616364527207;3715.20123173519;3825.1202223488476;3827.5215598050245;3837;3850.634189751969;5233.869153271161;5248.973755131238;5259.684418934838;5260.185236093542;5269.420363759983;4860.173770458995;4888.364512613373;4899.314096026559;4899.730514821684;4938.209886418156;5431.212474191259;5580.804671836507;5598.720063996784;5637.210790489335;5661.970845597627;4180.916381672349;4183.309753890604;4191.790410479494;4195.643370313527;4196.607933477919;5809.7095145242565;5817.680027598481;5837.795677151322;5848.912266316009;5854.443827836349;4187.330027195695;4280.315149576115;4281.614654681093;4305.48334199898;4324.286492728727;4338.783060846945;4371.295194874002;4376.934345984812;4380.189664912002;4383.16719823239;4862.270659401047;4865.5864251539015;4895.853124406273;4896.363472748591;4922.950770492249;5476.479734425223;5580.414056524088;5653.660780353192;5662.603617746719;5711.857203569861;1371.9862801372058;1390.4021270853427;1431.957041288763;1469.6472846516758;1477.1949287638263;987.6148302162162;1016.2124353625999;1019.4596863662271;1020.4438580973388;1039.1167507618463;5237.062286953776;5247.632665713363;5254.238135470336;5257.580453277594;5269.631125821155;5494.945050549523;5499.642523235977;5517.227588137664;5530.170474428868;5574.498295153375;5096.431101399801;5166.354205724285;5178.741062946838;5190.584753219733;5250.632455728139;2927.9414411712073;2956.2705817096808;2957.896473623413;2958.556216567532;2999.580058791771;5795.565332600072;5821.505172060422;5825.88348233033;5826.621269617462;5839.824805255849;5324.520793128637;5567.993283626877;5624.803131890364;5636.746346414421;5659.603827732019;5670.943290567042;5709.314882214077;5725.971370143206;5731.595759038979;5748.223989761329;5235.869103272448;5495.917561236504;5533.501984821385;5560.026995275892;5569.880866714653;5417.485338892799;5420.566354691537;5435.293411856592;5446.700431476307;5464.726763661881;5696.515796157208;5697.800576979786;5717.3996730342715;5718.542516598579;5718.828435146952;3929.587393323774;4139.772312522719;4150.377443383517;4163.521195062606;4173.770442625685;5525.254090697705;5634.88730225385;5720.48515633595;5729.341125770589;5734.340550836707;5508.862278443071;5520.254765606592;5536.390996990408;5549.472800083986;5558.666480011212;5621.409751975983;5648.971755141198;5653.830385088454;5661.197707134995;5721.370649228665;5373.785048598169;5573.1918871762555;5576.358718747234;5610.775568977195;5615;5688.715564221855;5699.173619825185;5723.656580605177;5736.504620489934;5738.053221218619;5466.234727138124;5604.271444712162;5615.388844187472;5616.85957851057;5620.409856965123 09:08:44 INFO - PROCESS | 13990 | |5;yui.html;689.6999805084788;703.7994171661074;706.6290197646232;830.8296799156174;880.8766772651829;14362.640933976656;15661.373545058212;15736.685266294668;15742.29159687814;15753.92123039386;13247.801282980763;13895.722085558284;13987.860121398782;14013.579592612212;14062.367193476293;711.5375006245955;732.9377002954728;857.2199298638225;862.4782006885838;862.9395942284043;833.62903507939;856.7472595584318;864.2265172670457;865.8051938313891;866.5147517390282;904.4302089683523;904.7421484876811;904.9547522623875;904.9999750275949;912.1608120529096;749.5727435361846;768.5235154204373;902.3953950852945;907.9455232686026;912.3203213605873;646.6281887914421;659.7097277198066;662.5064327076311;662.8873091574395;666.6533402630654;14741.336639851124;14761.18813465259;14764;14770.778438323434;14777.55667329971;14245.145291282453;14293.642658933506;14442.277886105758;14566.927165364212;14613.853861461355;13227.338633068404;13343.532976345878;13352.933235333858;13441.126326788824;13746.312684365741;4539.977300113478;4595.172868883599;4615.653825963066;4714.104320179189;4719.693219940693;66542.66728666326;67085.32914670839;69176.6541167296;69301.30698693;70259.2974070263;11639.418029098511;11735.530578776754;11798.882011179778;11857.466414011391;12059.577914773115;21576.676349854766;21762.238321658984;21805.781942180693;21957.341279761633;21979.890100549394;8194.877076843852;8273.46222495536;8287.212714792086;8357.665693372197;8483.151684831468;4585.679002469795;4626.861194164113;4730.574248317599;4736.218523943579;4806;3452.7928324300624;3541.1855273287288;3545.096000519851;3546.858125674944;3547.095490649919;611.6941529235382;633.0409429713987;633.0630666613438;633.2179757998867;633.7053270229366;707.4976766495743;717.5049216040915;722.6278466589711;733.7688628082137;757.3032809814983;8443.831123377498;8483.74548763538;8732.388732788771;8768.956155219183;8833.469991800512;667.5827607745159;690.5787469643514;690.5821977703517;708.3553965891015;727.4943913979733;4237.343211802176;4290.570942905747;4325.502567204811;4377.737335759864;4396.120775844844;82719.58640206761;88139;90447.54776226077;91463;91943;62600;64705;78012.21987780163;82739;83260.58369708112;43062.569374306484;51530.48469515332;65022.67488662527;66792.33207667958;67927.98108028383;9831.262655301025;9887.357321774349;9914.40513569188;9998.800023999625;10365.429901355497;45495.77252113718;45593;47046.294305586125;47527.28709069436;47914;59153;60008.69995650168;63286.68356658187;63874.041889372624;64284;13205.141665791693;13245.403956821774;13338.799918001432;13358;13447.663808404868;14061.156330620195;14192.716145677236;14340.282985850457;14943.775843362575;15107.773383399039;14158.716825663223;14449.566513004627;14789.334479948644;14894;14993.2503374833;13068.411921463747;13682.31588420595;13824.654383640489;13911.165330080228;14081.788773168206;13438.731225375634;13507.459701611826;13944.790828137384;14008.369623366769;14437.494687685881;10815.45922703846;10878.619248326271;11150.776984460428;11854.170208085352;12187.451564679433;11936.4031798408;12060.577879774166;12092.818607720716;12234.510619575118;12496.500139994298 09:08:44 INFO - PROCESS | 13990 | __end_tp_report 09:08:44 INFO - PROCESS | 13990 | __start_cc_report 09:08:44 INFO - PROCESS | 13990 | _x_x_mozilla_cycle_collect,1335 09:08:44 INFO - PROCESS | 13990 | __end_cc_report 09:08:44 INFO - PROCESS | 13990 | __startTimestamp1479229724687__endTimestamp 09:08:44 INFO - PROCESS | 13990 | 09:08:44 INFO - PROCESS | 13990 | ------- Summary: start ------- 09:08:44 INFO - PROCESS | 13990 | Number of tests: 6 09:08:44 INFO - PROCESS | 13990 | 09:08:44 INFO - PROCESS | 13990 | [#0] dojo.html Cycles:165 Average:5533.03 Median:5725.28 stddev:630.64 (11.0%) stddev-sans-first:605.08 09:08:44 INFO - PROCESS | 13990 | Values: 3185.1 3233.2 3233.7 3251.8 3262.1 5469.8 5548.4 5555.6 5573.1 5584.4 5581.3 5608.3 5613.0 5615.1 5621.3 5063.7 5078.2 5107.4 5121.6 5174.0 4967.8 4994.6 5107.7 5155.4 5159.0 4947.0 4983.3 5020.1 5022.1 5024.2 5022.3 5081.8 5088.4 5092.7 5115.9 4860.3 4990.3 5001.7 5024.9 5054.9 5414.0 5469.5 5519.9 5540.9 5558.3 5991.1 6022.5 6022.8 6024.7 6028.2 5864.7 6042.3 6048.3 6054.9 6072.1 5514.4 5572.9 5607.0 5615.1 5675.8 6127.6 6162.0 6172.8 6173.6 6174.4 5908.2 5910.3 5920.7 5929.0 5935.1 5722.8 5827.0 5901.8 5940.3 5969.6 5988.7 5999.6 6002.7 6004.2 6039.1 5998.9 6000.8 6007.8 6008.7 6030.5 4421.9 4516.6 4523.7 4603.8 4606.5 4056.5 4076.9 4079.8 4105.9 4122.5 5617.8 5679.6 5679.7 5681.4 5711.5 5756.7 5790.3 5980.1 5982.6 5990.3 5582.6 5596.7 5641.6 5671.9 5713.9 5108.5 5109.8 5111.7 5128.2 5137.6 6154.4 6171.1 6174.5 6221.1 6222.1 5776.1 5846.4 5895.4 5915.1 5928.9 6116.4 6125.8 6130.0 6137.5 6164.6 5765.2 5793.4 5831.7 5832.5 5836.5 5848.1 5854.2 5891.9 5921.4 5928.9 5809.3 5888.2 5889.2 5912.5 5920.1 5873.0 5878.4 5879.4 5882.1 5884.4 5601.4 5643.7 5797.8 5805.3 5811.5 5738.5 5738.6 5772.6 5792.7 5875.8 5698.1 5712.7 5718.4 5719.7 5725.3 09:08:44 INFO - PROCESS | 13990 | 09:08:44 INFO - PROCESS | 13990 | [#1] ext.html Cycles:180 Average:53159.93 Median:43543.56 stddev:89883.05 (206.4%) stddev-sans-first:90048.50 09:08:44 INFO - PROCESS | 13990 | Values: 582.1 613.2 645.6 653.3 657.4 33268.3 44578.3 44912.0 44913.0 44934.6 47396.1 47835.0 47857.3 47870.0 47900.0 8952.6 9076.2 9079.0 9086.4 9086.8 8893.7 8988.5 8995.0 9001.9 9003.9 8991.1 9036.4 9038.8 9043.8 9053.7 8931.2 8951.1 8984.6 8994.4 8995.2 8713.4 8799.1 8810.0 8813.3 8815.6 43319.4 43503.0 43773.8 43837.8 43919.0 3405.5 3655.5 4172.2 4179.5 4200.5 33330.0 33421.8 33542.2 33599.2 33717.8 4425.1 4488.2 4567.1 4582.6 4589.6 332912.0 333800.0 334087.0 334218.0 334497.0 63484.7 63991.7 64050.4 64058.4 64172.4 40557.6 67219.0 67220.7 67440.3 67458.3 17644.0 18755.8 18756.8 18773.9 18817.3 14102.2 14111.3 14142.9 14143.6 14151.6 20443.9 20713.3 20812.3 20864.8 20924.8 7280.5 7328.3 7511.4 7563.9 7699.2 966.8 1056.9 1062.8 1086.0 1089.5 32562.3 32726.3 32834.8 32981.7 33063.8 961.4 1109.5 1125.2 1138.4 1170.0 16397.4 17093.3 17182.8 17279.0 17279.6 253749.0 255795.0 256056.0 256060.0 256234.0 61713.0 62636.7 62670.7 62671.4 62698.7 1231.6 1272.7 1376.4 1397.6 1459.6 29484.9 33394.7 34192.0 34495.6 34945.3 53153.7 54225.7 54328.5 54334.5 54367.2 417984.0 418188.0 419124.0 419412.0 420296.0 30336.2 30896.2 31015.7 31025.2 31107.8 50153.0 50912.2 50983.8 51029.7 51396.7 41570.4 43145.0 43895.6 44816.0 45524.5 42171.2 42478.0 42499.4 43584.1 43896.1 41971.4 42659.8 42904.6 46296.3 46647.8 41959.8 46285.8 46641.5 47013.5 47829.8 33256.8 35431.5 35808.3 35907.3 35929.6 09:08:44 INFO - PROCESS | 13990 | 09:08:44 INFO - PROCESS | 13990 | [#2] jquery.html Cycles:180 Average:28185.31 Median:12707.69 stddev:73799.18 (580.7%) stddev-sans-first:73976.70 09:08:44 INFO - PROCESS | 13990 | Values: 390.9 399.0 422.4 423.3 434.7 15912.8 19229.8 19518.1 19673.9 19689.1 19554.7 19690.4 19886.6 20079.2 20163.3 4728.6 5674.3 5815.4 5861.8 5902.8 5769.7 5856.4 5867.1 5870.0 5870.2 5780.7 5836.7 6058.8 6063.3 6146.8 5899.5 6078.4 6107.2 6121.5 6122.0 5814.7 5882.0 5884.6 5896.0 5896.6 15985.0 23089.0 23411.8 23945.2 24075.9 2326.4 2349.3 2414.3 2656.7 2753.2 11148.3 11405.4 11732.1 15711.8 15831.7 2028.4 2053.8 2066.9 2103.1 2115.4 67954.3 70981.6 74457.3 81911.6 87000.6 11365.7 11460.5 11642.5 11675.4 12050.5 16612.8 16623.6 16625.4 16651.0 16653.8 8546.1 8649.1 8694.2 8700.8 8865.7 8246.9 8325.7 8478.4 8510.6 8551.7 5022.4 5071.1 5089.2 5118.7 5166.8 2124.9 2132.3 2134.9 2151.8 2182.7 809.6 914.5 927.0 993.4 1064.7 19370.0 19909.7 20222.3 21523.9 21809.8 1022.9 1047.9 1062.6 1096.5 1118.1 10352.5 11180.8 11181.7 11249.2 11337.9 388139.0 393990.0 396980.0 500284.0 519017.0 96546.0 104489.0 108952.0 109575.0 109859.5 1052.2 1067.4 1092.3 1105.4 1107.1 13828.7 16725.2 17351.6 17404.9 18699.9 44486.0 44997.9 45257.8 45640.5 46660.0 56192.2 61317.1 65278.0 65643.7 66089.3 8156.8 8550.1 8721.3 8769.7 8800.6 10621.9 12326.7 12371.9 12526.6 12581.2 10697.7 10720.9 10949.7 11041.6 11042.9 10549.5 10579.1 10681.8 10886.1 10948.7 10255.3 10715.7 10717.2 10843.2 11087.1 8059.3 8616.0 8665.2 8671.3 8767.5 8589.5 10479.7 10667.8 10829.0 10935.9 09:08:44 INFO - PROCESS | 13990 | 09:08:44 INFO - PROCESS | 13990 | [#3] mootools.html Cycles:180 Average:5913.44 Median:4853.13 stddev:3308.72 (68.2%) stddev-sans-first:3301.56 09:08:44 INFO - PROCESS | 13990 | Values: 1525.4 1568.1 1720.3 1834.6 1865.1 8452.5 8955.2 8960.8 8973.1 8980.1 7769.5 7989.5 8390.8 8619.9 8833.9 2480.5 2508.8 2511.0 2520.7 2523.4 2462.3 2535.0 2535.3 2539.9 2539.9 2439.1 2449.8 2485.7 2488.7 2502.2 2377.5 2382.2 2398.5 2409.7 2414.3 2414.8 2414.9 2426.4 2447.6 2448.0 8369.4 8440.5 8587.4 8592.8 8598.8 5318.5 5456.6 5461.5 5466.2 5469.0 3496.7 3522.9 3558.1 3604.7 3605.8 1121.8 1131.8 1169.0 1175.2 1233.5 12629.9 12644.3 12655.2 12676.8 12679.1 4605.4 4715.3 4768.2 4789.1 4917.1 10536.3 10542.7 10545.3 10567.4 10569.4 5457.0 5484.8 5489.8 5496.4 5500.4 4341.3 4539.3 4949.9 4972.9 5005.7 4078.8 4107.1 4164.3 4198.4 4201.7 1352.0 1360.2 1361.5 1364.2 1380.2 811.4 869.9 943.5 1002.8 1021.5 5829.5 5897.3 5905.7 6010.9 6013.4 929.9 954.1 958.6 974.2 980.3 4139.8 4235.8 4241.2 4267.8 4296.2 10779.0 11117.6 11163.4 11201.7 11252.7 10773.8 10898.2 11121.3 11140.3 11147.5 8409.3 8546.2 8550.6 8552.7 8558.5 5705.7 5882.1 5882.8 5892.6 6036.7 9898.1 9963.7 10066.7 10127.1 10159.7 10400.3 10464.7 10521.7 10559.0 10573.9 7402.7 7587.3 7667.5 7674.9 7709.8 8400.1 8530.7 8621.6 8643.7 8921.4 7404.3 8005.4 8161.1 8248.1 8402.7 7881.4 7899.2 7984.4 8027.4 8033.8 6997.1 7026.8 7086.3 7087.9 7156.1 5276.6 5282.6 5316.0 5340.7 5346.7 5437.8 5484.3 5495.1 5543.0 5580.1 09:08:44 INFO - PROCESS | 13990 | 09:08:44 INFO - PROCESS | 13990 | [#4] prototype.html Cycles:180 Average:4712.14 Median:5269.53 stddev:1341.44 (25.5%) stddev-sans-first:1304.46 09:08:44 INFO - PROCESS | 13990 | Values: 340.8 353.2 354.1 360.5 362.0 5195.1 5345.4 5385.2 5407.3 5429.5 5222.0 5304.7 5356.5 5366.0 5374.3 4210.9 4214.6 4270.2 4271.3 4279.4 4144.7 4240.4 4244.3 4271.7 4280.2 4236.4 4241.8 4249.1 4249.3 4253.8 4222.7 4230.7 4238.0 4250.4 4262.6 3715.2 3825.1 3827.5 3837.0 3850.6 5233.9 5249.0 5259.7 5260.2 5269.4 4860.2 4888.4 4899.3 4899.7 4938.2 5431.2 5580.8 5598.7 5637.2 5662.0 4180.9 4183.3 4191.8 4195.6 4196.6 5809.7 5817.7 5837.8 5848.9 5854.4 4187.3 4280.3 4281.6 4305.5 4324.3 4338.8 4371.3 4376.9 4380.2 4383.2 4862.3 4865.6 4895.9 4896.4 4923.0 5476.5 5580.4 5653.7 5662.6 5711.9 1372.0 1390.4 1432.0 1469.6 1477.2 987.6 1016.2 1019.5 1020.4 1039.1 5237.1 5247.6 5254.2 5257.6 5269.6 5494.9 5499.6 5517.2 5530.2 5574.5 5096.4 5166.4 5178.7 5190.6 5250.6 2927.9 2956.3 2957.9 2958.6 2999.6 5795.6 5821.5 5825.9 5826.6 5839.8 5324.5 5568.0 5624.8 5636.7 5659.6 5670.9 5709.3 5726.0 5731.6 5748.2 5235.9 5495.9 5533.5 5560.0 5569.9 5417.5 5420.6 5435.3 5446.7 5464.7 5696.5 5697.8 5717.4 5718.5 5718.8 3929.6 4139.8 4150.4 4163.5 4173.8 5525.3 5634.9 5720.5 5729.3 5734.3 5508.9 5520.3 5536.4 5549.5 5558.7 5621.4 5649.0 5653.8 5661.2 5721.4 5373.8 5573.2 5576.4 5610.8 5615.0 5688.7 5699.2 5723.7 5736.5 5738.1 5466.2 5604.3 5615.4 5616.9 5620.4 09:08:44 INFO - PROCESS | 13990 | 09:08:44 INFO - PROCESS | 13990 | [#5] yui.html Cycles:180 Average:18044.59 Median:4716.90 stddev:23238.65 (492.7%) stddev-sans-first:23267.30 09:08:44 INFO - PROCESS | 13990 | Values: 689.7 703.8 706.6 830.8 880.9 14362.6 15661.4 15736.7 15742.3 15753.9 13247.8 13895.7 13987.9 14013.6 14062.4 711.5 732.9 857.2 862.5 862.9 833.6 856.7 864.2 865.8 866.5 904.4 904.7 905.0 905.0 912.2 749.6 768.5 902.4 907.9 912.3 646.6 659.7 662.5 662.9 666.7 14741.3 14761.2 14764.0 14770.8 14777.6 14245.1 14293.6 14442.3 14566.9 14613.9 13227.3 13343.5 13352.9 13441.1 13746.3 4540.0 4595.2 4615.7 4714.1 4719.7 66542.7 67085.3 69176.7 69301.3 70259.3 11639.4 11735.5 11798.9 11857.5 12059.6 21576.7 21762.2 21805.8 21957.3 21979.9 8194.9 8273.5 8287.2 8357.7 8483.2 4585.7 4626.9 4730.6 4736.2 4806.0 3452.8 3541.2 3545.1 3546.9 3547.1 611.7 633.0 633.1 633.2 633.7 707.5 717.5 722.6 733.8 757.3 8443.8 8483.7 8732.4 8769.0 8833.5 667.6 690.6 690.6 708.4 727.5 4237.3 4290.6 4325.5 4377.7 4396.1 82719.6 88139.0 90447.5 91463.0 91943.0 62600.0 64705.0 78012.2 82739.0 83260.6 43062.6 51530.5 65022.7 66792.3 67928.0 9831.3 9887.4 9914.4 9998.8 10365.4 45495.8 45593.0 47046.3 47527.3 47914.0 59153.0 60008.7 63286.7 63874.0 64284.0 13205.1 13245.4 13338.8 13358.0 13447.7 14061.2 14192.7 14340.3 14943.8 15107.8 14158.7 14449.6 14789.3 14894.0 14993.3 13068.4 13682.3 13824.7 13911.2 14081.8 13438.7 13507.5 13944.8 14008.4 14437.5 10815.5 10878.6 11150.8 11854.2 12187.5 11936.4 12060.6 12092.8 12234.5 12496.5 09:08:44 INFO - PROCESS | 13990 | -------- Summary: end -------- 09:08:44 INFO - PROCESS | 13990 | 09:08:45 INFO - TEST-INFO | 13990: exit 0 09:08:45 INFO - TEST-OK | dromaeo_css | took 1115512ms 09:08:45 INFO - TEST-START | kraken 09:08:45 INFO - operating with platform_type : linux_ 09:08:45 INFO - Initialising browser for kraken test... 09:08:45 INFO - TEST-INFO | started process 14312 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptE9tC8/profile http://localhost:46476/getInfo.html) 09:08:48 ERROR - PROCESS | 14312 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 09:08:49 INFO - PROCESS | 14312 | __metrics Screen width/height:1600/1200 09:08:49 INFO - PROCESS | 14312 | colorDepth:24 09:08:49 INFO - PROCESS | 14312 | Browser inner width/height: 1024/697 09:08:49 INFO - PROCESS | 14312 | __metrics 09:08:50 INFO - PROCESS | 14312 | 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:08:50 INFO - PROCESS | 14312 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:08:50 INFO - PROCESS | 14312 | console.error: PushService: 09:08:50 INFO - PROCESS | 14312 | stateChangeProcessEnqueue: Error transitioning state 09:08:50 INFO - PROCESS | 14312 | UnknownError 09:08:51 INFO - TEST-INFO | 14312: exit 0 09:08:51 INFO - Browser initialized. 09:08:51 INFO - Running cycle 1/1 for kraken test... 09:08:51 INFO - TEST-INFO | started process 14408 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptE9tC8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:09:03 INFO - PROCESS | 14408 | RSS: Main: 144818176 09:09:03 INFO - PROCESS | 14408 | 09:09:05 INFO - PROCESS | 14408 | Cycle 1(1): loaded http://localhost:46476/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46476/tests/kraken/driver.html?testName=audio-beat-detection) 09:09:06 INFO - PROCESS | 14408 | RSS: Main: 185733120 09:09:06 INFO - PROCESS | 14408 | 09:09:09 INFO - PROCESS | 14408 | Cycle 1(1): loaded http://localhost:46476/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46476/tests/kraken/driver.html?testName=audio-dft) 09:09:09 INFO - PROCESS | 14408 | RSS: Main: 174977024 09:09:09 INFO - PROCESS | 14408 | 09:09:12 INFO - PROCESS | 14408 | Cycle 1(1): loaded http://localhost:46476/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46476/tests/kraken/driver.html?testName=audio-fft) 09:09:13 INFO - PROCESS | 14408 | RSS: Main: 266887168 09:09:13 INFO - PROCESS | 14408 | 09:09:15 INFO - PROCESS | 14408 | Cycle 1(1): loaded http://localhost:46476/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46476/tests/kraken/driver.html?testName=audio-oscillator) 09:09:15 INFO - PROCESS | 14408 | RSS: Main: 173023232 09:09:15 INFO - PROCESS | 14408 | 09:09:17 INFO - PROCESS | 14408 | Cycle 1(1): loaded http://localhost:46476/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46476/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:09:18 INFO - PROCESS | 14408 | RSS: Main: 175169536 09:09:18 INFO - PROCESS | 14408 | 09:09:21 INFO - PROCESS | 14408 | Cycle 1(1): loaded http://localhost:46476/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46476/tests/kraken/driver.html?testName=imaging-darkroom) 09:09:21 INFO - PROCESS | 14408 | RSS: Main: 213794816 09:09:21 INFO - PROCESS | 14408 | 09:09:25 INFO - PROCESS | 14408 | Cycle 1(1): loaded http://localhost:46476/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46476/tests/kraken/driver.html?testName=imaging-desaturate) 09:09:25 INFO - PROCESS | 14408 | RSS: Main: 212889600 09:09:25 INFO - PROCESS | 14408 | 09:09:28 INFO - PROCESS | 14408 | Cycle 1(1): loaded http://localhost:46476/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46476/tests/kraken/driver.html?testName=json-parse-financial) 09:09:29 INFO - PROCESS | 14408 | RSS: Main: 211181568 09:09:29 INFO - PROCESS | 14408 | 09:09:30 INFO - PROCESS | 14408 | Cycle 1(1): loaded http://localhost:46476/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46476/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:09:31 INFO - PROCESS | 14408 | RSS: Main: 173731840 09:09:31 INFO - PROCESS | 14408 | 09:09:32 INFO - PROCESS | 14408 | Cycle 1(1): loaded http://localhost:46476/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46476/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:09:33 INFO - PROCESS | 14408 | RSS: Main: 180604928 09:09:33 INFO - PROCESS | 14408 | 09:09:35 INFO - PROCESS | 14408 | Cycle 1(1): loaded http://localhost:46476/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46476/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:09:36 INFO - PROCESS | 14408 | RSS: Main: 190246912 09:09:36 INFO - PROCESS | 14408 | 09:09:38 INFO - PROCESS | 14408 | Cycle 1(1): loaded http://localhost:46476/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46476/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:09:39 INFO - PROCESS | 14408 | RSS: Main: 199090176 09:09:39 INFO - PROCESS | 14408 | 09:09:42 INFO - PROCESS | 14408 | Cycle 1(1): loaded http://localhost:46476/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46476/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:09:42 INFO - PROCESS | 14408 | RSS: Main: 195076096 09:09:42 INFO - PROCESS | 14408 | 09:09:44 INFO - PROCESS | 14408 | Cycle 1(1): loaded http://localhost:46476/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46476/tests/kraken/driver.html?testName=ai-astar) 09:09:44 INFO - PROCESS | 14408 | RSS: Main: 245841920 09:09:44 INFO - PROCESS | 14408 | 09:09:44 INFO - PROCESS | 14408 | __start_tp_report 09:09:44 INFO - PROCESS | 14408 | _x_x_mozilla_page_load 09:09:44 INFO - PROCESS | 14408 | _x_x_mozilla_page_load_details 09:09:44 INFO - PROCESS | 14408 | |i|pagename|runs| 09:09:44 INFO - PROCESS | 14408 | |0;ai-astar;109;111;111;110;111;110;110;109;111;111 09:09:44 INFO - PROCESS | 14408 | |1;audio-beat-detection;147;120;126;161;129;123;123;123;156;126 09:09:44 INFO - PROCESS | 14408 | |2;audio-dft;160;160;160;160;162;160;159;161;160;160 09:09:44 INFO - PROCESS | 14408 | |3;audio-fft;74;75;75;107;75;76;76;75;101;76 09:09:44 INFO - PROCESS | 14408 | |4;audio-oscillator;81;82;121;81;81;81;97;81;80;105 09:09:44 INFO - PROCESS | 14408 | |5;imaging-gaussian-blur;117;117;116;117;117;117;116;117;117;117 09:09:44 INFO - PROCESS | 14408 | |6;imaging-darkroom;145;145;145;145;145;146;148;146;147;146 09:09:44 INFO - PROCESS | 14408 | |7;imaging-desaturate;85;85;85;85;85;85;84;85;84;86 09:09:44 INFO - PROCESS | 14408 | |8;json-parse-financial;52;50;50;51;50;50;50;50;50;50 09:09:44 INFO - PROCESS | 14408 | |9;json-stringify-tinderbox;60;59;61;59;60;60;59;63;60;59 09:09:44 INFO - PROCESS | 14408 | |10;stanford-crypto-aes;83;74;82;75;75;80;75;77;74;75 09:09:44 INFO - PROCESS | 14408 | |11;stanford-crypto-ccm;137;125;129;123;134;137;124;136;175;133 09:09:44 INFO - PROCESS | 14408 | |12;stanford-crypto-pbkdf2;159;156;155;153;154;156;154;162;151;154 09:09:44 INFO - PROCESS | 14408 | |13;stanford-crypto-sha256-iterative;67;61;64;62;62;61;61;62;60;60 09:09:44 INFO - PROCESS | 14408 | __end_tp_report 09:09:44 INFO - PROCESS | 14408 | __start_cc_report 09:09:44 INFO - PROCESS | 14408 | _x_x_mozilla_cycle_collect,1615 09:09:44 INFO - PROCESS | 14408 | __end_cc_report 09:09:44 INFO - PROCESS | 14408 | __startTimestamp1479229784677__endTimestamp 09:09:44 INFO - PROCESS | 14408 | 09:09:44 INFO - PROCESS | 14408 | ------- Summary: start ------- 09:09:44 INFO - PROCESS | 14408 | Number of tests: 14 09:09:44 INFO - PROCESS | 14408 | 09:09:44 INFO - PROCESS | 14408 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:0.82 (0.7%) stddev-sans-first:0.73 09:09:44 INFO - PROCESS | 14408 | Values: 109.0 111.0 111.0 110.0 111.0 110.0 110.0 109.0 111.0 111.0 09:09:44 INFO - PROCESS | 14408 | 09:09:44 INFO - PROCESS | 14408 | [#1] audio-beat-detection Cycles:10 Average:133.40 Median:127.50 stddev:15.24 (12.0%) stddev-sans-first:15.35 09:09:44 INFO - PROCESS | 14408 | Values: 147.0 120.0 126.0 161.0 129.0 123.0 123.0 123.0 156.0 126.0 09:09:44 INFO - PROCESS | 14408 | 09:09:44 INFO - PROCESS | 14408 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 09:09:44 INFO - PROCESS | 14408 | Values: 160.0 160.0 160.0 160.0 162.0 160.0 159.0 161.0 160.0 160.0 09:09:44 INFO - PROCESS | 14408 | 09:09:44 INFO - PROCESS | 14408 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.00 stddev:12.22 (16.3%) stddev-sans-first:12.70 09:09:44 INFO - PROCESS | 14408 | Values: 74.0 75.0 75.0 107.0 75.0 76.0 76.0 75.0 101.0 76.0 09:09:44 INFO - PROCESS | 14408 | 09:09:44 INFO - PROCESS | 14408 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:81.00 stddev:14.12 (17.4%) stddev-sans-first:14.68 09:09:44 INFO - PROCESS | 14408 | Values: 81.0 82.0 121.0 81.0 81.0 81.0 97.0 81.0 80.0 105.0 09:09:44 INFO - PROCESS | 14408 | 09:09:44 INFO - PROCESS | 14408 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:09:44 INFO - PROCESS | 14408 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 09:09:44 INFO - PROCESS | 14408 | 09:09:44 INFO - PROCESS | 14408 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:1.03 (0.7%) stddev-sans-first:1.05 09:09:44 INFO - PROCESS | 14408 | Values: 145.0 145.0 145.0 145.0 145.0 146.0 148.0 146.0 147.0 146.0 09:09:44 INFO - PROCESS | 14408 | 09:09:44 INFO - PROCESS | 14408 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 09:09:44 INFO - PROCESS | 14408 | Values: 85.0 85.0 85.0 85.0 85.0 85.0 84.0 85.0 84.0 86.0 09:09:44 INFO - PROCESS | 14408 | 09:09:44 INFO - PROCESS | 14408 | [#8] json-parse-financial Cycles:10 Average:50.30 Median:50.00 stddev:0.67 (1.3%) stddev-sans-first:0.33 09:09:44 INFO - PROCESS | 14408 | Values: 52.0 50.0 50.0 51.0 50.0 50.0 50.0 50.0 50.0 50.0 09:09:44 INFO - PROCESS | 14408 | 09:09:44 INFO - PROCESS | 14408 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:1.25 (2.1%) stddev-sans-first:1.32 09:09:44 INFO - PROCESS | 14408 | Values: 60.0 59.0 61.0 59.0 60.0 60.0 59.0 63.0 60.0 59.0 09:09:44 INFO - PROCESS | 14408 | 09:09:44 INFO - PROCESS | 14408 | [#10] stanford-crypto-aes Cycles:10 Average:77.00 Median:76.00 stddev:3.40 (4.5%) stddev-sans-first:2.83 09:09:44 INFO - PROCESS | 14408 | Values: 83.0 74.0 82.0 75.0 75.0 80.0 75.0 77.0 74.0 75.0 09:09:44 INFO - PROCESS | 14408 | 09:09:44 INFO - PROCESS | 14408 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:135.00 stddev:14.96 (11.1%) stddev-sans-first:15.85 09:09:44 INFO - PROCESS | 14408 | Values: 137.0 125.0 129.0 123.0 134.0 137.0 124.0 136.0 175.0 133.0 09:09:44 INFO - PROCESS | 14408 | 09:09:44 INFO - PROCESS | 14408 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.40 Median:155.50 stddev:3.13 (2.0%) stddev-sans-first:3.04 09:09:44 INFO - PROCESS | 14408 | Values: 159.0 156.0 155.0 153.0 154.0 156.0 154.0 162.0 151.0 154.0 09:09:44 INFO - PROCESS | 14408 | 09:09:44 INFO - PROCESS | 14408 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:62.00 stddev:2.11 (3.4%) stddev-sans-first:1.24 09:09:44 INFO - PROCESS | 14408 | Values: 67.0 61.0 64.0 62.0 62.0 61.0 61.0 62.0 60.0 60.0 09:09:44 INFO - PROCESS | 14408 | -------- Summary: end -------- 09:09:44 INFO - PROCESS | 14408 | 09:09:45 INFO - TEST-INFO | 14408: exit 0 09:09:45 INFO - TEST-OK | kraken | took 60263ms 09:09:45 INFO - SUITE-END | took 1175s 09:09:45 INFO - Completed test suite (00:19:35) 09:09:45 INFO - javascript benchmark 09:09:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3185.076327864919, 3233.240188555689, 3233.692799184078, 3251.821149836758, 3262.054004338742, 5469.753861076251, 5548.44515548445, 5555.638883472571, 5573.108302671573, 5584.441555844413, 5581.302337207849, 5608.298962629671, 5613.045782217023, 5615.073512870382, 5621.269234999455, 5063.670861394007, 5078.187490001582, 5107.387113546361, 5121.564667003309, 5173.974130129344, 4967.801287948478, 4994.550490455858, 5107.719075450848, 5155.355580552431, 5159.0, 4946.9752651236695, 4983.252512123175, 5020.121478741224, 5022.146235140017, 5024.196128619422, 5022.321986531808, 5081.8475445736685, 5088.440271570162, 5092.668976516515, 5115.897682046376, 4860.295257187688, 4990.2764099205415, 5001.749912504397, 5024.874378140539, 5054.9241761373605, 5414.025475414423, 5469.480399362094, 5519.917201241985, 5540.889182216373, 5558.277423934863, 5991.101334799771, 6022.457978781887, 6022.789202377896, 6024.668643224621, 6028.246469191351, 5864.70676466175, 6042.335343112254, 6048.334683184846, 6054.909176362358, 6072.149899014142, 5514.448555144493, 5572.944270557324, 5606.97196514023, 5615.129654903497, 5675.829725108253, 6127.571070025056, 6162.044883043135, 6172.814815555541, 6173.567850250529, 6174.44430001302, 5908.20239267702, 5910.34986151523, 5920.703964801829, 5929.0217114175675, 5935.080062590306, 5722.7710891563875, 5827.0, 5901.793437229677, 5940.34656187819, 5969.641821490724, 5988.700564971734, 5999.640021598718, 6002.6698531580305, 6004.219451471281, 6039.124326972652, 5998.850028749316, 6000.759969601167, 6007.849803754941, 6008.729607167688, 6030.4572588467245, 4421.889452763642, 4516.638668906479, 4523.660725445605, 4603.769811509411, 4606.539346065367, 4056.513218413809, 4076.8916318533907, 4079.7756123413496, 4105.856295029719, 4122.484689413824, 5617.803376881871, 5679.574031947621, 5679.716014199274, 5681.403452637496, 5711.485966263056, 5756.65460072397, 5790.305163380337, 5980.132880732356, 5982.551308651869, 5990.251218597676, 5582.637128586629, 5596.748146333425, 5641.633293835887, 5671.914921276184, 5713.885722285531, 5108.540231379194, 5109.846704598794, 5111.667741596784, 5128.153854614022, 5137.614678899097, 6154.446099851035, 6171.105189747551, 6174.475169610633, 6221.06683997395, 6222.066689996536, 5776.075827867521, 5846.356900741001, 5895.351511333664, 5915.112733090071, 5928.8814223716145, 6116.449519543263, 6125.754969801336, 6129.969350153221, 6137.46891820379, 6164.568480206342, 5765.164051212634, 5793.420657934173, 5831.650100993954, 5832.533397328119, 5836.533077353886, 5848.064309710426, 5854.151148083419, 5891.911621325769, 5921.437463440966, 5928.881422371443, 5809.331926828469, 5888.234529511136, 5889.204957330706, 5912.49743771767, 5920.111983202554, 5872.970635146797, 5878.441548052928, 5879.353271140257, 5882.117682347682, 5884.411558844081, 5601.355844077983, 5643.66138031703, 5797.768089276382, 5805.332386775575, 5811.53507719373, 5738.540916726568, 5738.626989245853, 5772.624779389326, 5792.710364481674, 5875.794347197828, 5698.0598201296325, 5712.685802280915, 5718.399568045295, 5719.714014299185, 5725.2843394575675], "value": 5490.409448661191, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.1239035251945, 613.1538476901875, 645.6190847400034, 653.2520264297376, 657.3722095398895, 33268.33463330735, 44578.33132503015, 44912.0, 44913.0, 44934.5506544934, 47396.0520789584, 47835.0, 47857.282140767915, 47870.0, 47900.0, 8952.597133129026, 9076.183143517082, 9079.046700096495, 9086.409383390059, 9086.77283067922, 8893.73318800437, 8988.460692358447, 8994.955025224865, 9001.864972025425, 9003.909960900406, 8991.100889911022, 9036.36745427817, 9038.819223615525, 9043.819123617524, 9053.728388148333, 8931.151540603665, 8951.104889511029, 8984.640614375417, 8994.41536300145, 8995.235404990552, 8713.433626814236, 8799.076097009785, 8810.0, 8813.294936405073, 8815.647374105029, 43319.35020974688, 43503.0, 43773.78113109414, 43837.78081109574, 43919.0, 3405.5062016007787, 3655.4882316475714, 4172.207280616703, 4179.540250572434, 4200.516940551845, 33330.0, 33421.83289083539, 33542.1614459638, 33599.16002099943, 33717.831410843035, 4425.141031401347, 4488.214562451591, 4567.063751930847, 4582.6104781093645, 4589.613242097636, 332912.0, 333800.0, 334087.0, 334218.0, 334497.0, 63484.682576587744, 63991.680041599495, 64050.35949640444, 64058.35941640524, 64172.35827641757, 40557.59442405538, 67219.0, 67220.66389668119, 67440.32559674438, 67458.32541674521, 17644.0, 18755.812441875678, 18756.81243187578, 18773.90613046926, 18817.341393051178, 14102.224377659328, 14111.2944352784, 14142.929285353714, 14143.64640883986, 14151.575452736435, 20443.897780511, 20713.27503537369, 20812.27157049496, 20864.791352086286, 20924.790752092587, 7280.490365674458, 7328.3404493595835, 7511.3615342696485, 7563.886541701879, 7699.230076992368, 966.8259713251682, 1056.884986339404, 1062.7715041266165, 1085.9945700271448, 1089.5260561655705, 32562.348753024806, 32726.345473090405, 32834.835825821196, 32981.67018329786, 33063.84276550309, 961.3895176562933, 1109.4730003248392, 1125.1954852280658, 1138.3568283919724, 1170.023030769317, 16397.42609008703, 17093.316267349415, 17182.828171718375, 17279.0, 17279.56801079983, 253749.0, 255795.0, 256056.0, 256060.0, 256234.0, 61713.0, 62636.68681656654, 62670.68664656648, 62671.37328626656, 62698.68650656717, 1231.5504840733067, 1272.7327261275236, 1376.3737499437732, 1397.573740009307, 1459.569427019032, 29484.852575736983, 33394.666053339155, 34192.0, 34495.620175192715, 34945.30109397747, 53153.7342313286, 54225.72887135539, 54328.45671543234, 54334.45665543294, 54367.18449223344, 417984.0, 418188.0, 419124.0, 419412.0, 420296.0, 30336.241593960327, 30896.227594310323, 31015.68984310128, 31025.224369390944, 31107.844460777553, 50153.0, 50912.23631645602, 50983.81726059655, 51029.74485127551, 51396.74301628468, 41570.376444352754, 43145.0, 43895.56104438915, 44816.0, 45524.54475455335, 42171.156576867674, 42478.0, 42499.36250956176, 43584.12831743411, 43896.12207755891, 41971.37042944297, 42659.786701066296, 42904.57095429006, 46296.305555416024, 46647.76676116598, 41959.790201048796, 46285.76857115693, 46641.53358466508, 47013.52986470229, 47829.76085119552, 33256.833715831264, 35431.468527971585, 35808.28383432265, 35907.28185436329, 35929.64070359263], "value": 20686.795930595308, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.9120447899225, 399.0, 422.39597375752675, 423.30155243847645, 434.7130893610218, 15912.840871591281, 19229.84979481256, 19518.121684524194, 19673.901630491844, 19689.113989870453, 19554.70667939982, 19690.409287721355, 19886.602267954633, 20079.196832126734, 20163.2942847, 4728.645351598627, 5674.3190817102, 5815.38938411467, 5861.7948371807, 5902.76042031174, 5769.682667453289, 5856.385079566648, 5867.090600956859, 5870.0314448116005, 5870.207521984542, 5780.682062486561, 5836.737346819404, 6058.848528786772, 6063.2724073111285, 6146.815595532141, 5899.498542623882, 6078.392160783908, 6107.236595425572, 6121.510279177677, 6122.0, 5814.709264536798, 5881.9705901470215, 5884.588078834483, 5896.027155519334, 5896.64620122794, 15985.0, 23089.0, 23411.76588234113, 23945.16191933274, 24075.9165837536, 2326.3835083702834, 2349.2717257650183, 2414.3119211024773, 2656.6546348974703, 2753.2428582139873, 11148.275362101438, 11405.429728513542, 11732.072529537614, 15711.764323535157, 15831.683366332609, 2028.4117605894273, 2053.7946205379494, 2066.9379918602467, 2103.074647155247, 2115.418259978518, 67954.32045679529, 70981.64509177473, 74457.25542744558, 81911.59044204741, 87000.56499717524, 11365.715857103638, 11460.484278207501, 11642.476088576035, 11675.357855317869, 12050.457729402198, 16612.83387166113, 16623.584410389838, 16625.418110366078, 16651.0, 16653.750193747102, 8546.102659220816, 8649.1350864913, 8694.17405346491, 8700.825983480296, 8865.734027979172, 8246.917530824734, 8325.66697332112, 8478.364122690822, 8510.574471276412, 8551.657933682583, 5022.447530771612, 5071.087204303187, 5089.185730283137, 5118.667286626357, 5166.844994650167, 2124.893755312228, 2132.3496333618396, 2134.903929323184, 2151.8278537716947, 2182.701292730823, 809.5587904592012, 914.4696076275744, 926.9953650231706, 993.3940296419179, 1064.7284942339654, 19370.0, 19909.701354479694, 20222.292219772236, 21523.892380537996, 21809.781902180774, 1022.8979447236002, 1047.9476026198658, 1062.6015244283394, 1096.5339730614617, 1118.0775859915602, 10352.482375881176, 11180.776384472265, 11181.72045698864, 11249.156313276537, 11337.943310283395, 388139.0, 393990.0, 396980.0, 500284.0, 519017.0, 96546.0, 104489.0, 108952.0, 109575.0, 109859.45070274598, 1052.2003277508995, 1067.3755852826027, 1092.2736380307008, 1105.3533682795494, 1107.1364335818075, 13828.723425531232, 16725.247363868413, 17351.56621084483, 17404.912975435043, 18699.906500467412, 44486.0, 44997.875053123935, 45257.77371113123, 45640.54359456496, 46660.0, 56192.15711764245, 61317.080243795484, 65278.0, 65643.67178164079, 66089.33910661025, 8156.776483527518, 8550.05949345559, 8721.345899057469, 8769.736907892773, 8800.559972001502, 10621.884702106168, 12326.691832703895, 12371.876281237432, 12526.561570344995, 12581.182223155465, 10697.732556686145, 10720.892791071989, 10949.726256843642, 11041.613543525938, 11042.944785276022, 10549.525271362654, 10579.10077643409, 10681.786364272826, 10886.129109671048, 10948.671539853816, 10255.282130250811, 10715.678529644123, 10717.196210284104, 10843.240973131806, 11087.06192858877, 8059.314958228616, 8616.0, 8665.176808203463, 8671.34964877624, 8767.473951562926, 8589.484630922165, 10479.738006549896, 10667.839982400115, 10829.025387715143, 10935.890641093487], "value": 9435.547289571969, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1525.4050920141144, 1568.0748358468504, 1720.277483456948, 1834.5963887944665, 1865.1233920057578, 8452.492850428978, 8955.238804701592, 8960.820783584324, 8973.102689731024, 8980.101989801016, 7769.533827970312, 7989.480683755552, 8390.83218335633, 8619.91380086199, 8833.867491987608, 2480.5410998965203, 2508.799296056311, 2511.033252197908, 2520.7227205007434, 2523.3691577105724, 2462.2613216035206, 2535.024015753939, 2535.290118766748, 2539.9238022859345, 2539.9492010159784, 2439.146298795425, 2449.8162637802147, 2485.7389974052735, 2488.6515887775727, 2502.2118032819603, 2377.5482658294954, 2382.2019623426086, 2398.520295940819, 2409.6626472293806, 2414.263649586875, 2414.7826695597305, 2414.9396265093337, 2426.417659761662, 2447.645091461728, 2447.9510409791883, 8369.414141010131, 8440.451370660949, 8587.398882078258, 8592.785180370478, 8598.828023439497, 5318.468153184689, 5456.645318054314, 5461.5357694596005, 5466.207399926989, 5468.9726551367385, 3496.7377446691344, 3522.9119272018406, 3558.1460449492192, 3604.6755791978585, 3605.7836529808296, 1121.8205087186093, 1131.7736452709491, 1169.0243488504486, 1175.177375836909, 1233.4511142541573, 12629.936850315782, 12644.30456324911, 12655.240685558896, 12676.80984785229, 12679.112462127654, 4605.447346318396, 4715.269133284346, 4768.213244814567, 4789.114013907439, 4917.139500587383, 10536.262461627766, 10542.683719488428, 10545.261831671709, 10567.418791966362, 10569.418681972411, 5457.045017122067, 5484.8354549363585, 5489.835304940858, 5496.422875598085, 5500.367457742411, 4341.327094300388, 4539.296409056601, 4949.876253093701, 4972.8756781080765, 5005.674631148963, 4078.7756673382655, 4107.0553772631865, 4164.271252530795, 4198.433211516406, 4201.705880588391, 1351.9932400337934, 1360.2042804959012, 1361.455417832855, 1364.2155760437788, 1380.1718968618748, 811.3752410643772, 869.8956125265008, 943.4858002388714, 1002.7944271424341, 1021.4688362051692, 5829.475347218686, 5897.262842144732, 5905.734241959122, 6010.909836352458, 6013.428724271187, 929.9163075323254, 954.1126752120595, 958.5542722633869, 974.1670871404989, 980.3333733061587, 4139.834406623761, 4235.830566777356, 4241.151769646083, 4267.8079486423185, 4296.226679197712, 10779.0, 11117.555297787998, 11163.441827908735, 11201.66395008151, 11252.66242012741, 10773.83839242412, 10898.182636302308, 11121.27711698737, 11140.33158010522, 11147.498362573704, 8409.32725381968, 8546.188112129337, 8550.615222315011, 8552.657893684183, 8558.529280889486, 5705.686187259741, 5882.058870580858, 5882.764689412375, 5892.616979896293, 6036.698165091816, 9898.10917017472, 9963.651272205438, 10066.69799906004, 10127.139193168663, 10159.695209143738, 10400.323978941648, 10464.738381540217, 10521.684349469528, 10559.04968552834, 10573.9471302643, 7402.7409040683315, 7587.317141457295, 7667.539947603162, 7674.884876726742, 7709.768706938801, 8400.117987611213, 8530.74407767768, 8621.612027458905, 8643.654253829776, 8921.420107692978, 7404.333609975128, 8005.3995950305125, 8161.143079976517, 8248.092709802037, 8402.70590529353, 7881.369490440866, 7899.210078992055, 7984.401169912164, 8027.438079334391, 8033.799155021171, 6997.05539752127, 7026.824329391806, 7086.326798954091, 7087.929120708727, 7156.141263048467, 5276.604254680838, 5282.630215885005, 5315.973420132875, 5340.679559226459, 5346.652467589594, 5437.782488700566, 5484.314460692413, 5495.148252020943, 5543.0, 5580.107182850725], "value": 4767.027615602859, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.7938197390579, 353.2370080625848, 354.14827340246705, 360.46111063959387, 362.03698162886724, 5195.090859099652, 5345.412004679482, 5385.246065550826, 5407.296351824088, 5429.511343979037, 5222.007818514479, 5304.655197412166, 5356.54469370104, 5366.0, 5374.301340825697, 4210.936835947456, 4214.557471465498, 4270.210011147932, 4271.316589345705, 4279.40088387626, 4144.730592511492, 4240.448741663579, 4244.299690551055, 4271.679624028195, 4280.165367753274, 4236.428082208909, 4241.830326786925, 4249.08644641402, 4249.25638013348, 4253.8085786139545, 4222.662187025031, 4230.725002874803, 4237.957620423803, 4250.426192464009, 4262.616364527207, 3715.20123173519, 3825.1202223488476, 3827.5215598050245, 3837.0, 3850.634189751969, 5233.869153271161, 5248.973755131238, 5259.684418934838, 5260.185236093542, 5269.420363759983, 4860.173770458995, 4888.364512613373, 4899.314096026559, 4899.730514821684, 4938.209886418156, 5431.212474191259, 5580.804671836507, 5598.720063996784, 5637.210790489335, 5661.970845597627, 4180.916381672349, 4183.309753890604, 4191.790410479494, 4195.643370313527, 4196.607933477919, 5809.7095145242565, 5817.680027598481, 5837.795677151322, 5848.912266316009, 5854.443827836349, 4187.330027195695, 4280.315149576115, 4281.614654681093, 4305.48334199898, 4324.286492728727, 4338.783060846945, 4371.295194874002, 4376.934345984812, 4380.189664912002, 4383.16719823239, 4862.270659401047, 4865.5864251539015, 4895.853124406273, 4896.363472748591, 4922.950770492249, 5476.479734425223, 5580.414056524088, 5653.660780353192, 5662.603617746719, 5711.857203569861, 1371.9862801372058, 1390.4021270853427, 1431.957041288763, 1469.6472846516758, 1477.1949287638263, 987.6148302162162, 1016.2124353625999, 1019.4596863662271, 1020.4438580973388, 1039.1167507618463, 5237.062286953776, 5247.632665713363, 5254.238135470336, 5257.580453277594, 5269.631125821155, 5494.945050549523, 5499.642523235977, 5517.227588137664, 5530.170474428868, 5574.498295153375, 5096.431101399801, 5166.354205724285, 5178.741062946838, 5190.584753219733, 5250.632455728139, 2927.9414411712073, 2956.2705817096808, 2957.896473623413, 2958.556216567532, 2999.580058791771, 5795.565332600072, 5821.505172060422, 5825.88348233033, 5826.621269617462, 5839.824805255849, 5324.520793128637, 5567.993283626877, 5624.803131890364, 5636.746346414421, 5659.603827732019, 5670.943290567042, 5709.314882214077, 5725.971370143206, 5731.595759038979, 5748.223989761329, 5235.869103272448, 5495.917561236504, 5533.501984821385, 5560.026995275892, 5569.880866714653, 5417.485338892799, 5420.566354691537, 5435.293411856592, 5446.700431476307, 5464.726763661881, 5696.515796157208, 5697.800576979786, 5717.3996730342715, 5718.542516598579, 5718.828435146952, 3929.587393323774, 4139.772312522719, 4150.377443383517, 4163.521195062606, 4173.770442625685, 5525.254090697705, 5634.88730225385, 5720.48515633595, 5729.341125770589, 5734.340550836707, 5508.862278443071, 5520.254765606592, 5536.390996990408, 5549.472800083986, 5558.666480011212, 5621.409751975983, 5648.971755141198, 5653.830385088454, 5661.197707134995, 5721.370649228665, 5373.785048598169, 5573.1918871762555, 5576.358718747234, 5610.775568977195, 5615.0, 5688.715564221855, 5699.173619825185, 5723.656580605177, 5736.504620489934, 5738.053221218619, 5466.234727138124, 5604.271444712162, 5615.388844187472, 5616.85957851057, 5620.409856965123], "value": 4291.160501942331, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.6999805084788, 703.7994171661074, 706.6290197646232, 830.8296799156174, 880.8766772651829, 14362.640933976656, 15661.373545058212, 15736.685266294668, 15742.29159687814, 15753.92123039386, 13247.801282980763, 13895.722085558284, 13987.860121398782, 14013.579592612212, 14062.367193476293, 711.5375006245955, 732.9377002954728, 857.2199298638225, 862.4782006885838, 862.9395942284043, 833.62903507939, 856.7472595584318, 864.2265172670457, 865.8051938313891, 866.5147517390282, 904.4302089683523, 904.7421484876811, 904.9547522623875, 904.9999750275949, 912.1608120529096, 749.5727435361846, 768.5235154204373, 902.3953950852945, 907.9455232686026, 912.3203213605873, 646.6281887914421, 659.7097277198066, 662.5064327076311, 662.8873091574395, 666.6533402630654, 14741.336639851124, 14761.18813465259, 14764.0, 14770.778438323434, 14777.55667329971, 14245.145291282453, 14293.642658933506, 14442.277886105758, 14566.927165364212, 14613.853861461355, 13227.338633068404, 13343.532976345878, 13352.933235333858, 13441.126326788824, 13746.312684365741, 4539.977300113478, 4595.172868883599, 4615.653825963066, 4714.104320179189, 4719.693219940693, 66542.66728666326, 67085.32914670839, 69176.6541167296, 69301.30698693, 70259.2974070263, 11639.418029098511, 11735.530578776754, 11798.882011179778, 11857.466414011391, 12059.577914773115, 21576.676349854766, 21762.238321658984, 21805.781942180693, 21957.341279761633, 21979.890100549394, 8194.877076843852, 8273.46222495536, 8287.212714792086, 8357.665693372197, 8483.151684831468, 4585.679002469795, 4626.861194164113, 4730.574248317599, 4736.218523943579, 4806.0, 3452.7928324300624, 3541.1855273287288, 3545.096000519851, 3546.858125674944, 3547.095490649919, 611.6941529235382, 633.0409429713987, 633.0630666613438, 633.2179757998867, 633.7053270229366, 707.4976766495743, 717.5049216040915, 722.6278466589711, 733.7688628082137, 757.3032809814983, 8443.831123377498, 8483.74548763538, 8732.388732788771, 8768.956155219183, 8833.469991800512, 667.5827607745159, 690.5787469643514, 690.5821977703517, 708.3553965891015, 727.4943913979733, 4237.343211802176, 4290.570942905747, 4325.502567204811, 4377.737335759864, 4396.120775844844, 82719.58640206761, 88139.0, 90447.54776226077, 91463.0, 91943.0, 62600.0, 64705.0, 78012.21987780163, 82739.0, 83260.58369708112, 43062.569374306484, 51530.48469515332, 65022.67488662527, 66792.33207667958, 67927.98108028383, 9831.262655301025, 9887.357321774349, 9914.40513569188, 9998.800023999625, 10365.429901355497, 45495.77252113718, 45593.0, 47046.294305586125, 47527.28709069436, 47914.0, 59153.0, 60008.69995650168, 63286.68356658187, 63874.041889372624, 64284.0, 13205.141665791693, 13245.403956821774, 13338.799918001432, 13358.0, 13447.663808404868, 14061.156330620195, 14192.716145677236, 14340.282985850457, 14943.775843362575, 15107.773383399039, 14158.716825663223, 14449.566513004627, 14789.334479948644, 14894.0, 14993.2503374833, 13068.411921463747, 13682.31588420595, 13824.654383640489, 13911.165330080228, 14081.788773168206, 13438.731225375634, 13507.459701611826, 13944.790828137384, 14008.369623366769, 14437.494687685881, 10815.45922703846, 10878.619248326271, 11150.776984460428, 11854.170208085352, 12187.451564679433, 11936.4031798408, 12060.577879774166, 12092.818607720716, 12234.510619575118, 12496.500139994298], "value": 7390.25907370179, "unit": "score"}], "name": "dromaeo_css", "value": 7383.550281691199, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 111.0, 110.0, 111.0, 110.0, 110.0, 109.0, 111.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 120.0, 126.0, 161.0, 129.0, 123.0, 123.0, 123.0, 156.0, 126.0], "value": 133.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 160.0, 162.0, 160.0, 159.0, 161.0, 160.0, 160.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 107.0, 75.0, 76.0, 76.0, 75.0, 101.0, 76.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 121.0, 81.0, 81.0, 81.0, 97.0, 81.0, 80.0, 105.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 148.0, 146.0, 147.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0, 85.0, 84.0, 86.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 50.0, 51.0, 50.0, 50.0, 50.0, 50.0, 50.0, 50.0], "value": 50.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 61.0, 59.0, 60.0, 60.0, 59.0, 63.0, 60.0, 59.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 74.0, 82.0, 75.0, 75.0, 80.0, 75.0, 77.0, 74.0, 75.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 125.0, 129.0, 123.0, 134.0, 137.0, 124.0, 136.0, 175.0, 133.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 156.0, 155.0, 153.0, 154.0, 156.0, 154.0, 162.0, 151.0, 154.0], "value": 155.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 61.0, 64.0, 62.0, 62.0, 61.0, 61.0, 62.0, 60.0, 60.0], "value": 62.0, "unit": "score"}], "name": "kraken", "value": 1461.3999999999999, "alertThreshold": 2.0}]} 09:09:45 INFO - Return code: 0 09:09:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:09:46 ERROR - # TBPL SUCCESS # 09:09:46 INFO - Running post-action listener: _resource_record_post_action 09:09:46 INFO - [mozharness: 2016-11-15 17:09:46.006777Z] Finished run-tests step (success) 09:09:46 INFO - Running post-run listener: _resource_record_post_run 09:09:46 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 270336; Write bytes: 354447360; Read time: 388; Write time: 259436 09:09:46 INFO - TinderboxPrint: CPU usage
13.0% 09:09:46 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 388 09:09:46 INFO - TinderboxPrint: I/O write bytes / time
354,447,360 / 259,436 09:09:46 INFO - TinderboxPrint: CPU idle
8,276.1 (87.0%) 09:09:46 INFO - TinderboxPrint: CPU user
1,190.9 (12.5%) 09:09:46 INFO - TinderboxPrint: Swap in / out
0 / 0 09:09:46 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 107270144; Read time: 216; Write time: 83824 09:09:46 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 266240; Write bytes: 247177216; Read time: 172; Write time: 175612 09:09:46 INFO - Running post-run listener: _upload_blobber_files 09:09:46 INFO - Blob upload gear active. 09:09:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:09:46 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 09:09:46 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'] 09:09:46 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 09:09:47 INFO - (blobuploader) - INFO - Open directory for files ... 09:09:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:09:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:09:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:47 INFO - (blobuploader) - INFO - Done attempting. 09:09:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:09:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:09:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:48 INFO - (blobuploader) - INFO - Done attempting. 09:09:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:09:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:09:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:52 INFO - (blobuploader) - INFO - Done attempting. 09:09:52 INFO - (blobuploader) - INFO - Iteration through files over. 09:09:52 INFO - Return code: 0 09:09:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:09:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:09:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f41156d54686f14af01483bd6000d4cbe85eea37c04db8e5acd4aa03d0e1a38276a15a48e2bb39820be47127142fec92b035bf61a1e0e09617f119d6e04734f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/754618c601c1ba2dc936a3e8b1f71670aad877a1ea1218e5639c97f96355512326c3acf42eb0d25eeb204e60060afe259656b2bdd4b8cdbac949f31966f71aeb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e552080a35476d4310ba0cc06b7f4ac49a557c4cf516fe220c00827a0fb40a76f3d78c0c33ca76c05b1f8d9d0a4353287a0e14372becebcd0b0999ee97040e2c"} 09:09:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:09:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:09:52 INFO - Contents: 09:09:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f41156d54686f14af01483bd6000d4cbe85eea37c04db8e5acd4aa03d0e1a38276a15a48e2bb39820be47127142fec92b035bf61a1e0e09617f119d6e04734f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/754618c601c1ba2dc936a3e8b1f71670aad877a1ea1218e5639c97f96355512326c3acf42eb0d25eeb204e60060afe259656b2bdd4b8cdbac949f31966f71aeb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e552080a35476d4310ba0cc06b7f4ac49a557c4cf516fe220c00827a0fb40a76f3d78c0c33ca76c05b1f8d9d0a4353287a0e14372becebcd0b0999ee97040e2c"} 09:09:52 INFO - Running post-run listener: copy_logs_to_upload_dir 09:09:52 INFO - Copying logs to upload dir... 09:09:52 INFO - mkdir: /builds/slave/test/build/upload/logs 09:09:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.435000 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-11-15 09:09:52.024675) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-15 09:09:52.030539) ========= 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=14ef55db36f7623abb31b9cf000001d5-1479227690.149988-730682823 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/1f41156d54686f14af01483bd6000d4cbe85eea37c04db8e5acd4aa03d0e1a38276a15a48e2bb39820be47127142fec92b035bf61a1e0e09617f119d6e04734f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/754618c601c1ba2dc936a3e8b1f71670aad877a1ea1218e5639c97f96355512326c3acf42eb0d25eeb204e60060afe259656b2bdd4b8cdbac949f31966f71aeb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e552080a35476d4310ba0cc06b7f4ac49a557c4cf516fe220c00827a0fb40a76f3d78c0c33ca76c05b1f8d9d0a4353287a0e14372becebcd0b0999ee97040e2c"} build_url:https://queue.taskcluster.net/v1/task/bfvqbkAhSJiRCA19KXeKLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011253 build_url: 'https://queue.taskcluster.net/v1/task/bfvqbkAhSJiRCA19KXeKLg/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/1f41156d54686f14af01483bd6000d4cbe85eea37c04db8e5acd4aa03d0e1a38276a15a48e2bb39820be47127142fec92b035bf61a1e0e09617f119d6e04734f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/754618c601c1ba2dc936a3e8b1f71670aad877a1ea1218e5639c97f96355512326c3acf42eb0d25eeb204e60060afe259656b2bdd4b8cdbac949f31966f71aeb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e552080a35476d4310ba0cc06b7f4ac49a557c4cf516fe220c00827a0fb40a76f3d78c0c33ca76c05b1f8d9d0a4353287a0e14372becebcd0b0999ee97040e2c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-15 09:09:52.056025) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 09:09:52.056489) ========= 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=14ef55db36f7623abb31b9cf000001d5-1479227690.149988-730682823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 09:09:52.141293) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 09:09:52.141704) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 09:09:52.142047) ========= ========= Total master_lag: 0.18 =========