builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1470479164.88 results: success (0) buildid: 20160806004002 builduid: 19e6504b570843c7a67295ec3fc0f3a0 revision: 307fe134b473938131cb0f28db52cf371883f663 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-06 03:26:04.880944) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-06 03:26:04.881391) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-06 03:26:04.881666) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-06 03:26:04.898846) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 03:26:04.899249) ========= 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=ed14279e38b05397cf4aa391000001a4-1470479164.559306-1625069966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-06 03:26:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-08-06 03:26:05 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111955 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 03:26:05.025240) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 03:26:05.025566) ========= 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=ed14279e38b05397cf4aa391000001a4-1470479164.559306-1625069966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014890 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 03:26:05.078043) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-06 03:26:05.080496) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 307fe134b473938131cb0f28db52cf371883f663 --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 307fe134b473938131cb0f28db52cf371883f663 --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=ed14279e38b05397cf4aa391000001a4-1470479164.559306-1625069966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-06 03:26:05,788 truncating revision to first 12 chars 2016-08-06 03:26:05,788 Setting DEBUG logging. 2016-08-06 03:26:05,788 attempt 1/10 2016-08-06 03:26:05,788 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/307fe134b473?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-06 03:26:06,563 unpacking tar archive at: mozilla-aurora-307fe134b473/testing/mozharness/ program finished with exit code 0 elapsedTime=1.170430 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-06 03:26:06.268307) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-06 03:26:06.268708) ========= script_repo_revision: 307fe134b473938131cb0f28db52cf371883f663 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-06 03:26:06.269222) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-06 03:26:06.269495) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-06 03:26:06.279685) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 2 secs) (at 2016-08-06 03:26:06.280124) ========= /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=ed14279e38b05397cf4aa391000001a4-1470479164.559306-1625069966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:26:07 INFO - MultiFileLogger online at 20160806 03:26:07 in /builds/slave/test 03:26:07 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 03:26:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:26:07 INFO - {'append_to_log': False, 03:26:07 INFO - 'base_work_dir': '/builds/slave/test', 03:26:07 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:26:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:26:07 INFO - 'branch': 'Mozilla-Aurora', 03:26:07 INFO - 'buildbot_json_path': 'buildprops.json', 03:26:07 INFO - 'config_files': ('talos/linux_config.py',), 03:26:07 INFO - 'default_actions': ('clobber', 03:26:07 INFO - 'read-buildbot-config', 03:26:07 INFO - 'download-and-extract', 03:26:07 INFO - 'populate-webroot', 03:26:07 INFO - 'create-virtualenv', 03:26:07 INFO - 'install', 03:26:07 INFO - 'run-tests'), 03:26:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:26:07 INFO - 'download_minidump_stackwalk': True, 03:26:07 INFO - 'download_symbols': 'ondemand', 03:26:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:26:07 INFO - 'tooltool.py': '/tools/tooltool.py', 03:26:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:26:07 INFO - '/tools/misc-python/virtualenv.py')}, 03:26:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:26:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:26:07 INFO - 'installer_path': 'installer.exe', 03:26:07 INFO - 'log_level': 'info', 03:26:07 INFO - 'log_name': 'talos', 03:26:07 INFO - 'log_to_console': True, 03:26:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:26:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:26:07 INFO - 'opt_config_files': (), 03:26:07 INFO - 'pip_index': False, 03:26:07 INFO - 'sps_profile': False, 03:26:07 INFO - 'sps_profile_interval': 0, 03:26:07 INFO - 'suite': 'dromaeojs', 03:26:07 INFO - 'system_bits': '32', 03:26:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:26:07 INFO - 'title': 'talos-linux64-ix-035', 03:26:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:26:07 INFO - 'use_talos_json': True, 03:26:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:26:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:26:07 INFO - 'work_dir': 'build'} 03:26:07 INFO - [mozharness: 2016-08-06 10:26:07.080909Z] Running clobber step. 03:26:07 INFO - Running pre-action listener: _resource_record_pre_action 03:26:07 INFO - Running main action method: clobber 03:26:07 INFO - rmtree: /builds/slave/test/build 03:26:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:26:07 INFO - Running post-action listener: _resource_record_post_action 03:26:07 INFO - [mozharness: 2016-08-06 10:26:07.537330Z] Finished clobber step (success) 03:26:07 INFO - [mozharness: 2016-08-06 10:26:07.537430Z] Running read-buildbot-config step. 03:26:07 INFO - Running pre-action listener: _resource_record_pre_action 03:26:07 INFO - Running main action method: read_buildbot_config 03:26:07 INFO - Using buildbot properties: 03:26:07 INFO - { 03:26:07 INFO - "project": "", 03:26:07 INFO - "product": "firefox", 03:26:07 INFO - "script_repo_revision": "production", 03:26:07 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:26:07 INFO - "repository": "", 03:26:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:26:07 INFO - "buildid": "20160806004002", 03:26:07 INFO - "stage_platform": "linux64-pgo", 03:26:07 INFO - "basedir": "/builds/slave/test", 03:26:07 INFO - "nightly_build": "True", 03:26:07 INFO - "buildnumber": 413, 03:26:07 INFO - "slavename": "talos-linux64-ix-035", 03:26:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:26:07 INFO - "platform": "ubuntu64_hw", 03:26:07 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:26:07 INFO - "branch": "mozilla-aurora", 03:26:07 INFO - "repo_path": "releases/mozilla-aurora", 03:26:07 INFO - "revision": "307fe134b473938131cb0f28db52cf371883f663", 03:26:07 INFO - "pgo_build": "True", 03:26:07 INFO - "builduid": "19e6504b570843c7a67295ec3fc0f3a0", 03:26:07 INFO - "slavebuilddir": "test" 03:26:07 INFO - } 03:26:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 03:26:07 INFO - Running post-action listener: _resource_record_post_action 03:26:07 INFO - [mozharness: 2016-08-06 10:26:07.539934Z] Finished read-buildbot-config step (success) 03:26:07 INFO - [mozharness: 2016-08-06 10:26:07.540024Z] Running download-and-extract step. 03:26:07 INFO - Running pre-action listener: _resource_record_pre_action 03:26:07 INFO - Running main action method: download_and_extract 03:26:07 INFO - mkdir: /builds/slave/test/build/tests 03:26:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:07 INFO - https://queue.taskcluster.net/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:26:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:26:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:26:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:26:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:26:07 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:26:07 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:26:07 INFO - retry: Failed, sleeping 30 seconds before retrying 03:26:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 03:26:37 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:26:37 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:26:37 INFO - retry: Failed, sleeping 60 seconds before retrying 03:27:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 03:27:37 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:27:37 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:27:37 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json! 03:27:37 INFO - Caught exception: HTTP Error 404: Not Found 03:27:37 INFO - Caught exception: HTTP Error 404: Not Found 03:27:37 INFO - Caught exception: HTTP Error 404: Not Found 03:27:37 INFO - trying https://queue.taskcluster.net/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:27:37 INFO - Downloading https://queue.taskcluster.net/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:27:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:27:38 INFO - Downloaded 1361 bytes. 03:27:38 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:27:38 INFO - Using the following test package requirements: 03:27:38 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:27:38 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:38 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:27:38 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:38 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:27:38 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:38 INFO - u'jsshell-linux-x86_64.zip'], 03:27:38 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:38 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:27:38 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:27:38 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:38 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:27:38 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:38 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:27:38 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:38 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:27:38 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:38 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:27:38 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:27:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:38 INFO - https://queue.taskcluster.net/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:27:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:27:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:27:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:27:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:27:38 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:27:38 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:27:38 INFO - retry: Failed, sleeping 30 seconds before retrying 03:28:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 03:28:08 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:28:08 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:28:08 INFO - retry: Failed, sleeping 60 seconds before retrying 03:29:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 03:29:08 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:29:08 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:29:08 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 03:29:08 INFO - Caught exception: HTTP Error 404: Not Found 03:29:08 INFO - Caught exception: HTTP Error 404: Not Found 03:29:08 INFO - Caught exception: HTTP Error 404: Not Found 03:29:08 INFO - trying https://queue.taskcluster.net/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:29:08 INFO - Downloading https://queue.taskcluster.net/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:29:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:29:11 INFO - Downloaded 21764990 bytes. 03:29:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:29:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:29:12 INFO - Return code: 0 03:29:12 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:12 INFO - https://queue.taskcluster.net/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:29:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:29:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:29:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:29:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:29:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:29:12 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:29:12 INFO - retry: Failed, sleeping 30 seconds before retrying 03:29:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 03:29:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:29:42 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:29:42 INFO - retry: Failed, sleeping 60 seconds before retrying 03:30:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 03:30:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:30:42 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:30:42 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 03:30:42 INFO - Caught exception: HTTP Error 404: Not Found 03:30:42 INFO - Caught exception: HTTP Error 404: Not Found 03:30:42 INFO - Caught exception: HTTP Error 404: Not Found 03:30:42 INFO - trying https://queue.taskcluster.net/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:30:42 INFO - Downloading https://queue.taskcluster.net/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:30:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:30:43 INFO - Downloaded 21764990 bytes. 03:30:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:30:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:30:44 INFO - Return code: 0 03:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:44 INFO - https://queue.taskcluster.net/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:30:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:30:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:30:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:30:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:30:44 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:30:44 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:30:44 INFO - retry: Failed, sleeping 30 seconds before retrying 03:31:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 03:31:14 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:31:14 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:31:14 INFO - retry: Failed, sleeping 60 seconds before retrying 03:32:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 03:32:14 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:32:14 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:32:14 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip! 03:32:14 INFO - Caught exception: HTTP Error 404: Not Found 03:32:14 INFO - Caught exception: HTTP Error 404: Not Found 03:32:14 INFO - Caught exception: HTTP Error 404: Not Found 03:32:14 INFO - trying https://queue.taskcluster.net/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:32:14 INFO - Downloading https://queue.taskcluster.net/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:32:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:32:18 INFO - Downloaded 14413723 bytes. 03:32:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:32:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:32:18 INFO - Return code: 0 03:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:18 INFO - https://queue.taskcluster.net/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:32:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:32:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:32:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:32:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:32:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:32:19 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:32:19 INFO - retry: Failed, sleeping 30 seconds before retrying 03:32:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 03:32:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:32:49 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:32:49 INFO - retry: Failed, sleeping 60 seconds before retrying 03:33:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 03:33:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:33:49 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:33:49 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2! 03:33:49 INFO - Caught exception: HTTP Error 404: Not Found 03:33:49 INFO - Caught exception: HTTP Error 404: Not Found 03:33:49 INFO - Caught exception: HTTP Error 404: Not Found 03:33:49 INFO - trying https://queue.taskcluster.net/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:33:49 INFO - Downloading https://queue.taskcluster.net/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:33:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:33:51 INFO - Downloaded 63749412 bytes. 03:33:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:33:51 INFO - mkdir: /builds/slave/test/properties 03:33:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:33:51 INFO - Writing to file /builds/slave/test/properties/build_url 03:33:51 INFO - Contents: 03:33:51 INFO - build_url:https://queue.taskcluster.net/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:33:52 INFO - Running post-action listener: _resource_record_post_action 03:33:52 INFO - Running post-action listener: set_extra_try_arguments 03:33:52 INFO - [mozharness: 2016-08-06 10:33:52.085155Z] Finished download-and-extract step (success) 03:33:52 INFO - [mozharness: 2016-08-06 10:33:52.085386Z] Running populate-webroot step. 03:33:52 INFO - Running pre-action listener: _resource_record_pre_action 03:33:52 INFO - Running main action method: populate_webroot 03:33:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:33:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:33:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:33:52 INFO - '--tppagecycles', 03:33:52 INFO - '7'], 03:33:52 INFO - 'tests': ['tsvgm']}}, 03:33:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:33:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:33:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:33:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:33:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:33:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:33:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:52 INFO - 'talos_options': ['--disable-e10s'], 03:33:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:52 INFO - 'talos_options': ['--disable-e10s'], 03:33:52 INFO - 'tests': ['damp', 'tps']}, 03:33:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:52 INFO - 'tests': ['damp', 'tps']}, 03:33:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:33:52 INFO - 'tests': ['dromaeo_dom']}, 03:33:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:33:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:33:52 INFO - 'tests': ['basic_compositor_video']}, 03:33:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:33:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:33:52 INFO - 'tests': ['a11yr', 03:33:52 INFO - 'ts_paint', 03:33:52 INFO - 'tpaint', 03:33:52 INFO - 'sessionrestore', 03:33:52 INFO - 'sessionrestore_no_auto_restore', 03:33:52 INFO - 'tabpaint']}, 03:33:52 INFO - 'other-e10s': {'tests': ['a11yr', 03:33:52 INFO - 'ts_paint', 03:33:52 INFO - 'tpaint', 03:33:52 INFO - 'sessionrestore', 03:33:52 INFO - 'sessionrestore_no_auto_restore', 03:33:52 INFO - 'tabpaint']}, 03:33:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:33:52 INFO - 'ts_paint', 03:33:52 INFO - 'tpaint', 03:33:52 INFO - 'sessionrestore', 03:33:52 INFO - 'sessionrestore_no_auto_restore', 03:33:52 INFO - 'tabpaint']}, 03:33:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:33:52 INFO - 'ts_paint', 03:33:52 INFO - 'tpaint', 03:33:52 INFO - 'sessionrestore', 03:33:52 INFO - 'sessionrestore_no_auto_restore', 03:33:52 INFO - 'tabpaint']}, 03:33:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:33:52 INFO - 'tests': ['a11yr', 03:33:52 INFO - 'ts_paint', 03:33:52 INFO - 'tpaint', 03:33:52 INFO - 'sessionrestore', 03:33:52 INFO - 'sessionrestore_no_auto_restore', 03:33:52 INFO - 'tabpaint']}, 03:33:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:33:52 INFO - 'tests': ['a11yr', 03:33:52 INFO - 'ts_paint', 03:33:52 INFO - 'tpaint', 03:33:52 INFO - 'sessionrestore', 03:33:52 INFO - 'sessionrestore_no_auto_restore', 03:33:52 INFO - 'tabpaint']}, 03:33:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:33:52 INFO - 'tests': ['tsvgx', 03:33:52 INFO - 'tsvgr_opacity', 03:33:52 INFO - 'tart', 03:33:52 INFO - 'tscrollx', 03:33:52 INFO - 'cart']}, 03:33:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:33:52 INFO - 'tsvgr_opacity', 03:33:52 INFO - 'tart', 03:33:52 INFO - 'tscrollx', 03:33:52 INFO - 'cart']}, 03:33:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:52 INFO - 'talos_options': ['--disable-e10s'], 03:33:52 INFO - 'tests': ['tp5o']}, 03:33:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:52 INFO - 'tests': ['tp5o']}, 03:33:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:52 INFO - 'talos_options': ['--disable-e10s', 03:33:52 INFO - '--xperf_path', 03:33:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:52 INFO - 'tests': ['tp5n']}, 03:33:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:52 INFO - 'talos_options': ['--xperf_path', 03:33:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:52 INFO - 'tests': ['tp5n']}}, 03:33:52 INFO - 'talos.zip': {'path': '', 03:33:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:33:52 INFO - Running post-action listener: _resource_record_post_action 03:33:52 INFO - [mozharness: 2016-08-06 10:33:52.103248Z] Finished populate-webroot step (success) 03:33:52 INFO - [mozharness: 2016-08-06 10:33:52.103337Z] Running create-virtualenv step. 03:33:52 INFO - Running pre-action listener: _resource_record_pre_action 03:33:52 INFO - Running main action method: create_virtualenv 03:33:52 INFO - Creating virtualenv /builds/slave/test/build/venv 03:33:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:33:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:33:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:33:52 INFO - Using real prefix '/usr' 03:33:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:33:52 INFO - Installing distribute.............................................................................................................................................................................................done. 03:33:54 INFO - Installing pip.................done. 03:33:54 INFO - Return code: 0 03:33:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:54 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 0xf03030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c23b0>, '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 0x11c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c3740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470479164.559306-1625069966', '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 03:33:54 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 03:33:54 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 03:33:54 INFO - Using env: {'DISPLAY': ':0', 03:33:54 INFO - 'HOME': '/home/cltbld', 03:33:54 INFO - 'LANG': 'en_US.UTF-8', 03:33:54 INFO - 'LANGUAGE': 'en_US:en', 03:33:54 INFO - 'LOGNAME': 'cltbld', 03:33:54 INFO - 'MAIL': '/var/mail/cltbld', 03:33:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:54 INFO - 'MOZ_NO_REMOTE': '1', 03:33:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:54 INFO - 'NO_EM_RESTART': '1', 03:33:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:54 INFO - 'PWD': '/builds/slave/test', 03:33:54 INFO - 'SHELL': '/bin/bash', 03:33:54 INFO - 'SHLVL': '1', 03:33:54 INFO - 'TERM': 'linux', 03:33:54 INFO - 'TMOUT': '86400', 03:33:54 INFO - 'USER': 'cltbld', 03:33:54 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470479164.559306-1625069966', 03:33:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:54 INFO - '_': '/tools/buildbot/bin/python'} 03:33:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:54 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 03:33:54 INFO - Cleaning up... 03:33:54 INFO - Return code: 0 03:33:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:54 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 0xf03030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c23b0>, '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 0x11c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c3740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470479164.559306-1625069966', '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 03:33:54 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 03:33:54 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 03:33:54 INFO - Using env: {'DISPLAY': ':0', 03:33:54 INFO - 'HOME': '/home/cltbld', 03:33:54 INFO - 'LANG': 'en_US.UTF-8', 03:33:54 INFO - 'LANGUAGE': 'en_US:en', 03:33:54 INFO - 'LOGNAME': 'cltbld', 03:33:54 INFO - 'MAIL': '/var/mail/cltbld', 03:33:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:54 INFO - 'MOZ_NO_REMOTE': '1', 03:33:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:54 INFO - 'NO_EM_RESTART': '1', 03:33:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:54 INFO - 'PWD': '/builds/slave/test', 03:33:54 INFO - 'SHELL': '/bin/bash', 03:33:54 INFO - 'SHLVL': '1', 03:33:54 INFO - 'TERM': 'linux', 03:33:54 INFO - 'TMOUT': '86400', 03:33:54 INFO - 'USER': 'cltbld', 03:33:54 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470479164.559306-1625069966', 03:33:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:54 INFO - '_': '/tools/buildbot/bin/python'} 03:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:55 INFO - Downloading/unpacking psutil>=3.1.1 03:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:33:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:57 INFO - Installing collected packages: psutil 03:33:57 INFO - Running setup.py install for psutil 03:33:57 INFO - building 'psutil._psutil_linux' extension 03:33:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:33:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:33:57 INFO - building 'psutil._psutil_posix' extension 03:33:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:33:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:33:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:57 INFO - Successfully installed psutil 03:33:57 INFO - Cleaning up... 03:33:57 INFO - Return code: 0 03:33:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:33:57 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:57 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:57 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 0xf03030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c23b0>, '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 0x11c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c3740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470479164.559306-1625069966', '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 03:33:57 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 03:33:57 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 03:33:57 INFO - Using env: {'DISPLAY': ':0', 03:33:57 INFO - 'HOME': '/home/cltbld', 03:33:57 INFO - 'LANG': 'en_US.UTF-8', 03:33:57 INFO - 'LANGUAGE': 'en_US:en', 03:33:57 INFO - 'LOGNAME': 'cltbld', 03:33:57 INFO - 'MAIL': '/var/mail/cltbld', 03:33:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:57 INFO - 'MOZ_NO_REMOTE': '1', 03:33:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:57 INFO - 'NO_EM_RESTART': '1', 03:33:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:57 INFO - 'PWD': '/builds/slave/test', 03:33:57 INFO - 'SHELL': '/bin/bash', 03:33:57 INFO - 'SHLVL': '1', 03:33:57 INFO - 'TERM': 'linux', 03:33:57 INFO - 'TMOUT': '86400', 03:33:57 INFO - 'USER': 'cltbld', 03:33:57 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470479164.559306-1625069966', 03:33:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:57 INFO - '_': '/tools/buildbot/bin/python'} 03:33:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:33:57 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 03:33:57 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 03:33:57 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 03:33:57 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 03:33:57 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 03:33:57 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 03:33:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:33:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:33:59 INFO - Installing collected packages: mozsystemmonitor 03:33:59 INFO - Running setup.py install for mozsystemmonitor 03:33:59 INFO - Successfully installed mozsystemmonitor 03:33:59 INFO - Cleaning up... 03:34:00 INFO - Return code: 0 03:34:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf03030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c23b0>, '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 0x11c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c3740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470479164.559306-1625069966', '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 03:34:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:34:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:34:00 INFO - Using env: {'DISPLAY': ':0', 03:34:00 INFO - 'HOME': '/home/cltbld', 03:34:00 INFO - 'LANG': 'en_US.UTF-8', 03:34:00 INFO - 'LANGUAGE': 'en_US:en', 03:34:00 INFO - 'LOGNAME': 'cltbld', 03:34:00 INFO - 'MAIL': '/var/mail/cltbld', 03:34:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:00 INFO - 'MOZ_NO_REMOTE': '1', 03:34:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:00 INFO - 'NO_EM_RESTART': '1', 03:34:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:00 INFO - 'PWD': '/builds/slave/test', 03:34:00 INFO - 'SHELL': '/bin/bash', 03:34:00 INFO - 'SHLVL': '1', 03:34:00 INFO - 'TERM': 'linux', 03:34:00 INFO - 'TMOUT': '86400', 03:34:00 INFO - 'USER': 'cltbld', 03:34:00 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470479164.559306-1625069966', 03:34:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:00 INFO - '_': '/tools/buildbot/bin/python'} 03:34:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:00 INFO - Downloading/unpacking jsonschema==2.5.1 03:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:34:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:02 INFO - Downloading functools32-3.2.3-2.tar.gz 03:34:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:34:02 INFO - warning: no files found matching '*.txt' 03:34:02 INFO - no previously-included directories found matching 'build' 03:34:02 INFO - no previously-included directories found matching 'dist' 03:34:02 INFO - no previously-included directories found matching '.git*' 03:34:02 INFO - Installing collected packages: jsonschema, functools32 03:34:02 INFO - Running setup.py install for functools32 03:34:02 INFO - warning: no files found matching '*.txt' 03:34:02 INFO - no previously-included directories found matching 'build' 03:34:02 INFO - no previously-included directories found matching 'dist' 03:34:02 INFO - no previously-included directories found matching '.git*' 03:34:02 INFO - Successfully installed jsonschema functools32 03:34:02 INFO - Cleaning up... 03:34:02 INFO - Return code: 0 03:34:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf03030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c23b0>, '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 0x11c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c3740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470479164.559306-1625069966', '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 03:34:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:34:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:34:02 INFO - Using env: {'DISPLAY': ':0', 03:34:02 INFO - 'HOME': '/home/cltbld', 03:34:02 INFO - 'LANG': 'en_US.UTF-8', 03:34:02 INFO - 'LANGUAGE': 'en_US:en', 03:34:02 INFO - 'LOGNAME': 'cltbld', 03:34:02 INFO - 'MAIL': '/var/mail/cltbld', 03:34:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:02 INFO - 'MOZ_NO_REMOTE': '1', 03:34:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:02 INFO - 'NO_EM_RESTART': '1', 03:34:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:02 INFO - 'PWD': '/builds/slave/test', 03:34:02 INFO - 'SHELL': '/bin/bash', 03:34:02 INFO - 'SHLVL': '1', 03:34:02 INFO - 'TERM': 'linux', 03:34:02 INFO - 'TMOUT': '86400', 03:34:02 INFO - 'USER': 'cltbld', 03:34:02 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470479164.559306-1625069966', 03:34:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:02 INFO - '_': '/tools/buildbot/bin/python'} 03:34:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:34:02 INFO - Cleaning up... 03:34:02 INFO - Return code: 0 03:34:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf03030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c23b0>, '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 0x11c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c3740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470479164.559306-1625069966', '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 03:34:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:34:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:34:02 INFO - Using env: {'DISPLAY': ':0', 03:34:02 INFO - 'HOME': '/home/cltbld', 03:34:02 INFO - 'LANG': 'en_US.UTF-8', 03:34:02 INFO - 'LANGUAGE': 'en_US:en', 03:34:02 INFO - 'LOGNAME': 'cltbld', 03:34:02 INFO - 'MAIL': '/var/mail/cltbld', 03:34:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:02 INFO - 'MOZ_NO_REMOTE': '1', 03:34:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:02 INFO - 'NO_EM_RESTART': '1', 03:34:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:02 INFO - 'PWD': '/builds/slave/test', 03:34:02 INFO - 'SHELL': '/bin/bash', 03:34:02 INFO - 'SHLVL': '1', 03:34:02 INFO - 'TERM': 'linux', 03:34:02 INFO - 'TMOUT': '86400', 03:34:02 INFO - 'USER': 'cltbld', 03:34:02 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470479164.559306-1625069966', 03:34:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:02 INFO - '_': '/tools/buildbot/bin/python'} 03:34:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:02 INFO - Downloading/unpacking blobuploader==1.2.4 03:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:04 INFO - Downloading blobuploader-1.2.4.tar.gz 03:34:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:34:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:34:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:05 INFO - Downloading docopt-0.6.1.tar.gz 03:34:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:34:05 INFO - Installing collected packages: blobuploader, requests, docopt 03:34:05 INFO - Running setup.py install for blobuploader 03:34:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:34:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:34:05 INFO - Running setup.py install for requests 03:34:06 INFO - Running setup.py install for docopt 03:34:06 INFO - Successfully installed blobuploader requests docopt 03:34:06 INFO - Cleaning up... 03:34:06 INFO - Return code: 0 03:34:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf03030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c23b0>, '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 0x11c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c3740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470479164.559306-1625069966', '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 03:34:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:34:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:34:06 INFO - Using env: {'DISPLAY': ':0', 03:34:06 INFO - 'HOME': '/home/cltbld', 03:34:06 INFO - 'LANG': 'en_US.UTF-8', 03:34:06 INFO - 'LANGUAGE': 'en_US:en', 03:34:06 INFO - 'LOGNAME': 'cltbld', 03:34:06 INFO - 'MAIL': '/var/mail/cltbld', 03:34:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:06 INFO - 'MOZ_NO_REMOTE': '1', 03:34:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:06 INFO - 'NO_EM_RESTART': '1', 03:34:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:06 INFO - 'PWD': '/builds/slave/test', 03:34:06 INFO - 'SHELL': '/bin/bash', 03:34:06 INFO - 'SHLVL': '1', 03:34:06 INFO - 'TERM': 'linux', 03:34:06 INFO - 'TMOUT': '86400', 03:34:06 INFO - 'USER': 'cltbld', 03:34:06 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470479164.559306-1625069966', 03:34:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:06 INFO - '_': '/tools/buildbot/bin/python'} 03:34:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:06 INFO - Running setup.py (path:/tmp/pip-tRmvT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:06 INFO - Running setup.py (path:/tmp/pip-h577bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:06 INFO - Running setup.py (path:/tmp/pip-tyt10A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:06 INFO - Running setup.py (path:/tmp/pip-kwBYyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:06 INFO - Running setup.py (path:/tmp/pip-fVdZBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:06 INFO - Running setup.py (path:/tmp/pip-_I2yVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:06 INFO - Running setup.py (path:/tmp/pip-HIH3Qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:06 INFO - Running setup.py (path:/tmp/pip-6bpHrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:07 INFO - Running setup.py (path:/tmp/pip-ucs1yY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:07 INFO - Running setup.py (path:/tmp/pip-jqSJ0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:07 INFO - Running setup.py (path:/tmp/pip-SjUc9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:07 INFO - Running setup.py (path:/tmp/pip-18yBjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:07 INFO - Running setup.py (path:/tmp/pip-7ETqfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:07 INFO - Running setup.py (path:/tmp/pip-ChiymG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:07 INFO - Running setup.py (path:/tmp/pip-c0er1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:07 INFO - Running setup.py (path:/tmp/pip-590sEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:07 INFO - Running setup.py (path:/tmp/pip-PiugLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:34:07 INFO - Running setup.py install for manifestparser 03:34:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:34:07 INFO - Running setup.py install for mozcrash 03:34:07 INFO - Running setup.py install for mozdebug 03:34:07 INFO - Running setup.py install for mozdevice 03:34:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:34:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:34:08 INFO - Running setup.py install for mozfile 03:34:08 INFO - Running setup.py install for mozhttpd 03:34:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:34:08 INFO - Running setup.py install for mozinfo 03:34:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:34:08 INFO - Running setup.py install for mozInstall 03:34:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:34:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:34:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:34:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:34:08 INFO - Running setup.py install for mozleak 03:34:08 INFO - Running setup.py install for mozlog 03:34:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:34:08 INFO - Running setup.py install for moznetwork 03:34:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:34:08 INFO - Running setup.py install for mozprocess 03:34:08 INFO - Running setup.py install for mozprofile 03:34:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:34:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:34:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:34:09 INFO - Running setup.py install for mozrunner 03:34:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:34:09 INFO - Running setup.py install for mozscreenshot 03:34:09 INFO - Running setup.py install for moztest 03:34:09 INFO - Running setup.py install for mozversion 03:34:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:34:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:34:09 INFO - Cleaning up... 03:34:09 INFO - Return code: 0 03:34:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:09 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 0xf03030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c23b0>, '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 0x11c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c3740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470479164.559306-1625069966', '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 03:34:09 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 03:34:09 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 03:34:09 INFO - Using env: {'DISPLAY': ':0', 03:34:09 INFO - 'HOME': '/home/cltbld', 03:34:09 INFO - 'LANG': 'en_US.UTF-8', 03:34:09 INFO - 'LANGUAGE': 'en_US:en', 03:34:09 INFO - 'LOGNAME': 'cltbld', 03:34:09 INFO - 'MAIL': '/var/mail/cltbld', 03:34:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:09 INFO - 'MOZ_NO_REMOTE': '1', 03:34:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:09 INFO - 'NO_EM_RESTART': '1', 03:34:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:09 INFO - 'PWD': '/builds/slave/test', 03:34:09 INFO - 'SHELL': '/bin/bash', 03:34:09 INFO - 'SHLVL': '1', 03:34:09 INFO - 'TERM': 'linux', 03:34:09 INFO - 'TMOUT': '86400', 03:34:09 INFO - 'USER': 'cltbld', 03:34:09 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470479164.559306-1625069966', 03:34:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:09 INFO - '_': '/tools/buildbot/bin/python'} 03:34:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:09 INFO - Running setup.py (path:/tmp/pip-7lKfGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34:09 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)) 03:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:09 INFO - Running setup.py (path:/tmp/pip-5Ly090-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:09 INFO - Running setup.py (path:/tmp/pip-2k75xI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34:09 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)) 03:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:09 INFO - Running setup.py (path:/tmp/pip-xVXNV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34:09 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)) 03:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:09 INFO - Running setup.py (path:/tmp/pip-XScQDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:10 INFO - Running setup.py (path:/tmp/pip-Wvk5j_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:10 INFO - Running setup.py (path:/tmp/pip-GNpudu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:10 INFO - Running setup.py (path:/tmp/pip-qidXFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:10 INFO - Running setup.py (path:/tmp/pip-WmKgpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:10 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)) 03:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:10 INFO - Running setup.py (path:/tmp/pip-jU1AXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 03:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:10 INFO - Running setup.py (path:/tmp/pip-HqluoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34:10 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)) 03:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:10 INFO - Running setup.py (path:/tmp/pip-og_mOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34:10 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)) 03:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:10 INFO - Running setup.py (path:/tmp/pip-42OOMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34:10 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)) 03:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:10 INFO - Running setup.py (path:/tmp/pip-SWx4SB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:10 INFO - Running setup.py (path:/tmp/pip-uwGw1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:10 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)) 03:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:10 INFO - Running setup.py (path:/tmp/pip-kE8CTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:10 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)) 03:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:10 INFO - Running setup.py (path:/tmp/pip-bPsb2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:10 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)) 03:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:34:10 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)) 03:34:10 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)) 03:34:10 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)) 03:34:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:34:10 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 03:34:10 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 03:34:10 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 03:34:10 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 03:34:10 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 03:34:10 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 03:34:12 INFO - Downloading blessings-1.6.tar.gz 03:34:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:34:12 INFO - Installing collected packages: blessings 03:34:12 INFO - Running setup.py install for blessings 03:34:12 INFO - Successfully installed blessings 03:34:12 INFO - Cleaning up... 03:34:13 INFO - Return code: 0 03:34:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:34:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:13 INFO - Reading from file tmpfile_stdout 03:34:13 INFO - Current package versions: 03:34:13 INFO - argparse == 1.2.1 03:34:13 INFO - blessings == 1.6 03:34:13 INFO - blobuploader == 1.2.4 03:34:13 INFO - docopt == 0.6.1 03:34:13 INFO - functools32 == 3.2.3-2 03:34:13 INFO - jsonschema == 2.5.1 03:34:13 INFO - manifestparser == 1.1 03:34:13 INFO - mozInstall == 1.12 03:34:13 INFO - mozcrash == 0.17 03:34:13 INFO - mozdebug == 0.1 03:34:13 INFO - mozdevice == 0.48 03:34:13 INFO - mozfile == 1.2 03:34:13 INFO - mozhttpd == 0.7 03:34:13 INFO - mozinfo == 0.9 03:34:13 INFO - mozleak == 0.1 03:34:13 INFO - mozlog == 3.3 03:34:13 INFO - moznetwork == 0.27 03:34:13 INFO - mozprocess == 0.23 03:34:13 INFO - mozprofile == 0.28 03:34:13 INFO - mozrunner == 6.12 03:34:13 INFO - mozscreenshot == 0.1 03:34:13 INFO - mozsystemmonitor == 0.3 03:34:13 INFO - moztest == 0.7 03:34:13 INFO - mozversion == 1.4 03:34:13 INFO - psutil == 3.1.1 03:34:13 INFO - requests == 1.2.3 03:34:13 INFO - wsgiref == 0.1.2 03:34:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf03030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c23b0>, '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 0x11c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c3740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470479164.559306-1625069966', '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 03:34:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:34:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:34:13 INFO - Using env: {'DISPLAY': ':0', 03:34:13 INFO - 'HOME': '/home/cltbld', 03:34:13 INFO - 'LANG': 'en_US.UTF-8', 03:34:13 INFO - 'LANGUAGE': 'en_US:en', 03:34:13 INFO - 'LOGNAME': 'cltbld', 03:34:13 INFO - 'MAIL': '/var/mail/cltbld', 03:34:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:13 INFO - 'MOZ_NO_REMOTE': '1', 03:34:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:13 INFO - 'NO_EM_RESTART': '1', 03:34:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:13 INFO - 'PWD': '/builds/slave/test', 03:34:13 INFO - 'SHELL': '/bin/bash', 03:34:13 INFO - 'SHLVL': '1', 03:34:13 INFO - 'TERM': 'linux', 03:34:13 INFO - 'TMOUT': '86400', 03:34:13 INFO - 'USER': 'cltbld', 03:34:13 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470479164.559306-1625069966', 03:34:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:13 INFO - '_': '/tools/buildbot/bin/python'} 03:34:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:13 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)) 03:34:13 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)) 03:34:13 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)) 03:34:13 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)) 03:34:13 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)) 03:34:13 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)) 03:34:13 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)) 03:34:13 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)) 03:34:13 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)) 03:34:13 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)) 03:34:13 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)) 03:34:13 INFO - Cleaning up... 03:34:13 INFO - Return code: 0 03:34:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:13 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 0xf03030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c23b0>, '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 0x11c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c3740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470479164.559306-1625069966', '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 03:34:13 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 03:34:13 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 03:34:13 INFO - Using env: {'DISPLAY': ':0', 03:34:13 INFO - 'HOME': '/home/cltbld', 03:34:13 INFO - 'LANG': 'en_US.UTF-8', 03:34:13 INFO - 'LANGUAGE': 'en_US:en', 03:34:13 INFO - 'LOGNAME': 'cltbld', 03:34:13 INFO - 'MAIL': '/var/mail/cltbld', 03:34:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:13 INFO - 'MOZ_NO_REMOTE': '1', 03:34:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:13 INFO - 'NO_EM_RESTART': '1', 03:34:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:13 INFO - 'PWD': '/builds/slave/test', 03:34:13 INFO - 'SHELL': '/bin/bash', 03:34:13 INFO - 'SHLVL': '1', 03:34:13 INFO - 'TERM': 'linux', 03:34:13 INFO - 'TMOUT': '86400', 03:34:13 INFO - 'USER': 'cltbld', 03:34:13 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470479164.559306-1625069966', 03:34:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:13 INFO - '_': '/tools/buildbot/bin/python'} 03:34:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:34:13 INFO - Cleaning up... 03:34:13 INFO - Return code: 0 03:34:13 INFO - Running post-action listener: _resource_record_post_action 03:34:13 INFO - Running post-action listener: _start_resource_monitoring 03:34:13 INFO - Starting resource monitoring. 03:34:13 INFO - [mozharness: 2016-08-06 10:34:13.745050Z] Finished create-virtualenv step (success) 03:34:13 INFO - [mozharness: 2016-08-06 10:34:13.745495Z] Running install step. 03:34:13 INFO - Running pre-action listener: _resource_record_pre_action 03:34:13 INFO - Running main action method: install 03:34:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:13 INFO - Reading from file tmpfile_stdout 03:34:13 INFO - Detecting whether we're running mozinstall >=1.0... 03:34:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:34:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:34:14 INFO - Reading from file tmpfile_stdout 03:34:14 INFO - Output received: 03:34:14 INFO - Usage: mozinstall [options] installer 03:34:14 INFO - Options: 03:34:14 INFO - -h, --help show this help message and exit 03:34:14 INFO - -d DEST, --destination=DEST 03:34:14 INFO - Directory to install application into. [default: 03:34:14 INFO - "/builds/slave/test"] 03:34:14 INFO - --app=APP Application being installed. [default: firefox] 03:34:14 INFO - mkdir: /builds/slave/test/build/application 03:34:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:34:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:34:30 INFO - Reading from file tmpfile_stdout 03:34:30 INFO - Output received: 03:34:30 INFO - /builds/slave/test/build/application/firefox/firefox 03:34:30 INFO - Running post-action listener: _resource_record_post_action 03:34:30 INFO - [mozharness: 2016-08-06 10:34:30.581700Z] Finished install step (success) 03:34:30 INFO - [mozharness: 2016-08-06 10:34:30.581974Z] Running run-tests step. 03:34:30 INFO - Running pre-action listener: _resource_record_pre_action 03:34:30 INFO - Running main action method: run_tests 03:34:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:34:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:34:30 INFO - Python 2.7.3 03:34:30 INFO - Return code: 0 03:34:30 INFO - grabbing minidump binary from tooltool 03:34:30 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:30 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 0x11c23b0>, '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 0x11c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c3740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:34:30 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 03:34:30 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 03:34:30 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 03:34:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:34:30 INFO - Return code: 0 03:34:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:34:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:34:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:34:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:34:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:34:30 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/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 03:34:30 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/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 03:34:30 INFO - Using env: {'DISPLAY': ':0', 03:34:30 INFO - 'HOME': '/home/cltbld', 03:34:30 INFO - 'LANG': 'en_US.UTF-8', 03:34:30 INFO - 'LANGUAGE': 'en_US:en', 03:34:30 INFO - 'LOGNAME': 'cltbld', 03:34:30 INFO - 'MAIL': '/var/mail/cltbld', 03:34:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:34:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:34:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:30 INFO - 'MOZ_NO_REMOTE': '1', 03:34:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:34:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:30 INFO - 'NO_EM_RESTART': '1', 03:34:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:30 INFO - 'PWD': '/builds/slave/test', 03:34:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:34:30 INFO - 'SHELL': '/bin/bash', 03:34:30 INFO - 'SHLVL': '1', 03:34:30 INFO - 'TERM': 'linux', 03:34:30 INFO - 'TMOUT': '86400', 03:34:30 INFO - 'USER': 'cltbld', 03:34:30 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470479164.559306-1625069966', 03:34:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:30 INFO - '_': '/tools/buildbot/bin/python'} 03:34:30 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/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 03:34:30 INFO - mozversion application_buildid: 20160806004002 03:34:30 INFO - mozversion application_changeset: 307fe134b473938131cb0f28db52cf371883f663 03:34:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:34:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:34:30 INFO - mozversion application_name: Firefox 03:34:30 INFO - mozversion application_remotingname: firefox-dev 03:34:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:34:30 INFO - mozversion application_vendor: Mozilla 03:34:30 INFO - mozversion application_version: 50.0a2 03:34:30 INFO - mozversion platform_buildid: 20160806004002 03:34:30 INFO - mozversion platform_changeset: 307fe134b473938131cb0f28db52cf371883f663 03:34:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:34:30 INFO - mozversion platform_version: 50.0a2 03:34:30 INFO - using testdate: 1470479670 03:34:30 INFO - actual date: 1470479670 03:34:30 INFO - starting webserver on 'localhost:53713' 03:34:30 INFO - SUITE-START | Running 2 tests 03:34:30 INFO - TEST-START | dromaeo_css 03:34:30 INFO - operating with platform_type : linux_ 03:34:30 INFO - Initialising browser for dromaeo_css test... 03:34:30 INFO - TEST-INFO | started process 30456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplKoZWH/profile http://localhost:53713/getInfo.html) 03:34:34 INFO - PROCESS | 30456 | __metrics Screen width/height:1600/1200 03:34:34 INFO - PROCESS | 30456 | colorDepth:24 03:34:34 INFO - PROCESS | 30456 | Browser inner width/height: 1024/697 03:34:34 INFO - PROCESS | 30456 | __metrics 03:34:35 INFO - PROCESS | 30456 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:34:35 INFO - PROCESS | 30456 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:34:36 INFO - TEST-INFO | 30456: exit 0 03:34:36 INFO - Browser initialized. 03:34:36 INFO - Running cycle 1/1 for dromaeo_css test... 03:34:36 INFO - TEST-INFO | started process 30546 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplKoZWH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:34:48 INFO - PROCESS | 30546 | RSS: Main: 144793600 03:34:48 INFO - PROCESS | 30546 | 03:35:39 INFO - PROCESS | 30546 | 1470479739113 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] 03:37:47 INFO - PROCESS | 30546 | Cycle 1(1): loaded http://localhost:53713/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53713/tests/dromaeo/cssquery-ext.html) 03:37:49 INFO - PROCESS | 30546 | RSS: Main: 219496448 03:37:49 INFO - PROCESS | 30546 | 03:40:51 INFO - PROCESS | 30546 | Cycle 1(1): loaded http://localhost:53713/tests/dromaeo/cssquery-ext.html (next: http://localhost:53713/tests/dromaeo/cssquery-jquery.html) 03:40:51 INFO - PROCESS | 30546 | RSS: Main: 232869888 03:40:51 INFO - PROCESS | 30546 | 03:43:53 INFO - PROCESS | 30546 | Cycle 1(1): loaded http://localhost:53713/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53713/tests/dromaeo/cssquery-mootools.html) 03:43:54 INFO - PROCESS | 30546 | RSS: Main: 176533504 03:43:54 INFO - PROCESS | 30546 | 03:46:56 INFO - PROCESS | 30546 | Cycle 1(1): loaded http://localhost:53713/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53713/tests/dromaeo/cssquery-prototype.html) 03:46:56 INFO - PROCESS | 30546 | RSS: Main: 174444544 03:46:56 INFO - PROCESS | 30546 | 03:49:59 INFO - PROCESS | 30546 | Cycle 1(1): loaded http://localhost:53713/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53713/tests/dromaeo/cssquery-yui.html) 03:50:00 INFO - PROCESS | 30546 | RSS: Main: 177291264 03:50:00 INFO - PROCESS | 30546 | 03:53:02 INFO - PROCESS | 30546 | Cycle 1(1): loaded http://localhost:53713/tests/dromaeo/cssquery-yui.html (next: http://localhost:53713/tests/dromaeo/cssquery-dojo.html) 03:53:02 INFO - PROCESS | 30546 | RSS: Main: 265723904 03:53:02 INFO - PROCESS | 30546 | 03:53:02 INFO - PROCESS | 30546 | __start_tp_report 03:53:02 INFO - PROCESS | 30546 | _x_x_mozilla_page_load 03:53:02 INFO - PROCESS | 30546 | _x_x_mozilla_page_load_details 03:53:02 INFO - PROCESS | 30546 | |i|pagename|runs| 03:53:02 INFO - PROCESS | 30546 | |0;dojo.html;3191.2819615586495;3210.7270881975032;3210.7270881975032;3239.0930539448964;3260.070879799258;5481.698506582136;5555.083411237146;5568.470995255454;5586.720663966806;5609.9999999999945;5556.805511807088;5613.101903695409;5645.237892884459;5669.149627555868;5686.4597863203035;5029.547340739333;5039.924401133986;5116.360454943132;5145.716985565792;5202.8179013734525;5082.517160869711;5163.870903227431;5167.7932882684645;5168.53483186515;5172.172452407615;5016.573591244749;5031.421386540558;5040.117979353617;5056;5158;5124.385073791132;5128.769205385766;5134.589232861362;5148.794048238066;5189.299444574972;4956.826511072095;4981.32752078472;5034.370703662043;5043.722595257259;5044.142495775727;5450.400455949882;5472.644278121909;5490.094134467808;5521.668699878021;5531.032069387881;5996.730147143389;6000.309964354068;6000.519958403317;6002.669853158074;6017.729202185868;5817.7382017809305;5894.3810899855325;5939.435753603444;5944.881102377928;6033.366496517846;5581.888362232733;5598.076317407623;5609.607327487119;5610.438956104357;5615.157726341082;6101.850741495737;6107.908381374283;6115.783375616726;6120.663363515049;6122.846928826726;5694.857628559236;5801.82594522165;5839.737211825478;5846.035404158266;5914.585978981516;5969.104634304802;5969.283685957713;6007;6008.309044459856;6008.519318454513;5930.347661757203;5934.643921364732;5934.940650593525;5937.584369094208;5939.940600593939;5767.279090113736;5838.416158384212;5878.323992740804;5886.911696324559;5966.791162309299;4547.727136371828;4577.382053422745;4578.633709303248;4580.65645076614;4609.654275929319;4030.314846476106;4089.3048181809163;4092.0383709828166;4113.670906327487;4118.876433706993;5517.475839795213;5619.100943848965;5619.381867994599;5630.042892708249;5728.283964504437;6036.9698151508965;6038.486728628028;6042.577019608673;6045.0327947528185;6069.241344831896;5694.971525142348;5705.828825135252;5709.371969083398;5711.057675483498;5716.028275193227;4888.560029597354;4893.681910675795;4902.632302577321;4903.705777653352;4985.227289770091;6141.877162456815;6156.5998210116195;6156.938430615726;6164.352742962014;6169.198004259418;5953.196318497121;5955.493783028491;5957;5959.702014899324;5960.910586341295;5935.614185077956;6137.447629713347;6155.446009859134;6166.630002199882;6257.7184026718;5925.4370834770625;5935.258092738408;5939.970300148471;5941.1088336749835;5941.67320797343;5987.64074155552;6064.363241859542;6065.4541091302;6066.211392518944;6069;5687.260656114679;5811.389804070512;5843.795467158629;5860.326062502696;5951.256092988377;5873.735681894411;5881.3236477803885;5882.411758824083;5888;5892.823215303548;5794.449527294901;5825.970870145622;5837.211976383134;5839.065749480063;5839.386864379179;5757.050086735641;5837.328707198726;5881.9705901470215;5885.323187833454;5978.163057172086;5790.305163380422;5791.0734282514595;5792.768289268382;5795.3625101237985;5798 03:53:02 INFO - PROCESS | 30546 | |1;ext.html;612.1338306296591;626.6021076616348;630.6121735132891;649.8342922554749;651.1730102769486;34575.30849383014;38215.42676859846;46274.76862615687;46894.53105468953;47049.764751176284;49239.26141107886;49650;49700.751496242556;49756.2536561951;49860.750696246556;8349.123342049088;9096.63613455461;9240.353175277733;9253.30600204984;9261.675841345554;8364.539950302762;8654.826903461926;8656.697015604455;10761.515731792088;11064.723381915477;11407.600733974312;11480.598179063734;11485.196036277464;11486.540538378455;11487.770244595104;11152.944235278812;11200.775984480264;11206.103511719042;11207.66377008691;11216.270942388719;11143;11192.720181995433;11211.215214934959;11211.495482703216;11219.439028048564;45780.77109614431;45827.77086114548;46089.76955115236;46176.3073553897;46228.768856155504;3863.594322596115;4172.937405938914;4566.88582785433;4692.131955588193;4748.3589715388325;34743.30513389718;34874.476882846524;35193.712408693355;35663;37150.62849371499;4583.656225783079;4621.445426548802;4622.422197225347;4692.69497482666;4698.130845793505;377671;378151;379058;379141;379780;64460;64921;65031.67484162644;65036.349636503975;65087.34912650908;39641.80179099086;40355.59644403577;40439.393409098884;42861.78569107197;67330.32669673339;17090.230939607747;17242.482725518254;17244.051577163125;17247.310107595807;17266.827331726774;12643.936780316224;12678.683032924251;12710.809337859939;12723.300218487886;12723.427445764777;18785.436436906915;19152.329668461814;19160.90419547893;19524.902375488033;20293.18827246923;7270.672819723125;7301.853962920818;7465.962670186615;7637.19809420014;7765.844683106419;1030.2324768047702;1059.5549869055014;1118.8042092633757;1159.6405114414558;1183.6863231243726;35615.643843561236;36552.26895462129;36763.816180918926;37639.4354084689;38081.23837523234;1120.4957769003981;1159.9966029384523;1172.9589464368705;1183.5325046606542;1193.2244041373003;18201.81798182001;18498.16758245882;18505.629887402178;18568.44294671162;18586.349477768214;553139;555865;555873;556217;557634;64169.679151603945;64510;64694.35305646883;64954;65017.67491162514;1401.2083173007218;1417.5322143692556;1434.6269969807925;1476.0995792566525;1490.3070072416162;32915.50626740649;34458.82770586131;34461;34618.30763384668;34724;56136.719316403156;57221.42778572161;57256.14115788183;57280.71359643175;57694;481219;483109;484289;484371;486889;27548.17355479339;30529.236769080064;30610;31085;31503.842480788368;50981;51202.23196652128;51677;51887.2216916739;52206.47793522168;43218.783906081524;44182;45172.548274516834;45820.083598328514;46778.76610616925;44419.555804441545;44524;45134.54865451303;46179.76910115428;46354.536454635025;43941.340879886186;43955.560444396426;44188.33717494176;44215;44455;37805.81097094497;39804.800975994935;39835.80082099571;40457.39313910235;40657.79671101626;29453.410931781673;29582;29860.402791944474;29918;30066.24834379158 03:53:02 INFO - PROCESS | 30546 | |2;jquery.html;397.7514053716427;419.40025763158707;427.57456330950697;428.95710428957096;447.4988013424962;15743.291551880164;20426.387208383734;20796;20845.16619335225;21599.1360345586;19097.427077187673;19106;19109.426717198472;19111.61776764464;19400.51498712533;5775.422457754223;5879.823605291848;5994.400559944014;6135.110408990694;6176.444120029197;6213.03697926822;6247.125402443661;6248;6250.218722659668;6253.624782513064;6302.4958003359625;6464.676766161697;6533.346665333476;6539.509536784736;6552.639604821733;5856.0630299151935;6060.33336333003;6674.399304062634;6713.160854893138;6713.530052896274;6069.969650151766;6080.513558915276;6081.756729730805;6088.11722300264;6092.878142437171;15141.697166056727;15219.771703424458;15386.230688465645;15512.301946412439;15520.456784012618;2556.6931968163753;2585.4570540186583;2608.739126087395;2618.685757709068;3090.536419537065;11051.336919784839;11186.664400068012;11285;11337.886621133766;11432.657020289322;2005.5086503806515;2030.6141833051672;2122.07689654999;2131.7015617813518;2202.196198387577;64720;67806.66096669534;73543.63228183879;79421;88030.55984720035;11339.603113890975;11483.770324593628;11523.135764817673;11598.536058557733;11693.649190524298;16122.677546449006;16262.51212463628;16305.347786088661;16330.591735206715;16365.263563139688;7964.362850971908;8203;8286.212809783061;8346.791330216793;8433.03020152678;7784.727534536377;7830.882536761953;7905.644246008944;7930.167332430012;7965.4822436541435;4900.877478063006;4952.777125029383;5056.519630635084;5071.797128114834;5210.400803907523;1871.8876867388;2042.428120126367;2074.958500829975;2081.333973128584;2095.319021318078;960.5629438605417;1002.5989604158249;1020.7703266765067;1061.4268295120548;1103.8840921703265;20681.793182068286;20729.27447539329;20833.270835520685;20917.89541052285;20991.895040525003;1036.8652075230173;1039.7972395382828;1042.890496497872;1092.814221582333;1105.5798796457295;10611.681649550526;11381;11395.259308144945;11530.94234528822;11560.190786645022;469101;487326;491902;498196;499168;94709;94786;98872;98927.50536247273;101406;1008.0725732326277;1059.6026490066224;1065.984010239847;1066.4188017530464;1095.2497539185683;17827;18045.729314060038;18095.36666216676;18231.45305640833;18537.53656158607;43540;45155;45172;45500.77249613731;46348;58957.705211473665;61868.38131618626;63498.36501634924;63528;63928;8577.914220857712;8834.95582522109;8908.064653211319;8998.23515001206;9074.727758167266;11459.541618335506;13180.802287965496;13501.257430841399;13581.786297994588;13627.250501222132;11846.466908988943;12008.75982480363;12083.57707480234;12213.75572488563;12236.510539578674;11503;11748.353840538852;11936.045116390495;11963.521459141537;12225.960793332666;12023.21849079807;12042.21725587834;12119.515219391125;12153.939230303791;12206.694832629255;8914.509701966195;8955.328350373878;8990.640374384951;9099.772505687146;9245.630174792934;9480.620775168916;11237.49431275611;11436.94281528587;11821.408929553316;11882.16824822254 03:53:02 INFO - PROCESS | 30546 | |3;mootools.html;1539.5997040769396;1597.7283861743501;1777.1469694546618;1877.6432477829203;1881.0312688965178;9472.85790713139;10231.641892533762;10255.33340332878;10267.589296428143;10268.486575671206;8212.630431630576;8461.942257217848;9351.298652601048;9619.374740641853;9964.153046990996;2499.2627174983377;2527.84832910026;2528.3679080229945;2531.620256961461;2535.21408363407;2493.6259561065804;2560.9231723048247;2566.4225549251455;2570.498752743216;2571.190075126339;2530.1523989463553;2535.822492425531;2567.5250078735494;2567.653366795487;2569.216389001354;2464.3592665906904;2468.4445999650115;2483.6522886795865;2515.4466017476125;2522.936926576832;2455.668484754553;2458.041363868093;2462.938426539333;2466.9753302467107;2497.6628155198996;10032.147267482273;10089.949550252275;10091;10104.343217690826;10164.44095574743;5717.428257174291;5729.169270455803;5776.220210271602;5781.595288329819;5872.647641141545;3485.7734247273847;3617.981910090459;3653;3676.5771936227407;3683.4843121962945;1125.983110253347;1189.2567145534042;1197.3653963399413;1212.6968257935516;1226.5461779141774;14049.08680935746;14106.576802695936;14117.64705882351;14153.858461415357;14164.787528187086;5106.106431374569;5117;5181.481851814864;5228.816991405282;5306.814261500829;11260.324380537195;11353.205275630626;11354.03490703283;11356.659300221007;11367.147463940237;5901.616394934315;5904.7342869570975;5913.172155898178;5915.112733090071;5918.585699001114;4737.45519265282;5311.867203319948;5365.195220716923;5447.4552544746;5536.944630553723;4202.810873510699;4224.5353011168745;4263.4031235627035;4298.828046878152;4359.847405340798;1278.2586100061942;1298.3443361102584;1308.9149205301626;1309.260267948606;1312.2454588611586;911.3711539038175;1040.2510192661273;1052.984205236922;1069.0218450118055;1100.9889901101046;6831.28271531482;6908.1364829396325;6957.791266261919;7042.647867606599;7137.250588688217;499.8825276060123;500.5520059546758;502.4347608939943;508.38231548667807;510.2550276596137;4637.1421287062;4832.855014349575;4841.661083724176;4843.176659967814;4892.779824907888;11669.299842009506;12101.092418068503;12324.383780811102;12633.93683031579;12750.55373061957;12395.566155184526;12430;12431.383920090511;12436.067294952914;12453.93773031129;9172.908270917338;9327.160555550034;9337.43975361467;9346.345755797029;9358.578863951003;6897.206821215625;7051.612161331176;7191.964040179766;7246.565206087652;7355.521891077063;11291.209615326849;11615.245009074382;11782.410879456163;11799.056075513767;11802.645920622395;11718.296902185555;11764.823527647264;11960.76078478443;12003.459844307201;12036.338001410006;7995.2804247618;8688.478691278544;8769.868451973098;8951.41815781972;9130.223930965942;9888;9973;9993.300468967103;9994.350367226398;10003.399796012263;8256.339492840678;8321.41750077513;8322.791930201793;8391.202835730595;8470.068292487698;8643.740687779376;8645.8703119452;8768.736937891874;8769.605367758339;8924.86612700797;8236.546989915612;8252.711155109542;8303.62633681498;8331.750047498585;8371.455855369382;5936.970315148396;5972.70136493165;6102.816915492543;6170.413810687977;6306.936930630818;5866.149408335682;5886.764529418775;5892.911606325994;6162.907556386568;6209.813705588839 03:53:02 INFO - PROCESS | 30546 | |4;prototype.html;359.31191767764733;360.6321552016943;363.79263819622827;365.40074278183766;366.198026322354;5511.9724401378035;5553.8062465326175;5559.499645031946;5574.327701689492;5594.58040646951;5484.780608775644;5516;5521.944780552193;5527.668339899609;5531.368246367321;4191.958080419195;4316.223079845627;4362.25841606926;4376.518582955872;4391.429114215148;4364.2798938175165;4370.366296886949;4373.562643735617;4377.606015458608;4385.101054283864;4339.522652508222;4344.869653910388;4346.261135606955;4354.608085272325;4359.716618419792;4164.208800327928;4346.239408103569;4355.259605867011;4364.541723119059;4370.497392799837;3850.3261929162563;3854.286956912952;3864;3871.8644847430205;3875.1087249932675;5408.215808707755;5414.214938833847;5421.213923981;5423.430539793304;5435.157550579666;4809.735464549449;4848.29699693546;4893.412790465131;4908.509149085098;4956.3804524434445;5740.5981581289325;5749.856253593652;5753.453421924911;5757;5762.222100016486;4122.711410201287;4126.91746165075;4128.504579450485;4130.545639979599;4139.565345638694;5711.8000869969765;5798.246227990377;5834.941650583482;5965.940340596582;5984;4183.707140500197;4183.853565125206;4184.644305234089;4197;4232.407462955189;4317.589828966243;4332.285172946428;4339.262325404688;4362.058883796743;4363.36731173978;4772.403449568804;4930.13722598551;4945.802167913315;4946.9010619787405;5010.772360771634;5768.538516918637;5816.8947899898885;5824.359320474744;5833.154192642043;5833.854153646108;1510.4109397335048;1523.5962469945473;1525.6719805241705;1529.3118096856238;1553.0526378908858;935.5649622925372;971.1793534463367;976.72651657536;977.5063592885547;977.9584742249482;4963.45402005779;5014.598832093424;5019.874503137451;5021.4978502150225;5023.79904803811;5258.264772625024;5272;5283.471652834686;5296.232046353257;5305.4164041955355;4997.000599880039;5021.924671129936;5023.748812559357;5300.734963251822;5690.516306113944;3172.254520187754;3177.1739347769744;3193.0420873737785;3193.473076942325;3194.872205111816;5979.312379076462;6146.477549408351;6161.8125565424525;6167.074938759222;6287.308396076428;6005.39946005396;6012.579119461596;6046.727897244635;6047.78832740852;6050.394960503914;6147.938520614736;6149.723262453201;6157.4458298753325;6159.29168145669;6309.873802524015;5690.3456102548735;5939.732712027882;5968;6011.849703757441;6034.939650603438;5935.605132793877;5950.5239580834295;5951.16683664296;5956.344802071682;5967.6121052131475;5896.321922978741;6129.387061293835;6154.78458253959;6174.14775567337;6210.844728881814;4302.225599392014;4321.395004699281;4348.521183053608;4361.193179261847;4361.280388735823;5806.622569532967;5980.162777211107;6015.345779910384;6036.9094463582205;6042.395760424099;5796.21751063601;5822;5846.269216347957;5849.590528662953;5858.7070646466655;5848.093545500455;5849.245226432138;5850.736716847667;5861.362386925815;5863.970680146572;5494.890102197854;5783.624064435799;5800.24596802413;5807.245058142415;5827.912581311199;5861.794837180678;5871.706414679335;5878.647281163144;5900.406890139724;5902.20320256777;5567.777288908398;5731.226284451545;5738.225339579103;5744.3681195067675;5753.280839895013 03:53:02 INFO - PROCESS | 30546 | |5;yui.html;787.4763282417193;842.359806547024;856.2721686566417;885.9424137431063;906.5104843384572;15933;16702.415415460462;16790.160491975414;16821.327146914125;16839.579010524743;16007.919960400182;16297;16313;16318.102504362256;16350.427735029276;729.5950747335227;871.6949067826273;881.850085485469;902.5622573052065;908.7728067983004;903.0472851142042;903.2051794420901;905.5336501701596;905.728281515546;906.1482206725657;963.2005435488528;964.5177411294353;964.6816550538306;965.290511474066;965.3049804141007;780.6487080813628;927.2165020557618;945.2154711589365;956.93779904306;959.4674955399751;697.6372286411089;703.0614130136274;703.5602748282323;703.7290643102442;704.0600797934763;15727.606809829846;15859;15899.92050039754;15901.1254381009;15920.442784502487;15665.295061722136;15675.686486270211;15749.212539372986;15750;15925.28336224861;14175.787363189458;14324.57026289213;14481.275936203254;14533.854661453355;14666.853331466655;4621.306803979396;4643.117807616542;4660.254359302529;4742.739149346785;4748.145333839908;85820.57089714574;86425;86611;87183;89433.55283223608;12614.306213158181;12739.617811465485;12815.871841281654;12830.16603920742;12850.293233872228;23784;23990.160344387863;24013.399665008514;24098;24264.393390165387;8776.517291548898;8970.596323165473;9010.098990100938;9034.593443295067;9099.363044586815;4910.779014944264;4932.334134891744;4978.551930326288;5014.548690617789;5166.457521960216;3547.8580856765957;3641.2717456508803;3658.798766067892;3659.1949771050326;3661.212839239576;547.5838362844268;613.0589545048418;613.4632196827775;619.0250355689807;621.7450845153465;701.9894701579481;763.8090477380655;801.5110782422718;802.06959926485;819.7704642700054;10389.740256493496;10683.30558513694;10763.569457221623;11085.667429977113;11612.709682257842;722.3101937649532;783.2793829676712;788.0425283280841;798.508917016031;819.3895547816795;4910.410750709866;5283.9471605284225;5287.947120528823;5381.78472861089;5387.218853266255;74872.62563687147;88133;113349.4332528332;129305.35347323203;136021;112072;119166;119336.99999999827;119523;121286;59966.700166498886;61156;62004;93320;98425.50787246018;9135.451872887648;9400.764980875532;9631.747733793998;9683.66107186245;9763.755906102404;39464.60535394609;50598.494015059376;55260.44739552553;55560;55876;58380.12429813641;65804;75243;78050.6097469509;81577;14188.503402380868;14343.784843227151;14522.20127892976;14975.850241497446;14993.625159370667;15198.392064317304;16121.75817362717;16205.59486012859;16796.58008549796;17661;12581.685457863627;13386.598402047954;13473.663158421117;14475.710485790436;15511.76732348993;13965.58103256904;13988;14243.501477448239;14276.143431393733;14508.492202772852;14212.289385530476;14400.855991439952;14794.334254958338;14903.254837258311;16048.358065677243;11571.710707232387;11850.229735067192;11899.524019039141;12002.57476036262;12107.370072915784;11527.365994870363;11768.054002236751;11920.76158476843;12085.939570302093;12270.509179632714 03:53:02 INFO - PROCESS | 30546 | __end_tp_report 03:53:02 INFO - PROCESS | 30546 | __start_cc_report 03:53:02 INFO - PROCESS | 30546 | _x_x_mozilla_cycle_collect,1034 03:53:02 INFO - PROCESS | 30546 | __end_cc_report 03:53:02 INFO - PROCESS | 30546 | __startTimestamp1470480782929__endTimestamp 03:53:02 INFO - PROCESS | 30546 | 03:53:02 INFO - PROCESS | 30546 | ------- Summary: start ------- 03:53:02 INFO - PROCESS | 30546 | Number of tests: 6 03:53:02 INFO - PROCESS | 30546 | 03:53:02 INFO - PROCESS | 30546 | [#0] dojo.html Cycles:165 Average:5546.73 Median:5794.45 stddev:633.97 (10.9%) stddev-sans-first:608.39 03:53:02 INFO - PROCESS | 30546 | Values: 3191.3 3210.7 3210.7 3239.1 3260.1 5481.7 5555.1 5568.5 5586.7 5610.0 5556.8 5613.1 5645.2 5669.1 5686.5 5029.5 5039.9 5116.4 5145.7 5202.8 5082.5 5163.9 5167.8 5168.5 5172.2 5016.6 5031.4 5040.1 5056.0 5158.0 5124.4 5128.8 5134.6 5148.8 5189.3 4956.8 4981.3 5034.4 5043.7 5044.1 5450.4 5472.6 5490.1 5521.7 5531.0 5996.7 6000.3 6000.5 6002.7 6017.7 5817.7 5894.4 5939.4 5944.9 6033.4 5581.9 5598.1 5609.6 5610.4 5615.2 6101.9 6107.9 6115.8 6120.7 6122.8 5694.9 5801.8 5839.7 5846.0 5914.6 5969.1 5969.3 6007.0 6008.3 6008.5 5930.3 5934.6 5934.9 5937.6 5939.9 5767.3 5838.4 5878.3 5886.9 5966.8 4547.7 4577.4 4578.6 4580.7 4609.7 4030.3 4089.3 4092.0 4113.7 4118.9 5517.5 5619.1 5619.4 5630.0 5728.3 6037.0 6038.5 6042.6 6045.0 6069.2 5695.0 5705.8 5709.4 5711.1 5716.0 4888.6 4893.7 4902.6 4903.7 4985.2 6141.9 6156.6 6156.9 6164.4 6169.2 5953.2 5955.5 5957.0 5959.7 5960.9 5935.6 6137.4 6155.4 6166.6 6257.7 5925.4 5935.3 5940.0 5941.1 5941.7 5987.6 6064.4 6065.5 6066.2 6069.0 5687.3 5811.4 5843.8 5860.3 5951.3 5873.7 5881.3 5882.4 5888.0 5892.8 5794.4 5826.0 5837.2 5839.1 5839.4 5757.1 5837.3 5882.0 5885.3 5978.2 5790.3 5791.1 5792.8 5795.4 5798.0 03:53:02 INFO - PROCESS | 30546 | 03:53:02 INFO - PROCESS | 30546 | [#1] ext.html Cycles:180 Average:64532.39 Median:40448.39 stddev:126696.88 (313.2%) stddev-sans-first:126961.40 03:53:02 INFO - PROCESS | 30546 | Values: 612.1 626.6 630.6 649.8 651.2 34575.3 38215.4 46274.8 46894.5 47049.8 49239.3 49650.0 49700.8 49756.3 49860.8 8349.1 9096.6 9240.4 9253.3 9261.7 8364.5 8654.8 8656.7 10761.5 11064.7 11407.6 11480.6 11485.2 11486.5 11487.8 11152.9 11200.8 11206.1 11207.7 11216.3 11143.0 11192.7 11211.2 11211.5 11219.4 45780.8 45827.8 46089.8 46176.3 46228.8 3863.6 4172.9 4566.9 4692.1 4748.4 34743.3 34874.5 35193.7 35663.0 37150.6 4583.7 4621.4 4622.4 4692.7 4698.1 377671.0 378151.0 379058.0 379141.0 379780.0 64460.0 64921.0 65031.7 65036.3 65087.3 39641.8 40355.6 40439.4 42861.8 67330.3 17090.2 17242.5 17244.1 17247.3 17266.8 12643.9 12678.7 12710.8 12723.3 12723.4 18785.4 19152.3 19160.9 19524.9 20293.2 7270.7 7301.9 7466.0 7637.2 7765.8 1030.2 1059.6 1118.8 1159.6 1183.7 35615.6 36552.3 36763.8 37639.4 38081.2 1120.5 1160.0 1173.0 1183.5 1193.2 18201.8 18498.2 18505.6 18568.4 18586.3 553139.0 555865.0 555873.0 556217.0 557634.0 64169.7 64510.0 64694.4 64954.0 65017.7 1401.2 1417.5 1434.6 1476.1 1490.3 32915.5 34458.8 34461.0 34618.3 34724.0 56136.7 57221.4 57256.1 57280.7 57694.0 481219.0 483109.0 484289.0 484371.0 486889.0 27548.2 30529.2 30610.0 31085.0 31503.8 50981.0 51202.2 51677.0 51887.2 52206.5 43218.8 44182.0 45172.5 45820.1 46778.8 44419.6 44524.0 45134.5 46179.8 46354.5 43941.3 43955.6 44188.3 44215.0 44455.0 37805.8 39804.8 39835.8 40457.4 40657.8 29453.4 29582.0 29860.4 29918.0 30066.2 03:53:02 INFO - PROCESS | 30546 | 03:53:02 INFO - PROCESS | 30546 | [#2] jquery.html Cycles:180 Average:29272.65 Median:2126.89 stddev:80734.78 (3795.9%) stddev-sans-first:80932.15 03:53:02 INFO - PROCESS | 30546 | Values: 397.8 419.4 427.6 429.0 447.5 15743.3 20426.4 20796.0 20845.2 21599.1 19097.4 19106.0 19109.4 19111.6 19400.5 5775.4 5879.8 5994.4 6135.1 6176.4 6213.0 6247.1 6248.0 6250.2 6253.6 6302.5 6464.7 6533.3 6539.5 6552.6 5856.1 6060.3 6674.4 6713.2 6713.5 6070.0 6080.5 6081.8 6088.1 6092.9 15141.7 15219.8 15386.2 15512.3 15520.5 2556.7 2585.5 2608.7 2618.7 3090.5 11051.3 11186.7 11285.0 11337.9 11432.7 2005.5 2030.6 2122.1 2131.7 2202.2 64720.0 67806.7 73543.6 79421.0 88030.6 11339.6 11483.8 11523.1 11598.5 11693.6 16122.7 16262.5 16305.3 16330.6 16365.3 7964.4 8203.0 8286.2 8346.8 8433.0 7784.7 7830.9 7905.6 7930.2 7965.5 4900.9 4952.8 5056.5 5071.8 5210.4 1871.9 2042.4 2075.0 2081.3 2095.3 960.6 1002.6 1020.8 1061.4 1103.9 20681.8 20729.3 20833.3 20917.9 20991.9 1036.9 1039.8 1042.9 1092.8 1105.6 10611.7 11381.0 11395.3 11530.9 11560.2 469101.0 487326.0 491902.0 498196.0 499168.0 94709.0 94786.0 98872.0 98927.5 101406.0 1008.1 1059.6 1066.0 1066.4 1095.2 17827.0 18045.7 18095.4 18231.5 18537.5 43540.0 45155.0 45172.0 45500.8 46348.0 58957.7 61868.4 63498.4 63528.0 63928.0 8577.9 8835.0 8908.1 8998.2 9074.7 11459.5 13180.8 13501.3 13581.8 13627.3 11846.5 12008.8 12083.6 12213.8 12236.5 11503.0 11748.4 11936.0 11963.5 12226.0 12023.2 12042.2 12119.5 12153.9 12206.7 8914.5 8955.3 8990.6 9099.8 9245.6 9480.6 11237.5 11436.9 11821.4 11882.2 03:53:02 INFO - PROCESS | 30546 | 03:53:02 INFO - PROCESS | 30546 | [#3] mootools.html Cycles:180 Average:6552.24 Median:4243.97 stddev:3813.19 (89.8%) stddev-sans-first:3805.28 03:53:02 INFO - PROCESS | 30546 | Values: 1539.6 1597.7 1777.1 1877.6 1881.0 9472.9 10231.6 10255.3 10267.6 10268.5 8212.6 8461.9 9351.3 9619.4 9964.2 2499.3 2527.8 2528.4 2531.6 2535.2 2493.6 2560.9 2566.4 2570.5 2571.2 2530.2 2535.8 2567.5 2567.7 2569.2 2464.4 2468.4 2483.7 2515.4 2522.9 2455.7 2458.0 2462.9 2467.0 2497.7 10032.1 10089.9 10091.0 10104.3 10164.4 5717.4 5729.2 5776.2 5781.6 5872.6 3485.8 3618.0 3653.0 3676.6 3683.5 1126.0 1189.3 1197.4 1212.7 1226.5 14049.1 14106.6 14117.6 14153.9 14164.8 5106.1 5117.0 5181.5 5228.8 5306.8 11260.3 11353.2 11354.0 11356.7 11367.1 5901.6 5904.7 5913.2 5915.1 5918.6 4737.5 5311.9 5365.2 5447.5 5536.9 4202.8 4224.5 4263.4 4298.8 4359.8 1278.3 1298.3 1308.9 1309.3 1312.2 911.4 1040.3 1053.0 1069.0 1101.0 6831.3 6908.1 6957.8 7042.6 7137.3 499.9 500.6 502.4 508.4 510.3 4637.1 4832.9 4841.7 4843.2 4892.8 11669.3 12101.1 12324.4 12633.9 12750.6 12395.6 12430.0 12431.4 12436.1 12453.9 9172.9 9327.2 9337.4 9346.3 9358.6 6897.2 7051.6 7192.0 7246.6 7355.5 11291.2 11615.2 11782.4 11799.1 11802.6 11718.3 11764.8 11960.8 12003.5 12036.3 7995.3 8688.5 8769.9 8951.4 9130.2 9888.0 9973.0 9993.3 9994.4 10003.4 8256.3 8321.4 8322.8 8391.2 8470.1 8643.7 8645.9 8768.7 8769.6 8924.9 8236.5 8252.7 8303.6 8331.8 8371.5 5937.0 5972.7 6102.8 6170.4 6306.9 5866.1 5886.8 5892.9 6162.9 6209.8 03:53:02 INFO - PROCESS | 30546 | 03:53:02 INFO - PROCESS | 30546 | [#4] prototype.html Cycles:180 Average:4857.54 Median:5503.43 stddev:1415.39 (25.7%) stddev-sans-first:1378.50 03:53:02 INFO - PROCESS | 30546 | Values: 359.3 360.6 363.8 365.4 366.2 5512.0 5553.8 5559.5 5574.3 5594.6 5484.8 5516.0 5521.9 5527.7 5531.4 4192.0 4316.2 4362.3 4376.5 4391.4 4364.3 4370.4 4373.6 4377.6 4385.1 4339.5 4344.9 4346.3 4354.6 4359.7 4164.2 4346.2 4355.3 4364.5 4370.5 3850.3 3854.3 3864.0 3871.9 3875.1 5408.2 5414.2 5421.2 5423.4 5435.2 4809.7 4848.3 4893.4 4908.5 4956.4 5740.6 5749.9 5753.5 5757.0 5762.2 4122.7 4126.9 4128.5 4130.5 4139.6 5711.8 5798.2 5834.9 5965.9 5984.0 4183.7 4183.9 4184.6 4197.0 4232.4 4317.6 4332.3 4339.3 4362.1 4363.4 4772.4 4930.1 4945.8 4946.9 5010.8 5768.5 5816.9 5824.4 5833.2 5833.9 1510.4 1523.6 1525.7 1529.3 1553.1 935.6 971.2 976.7 977.5 978.0 4963.5 5014.6 5019.9 5021.5 5023.8 5258.3 5272.0 5283.5 5296.2 5305.4 4997.0 5021.9 5023.7 5300.7 5690.5 3172.3 3177.2 3193.0 3193.5 3194.9 5979.3 6146.5 6161.8 6167.1 6287.3 6005.4 6012.6 6046.7 6047.8 6050.4 6147.9 6149.7 6157.4 6159.3 6309.9 5690.3 5939.7 5968.0 6011.8 6034.9 5935.6 5950.5 5951.2 5956.3 5967.6 5896.3 6129.4 6154.8 6174.1 6210.8 4302.2 4321.4 4348.5 4361.2 4361.3 5806.6 5980.2 6015.3 6036.9 6042.4 5796.2 5822.0 5846.3 5849.6 5858.7 5848.1 5849.2 5850.7 5861.4 5864.0 5494.9 5783.6 5800.2 5807.2 5827.9 5861.8 5871.7 5878.6 5900.4 5902.2 5567.8 5731.2 5738.2 5744.4 5753.3 03:53:02 INFO - PROCESS | 30546 | 03:53:02 INFO - PROCESS | 30546 | [#5] yui.html Cycles:180 Average:21685.18 Median:4651.69 stddev:31054.14 (667.6%) stddev-sans-first:31101.61 03:53:02 INFO - PROCESS | 30546 | Values: 787.5 842.4 856.3 885.9 906.5 15933.0 16702.4 16790.2 16821.3 16839.6 16007.9 16297.0 16313.0 16318.1 16350.4 729.6 871.7 881.9 902.6 908.8 903.0 903.2 905.5 905.7 906.1 963.2 964.5 964.7 965.3 965.3 780.6 927.2 945.2 956.9 959.5 697.6 703.1 703.6 703.7 704.1 15727.6 15859.0 15899.9 15901.1 15920.4 15665.3 15675.7 15749.2 15750.0 15925.3 14175.8 14324.6 14481.3 14533.9 14666.9 4621.3 4643.1 4660.3 4742.7 4748.1 85820.6 86425.0 86611.0 87183.0 89433.6 12614.3 12739.6 12815.9 12830.2 12850.3 23784.0 23990.2 24013.4 24098.0 24264.4 8776.5 8970.6 9010.1 9034.6 9099.4 4910.8 4932.3 4978.6 5014.5 5166.5 3547.9 3641.3 3658.8 3659.2 3661.2 547.6 613.1 613.5 619.0 621.7 702.0 763.8 801.5 802.1 819.8 10389.7 10683.3 10763.6 11085.7 11612.7 722.3 783.3 788.0 798.5 819.4 4910.4 5283.9 5287.9 5381.8 5387.2 74872.6 88133.0 113349.4 129305.4 136021.0 112072.0 119166.0 119337.0 119523.0 121286.0 59966.7 61156.0 62004.0 93320.0 98425.5 9135.5 9400.8 9631.7 9683.7 9763.8 39464.6 50598.5 55260.4 55560.0 55876.0 58380.1 65804.0 75243.0 78050.6 81577.0 14188.5 14343.8 14522.2 14975.9 14993.6 15198.4 16121.8 16205.6 16796.6 17661.0 12581.7 13386.6 13473.7 14475.7 15511.8 13965.6 13988.0 14243.5 14276.1 14508.5 14212.3 14400.9 14794.3 14903.3 16048.4 11571.7 11850.2 11899.5 12002.6 12107.4 11527.4 11768.1 11920.8 12085.9 12270.5 03:53:02 INFO - PROCESS | 30546 | -------- Summary: end -------- 03:53:02 INFO - PROCESS | 30546 | 03:53:03 INFO - TEST-INFO | 30546: exit 0 03:53:03 INFO - TEST-OK | dromaeo_css | took 1112873ms 03:53:03 INFO - TEST-START | kraken 03:53:03 INFO - operating with platform_type : linux_ 03:53:03 INFO - Initialising browser for kraken test... 03:53:03 INFO - TEST-INFO | started process 30745 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiaFUrw/profile http://localhost:53713/getInfo.html) 03:53:07 INFO - PROCESS | 30745 | __metrics Screen width/height:1600/1200 03:53:07 INFO - PROCESS | 30745 | colorDepth:24 03:53:07 INFO - PROCESS | 30745 | Browser inner width/height: 1024/697 03:53:07 INFO - PROCESS | 30745 | __metrics 03:53:08 INFO - PROCESS | 30745 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:53:08 INFO - PROCESS | 30745 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:53:09 INFO - TEST-INFO | 30745: exit 0 03:53:09 INFO - Browser initialized. 03:53:09 INFO - Running cycle 1/1 for kraken test... 03:53:09 INFO - TEST-INFO | started process 30831 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiaFUrw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:53:20 INFO - PROCESS | 30831 | RSS: Main: 145727488 03:53:20 INFO - PROCESS | 30831 | 03:53:23 INFO - PROCESS | 30831 | Cycle 1(1): loaded http://localhost:53713/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53713/tests/kraken/driver.html?testName=audio-beat-detection) 03:53:24 INFO - PROCESS | 30831 | RSS: Main: 190877696 03:53:24 INFO - PROCESS | 30831 | 03:53:26 INFO - PROCESS | 30831 | Cycle 1(1): loaded http://localhost:53713/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53713/tests/kraken/driver.html?testName=audio-dft) 03:53:27 INFO - PROCESS | 30831 | RSS: Main: 180932608 03:53:27 INFO - PROCESS | 30831 | 03:53:30 INFO - PROCESS | 30831 | Cycle 1(1): loaded http://localhost:53713/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53713/tests/kraken/driver.html?testName=audio-fft) 03:53:30 INFO - PROCESS | 30831 | RSS: Main: 269012992 03:53:30 INFO - PROCESS | 30831 | 03:53:32 INFO - PROCESS | 30831 | Cycle 1(1): loaded http://localhost:53713/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53713/tests/kraken/driver.html?testName=audio-oscillator) 03:53:33 INFO - PROCESS | 30831 | RSS: Main: 176168960 03:53:33 INFO - PROCESS | 30831 | 03:53:35 INFO - PROCESS | 30831 | Cycle 1(1): loaded http://localhost:53713/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53713/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:53:36 INFO - PROCESS | 30831 | RSS: Main: 177500160 03:53:36 INFO - PROCESS | 30831 | 03:53:39 INFO - PROCESS | 30831 | Cycle 1(1): loaded http://localhost:53713/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53713/tests/kraken/driver.html?testName=imaging-darkroom) 03:53:39 INFO - PROCESS | 30831 | RSS: Main: 212971520 03:53:39 INFO - PROCESS | 30831 | 03:53:43 INFO - PROCESS | 30831 | Cycle 1(1): loaded http://localhost:53713/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53713/tests/kraken/driver.html?testName=imaging-desaturate) 03:53:43 INFO - PROCESS | 30831 | RSS: Main: 211959808 03:53:43 INFO - PROCESS | 30831 | 03:53:46 INFO - PROCESS | 30831 | Cycle 1(1): loaded http://localhost:53713/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53713/tests/kraken/driver.html?testName=json-parse-financial) 03:53:47 INFO - PROCESS | 30831 | RSS: Main: 212074496 03:53:47 INFO - PROCESS | 30831 | 03:53:48 INFO - PROCESS | 30831 | Cycle 1(1): loaded http://localhost:53713/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53713/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:53:49 INFO - PROCESS | 30831 | RSS: Main: 175644672 03:53:49 INFO - PROCESS | 30831 | 03:53:50 INFO - PROCESS | 30831 | Cycle 1(1): loaded http://localhost:53713/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53713/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:53:51 INFO - PROCESS | 30831 | RSS: Main: 181137408 03:53:51 INFO - PROCESS | 30831 | 03:53:53 INFO - PROCESS | 30831 | Cycle 1(1): loaded http://localhost:53713/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53713/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:53:54 INFO - PROCESS | 30831 | RSS: Main: 186601472 03:53:54 INFO - PROCESS | 30831 | 03:53:56 INFO - PROCESS | 30831 | Cycle 1(1): loaded http://localhost:53713/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53713/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:53:57 INFO - PROCESS | 30831 | RSS: Main: 181575680 03:53:57 INFO - PROCESS | 30831 | 03:53:59 INFO - PROCESS | 30831 | Cycle 1(1): loaded http://localhost:53713/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53713/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:54:00 INFO - PROCESS | 30831 | RSS: Main: 184877056 03:54:00 INFO - PROCESS | 30831 | 03:54:01 INFO - PROCESS | 30831 | Cycle 1(1): loaded http://localhost:53713/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53713/tests/kraken/driver.html?testName=ai-astar) 03:54:02 INFO - PROCESS | 30831 | RSS: Main: 235741184 03:54:02 INFO - PROCESS | 30831 | 03:54:02 INFO - PROCESS | 30831 | __start_tp_report 03:54:02 INFO - PROCESS | 30831 | _x_x_mozilla_page_load 03:54:02 INFO - PROCESS | 30831 | _x_x_mozilla_page_load_details 03:54:02 INFO - PROCESS | 30831 | |i|pagename|runs| 03:54:02 INFO - PROCESS | 30831 | |0;ai-astar;100;110;109;109;111;110;109;109;108;110 03:54:02 INFO - PROCESS | 30831 | |1;audio-beat-detection;142;113;120;172;116;117;141;115;160;116 03:54:02 INFO - PROCESS | 30831 | |2;audio-dft;160;159;161;162;163;162;161;162;160;162 03:54:02 INFO - PROCESS | 30831 | |3;audio-fft;75;75;76;125;75;74;73;74;106;74 03:54:02 INFO - PROCESS | 30831 | |4;audio-oscillator;83;83;114;82;82;82;114;83;83;128 03:54:02 INFO - PROCESS | 30831 | |5;imaging-gaussian-blur;116;117;116;117;116;117;118;117;117;117 03:54:02 INFO - PROCESS | 30831 | |6;imaging-darkroom;146;146;145;145;146;145;145;145;145;146 03:54:02 INFO - PROCESS | 30831 | |7;imaging-desaturate;95;95;95;95;94;95;94;95;95;95 03:54:02 INFO - PROCESS | 30831 | |8;json-parse-financial;52;51;50;51;50;50;50;49;51;49 03:54:02 INFO - PROCESS | 30831 | |9;json-stringify-tinderbox;60;62;59;60;60;60;60;60;59;61 03:54:02 INFO - PROCESS | 30831 | |10;stanford-crypto-aes;77;72;72;80;74;71;71;71;71;72 03:54:02 INFO - PROCESS | 30831 | |11;stanford-crypto-ccm;135;121;118;127;120;120;127;120;151;120 03:54:02 INFO - PROCESS | 30831 | |12;stanford-crypto-pbkdf2;151;153;150;149;149;152;150;149;148;148 03:54:02 INFO - PROCESS | 30831 | |13;stanford-crypto-sha256-iterative;60;65;63;60;61;62;60;59;62;59 03:54:02 INFO - PROCESS | 30831 | __end_tp_report 03:54:02 INFO - PROCESS | 30831 | __start_cc_report 03:54:02 INFO - PROCESS | 30831 | _x_x_mozilla_cycle_collect,1582 03:54:02 INFO - PROCESS | 30831 | __end_cc_report 03:54:02 INFO - PROCESS | 30831 | __startTimestamp1470480842195__endTimestamp 03:54:02 INFO - PROCESS | 30831 | 03:54:02 INFO - PROCESS | 30831 | ------- Summary: start ------- 03:54:02 INFO - PROCESS | 30831 | Number of tests: 14 03:54:02 INFO - PROCESS | 30831 | 03:54:02 INFO - PROCESS | 30831 | [#0] ai-astar Cycles:10 Average:108.50 Median:109.50 stddev:3.10 (2.8%) stddev-sans-first:0.88 03:54:02 INFO - PROCESS | 30831 | Values: 100.0 110.0 109.0 109.0 111.0 110.0 109.0 109.0 108.0 110.0 03:54:02 INFO - PROCESS | 30831 | 03:54:02 INFO - PROCESS | 30831 | [#1] audio-beat-detection Cycles:10 Average:131.20 Median:130.50 stddev:21.32 (16.3%) stddev-sans-first:22.25 03:54:02 INFO - PROCESS | 30831 | Values: 142.0 113.0 120.0 172.0 116.0 117.0 141.0 115.0 160.0 116.0 03:54:02 INFO - PROCESS | 30831 | 03:54:02 INFO - PROCESS | 30831 | [#2] audio-dft Cycles:10 Average:161.20 Median:162.00 stddev:1.23 (0.8%) stddev-sans-first:1.22 03:54:02 INFO - PROCESS | 30831 | Values: 160.0 159.0 161.0 162.0 163.0 162.0 161.0 162.0 160.0 162.0 03:54:02 INFO - PROCESS | 30831 | 03:54:02 INFO - PROCESS | 30831 | [#3] audio-fft Cycles:10 Average:82.70 Median:74.50 stddev:17.88 (24.0%) stddev-sans-first:18.74 03:54:02 INFO - PROCESS | 30831 | Values: 75.0 75.0 76.0 125.0 75.0 74.0 73.0 74.0 106.0 74.0 03:54:02 INFO - PROCESS | 30831 | 03:54:02 INFO - PROCESS | 30831 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:82.50 stddev:17.85 (21.6%) stddev-sans-first:18.53 03:54:02 INFO - PROCESS | 30831 | Values: 83.0 83.0 114.0 82.0 82.0 82.0 114.0 83.0 83.0 128.0 03:54:02 INFO - PROCESS | 30831 | 03:54:02 INFO - PROCESS | 30831 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 03:54:02 INFO - PROCESS | 30831 | Values: 116.0 117.0 116.0 117.0 116.0 117.0 118.0 117.0 117.0 117.0 03:54:02 INFO - PROCESS | 30831 | 03:54:02 INFO - PROCESS | 30831 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 03:54:02 INFO - PROCESS | 30831 | Values: 146.0 146.0 145.0 145.0 146.0 145.0 145.0 145.0 145.0 146.0 03:54:02 INFO - PROCESS | 30831 | 03:54:02 INFO - PROCESS | 30831 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:54:02 INFO - PROCESS | 30831 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 03:54:02 INFO - PROCESS | 30831 | 03:54:02 INFO - PROCESS | 30831 | [#8] json-parse-financial Cycles:10 Average:50.30 Median:50.50 stddev:0.95 (1.9%) stddev-sans-first:0.78 03:54:02 INFO - PROCESS | 30831 | Values: 52.0 51.0 50.0 51.0 50.0 50.0 50.0 49.0 51.0 49.0 03:54:02 INFO - PROCESS | 30831 | 03:54:02 INFO - PROCESS | 30831 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:0.88 (1.5%) stddev-sans-first:0.93 03:54:02 INFO - PROCESS | 30831 | Values: 60.0 62.0 59.0 60.0 60.0 60.0 60.0 60.0 59.0 61.0 03:54:02 INFO - PROCESS | 30831 | 03:54:02 INFO - PROCESS | 30831 | [#10] stanford-crypto-aes Cycles:10 Average:73.10 Median:72.00 stddev:3.07 (4.3%) stddev-sans-first:2.92 03:54:02 INFO - PROCESS | 30831 | Values: 77.0 72.0 72.0 80.0 74.0 71.0 71.0 71.0 71.0 72.0 03:54:02 INFO - PROCESS | 30831 | 03:54:02 INFO - PROCESS | 30831 | [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:124.00 stddev:10.22 (8.2%) stddev-sans-first:10.30 03:54:02 INFO - PROCESS | 30831 | Values: 135.0 121.0 118.0 127.0 120.0 120.0 127.0 120.0 151.0 120.0 03:54:02 INFO - PROCESS | 30831 | 03:54:02 INFO - PROCESS | 30831 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.90 Median:150.00 stddev:1.66 (1.1%) stddev-sans-first:1.72 03:54:02 INFO - PROCESS | 30831 | Values: 151.0 153.0 150.0 149.0 149.0 152.0 150.0 149.0 148.0 148.0 03:54:02 INFO - PROCESS | 30831 | 03:54:02 INFO - PROCESS | 30831 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.10 Median:61.50 stddev:1.91 (3.1%) stddev-sans-first:1.99 03:54:02 INFO - PROCESS | 30831 | Values: 60.0 65.0 63.0 60.0 61.0 62.0 60.0 59.0 62.0 59.0 03:54:02 INFO - PROCESS | 30831 | -------- Summary: end -------- 03:54:02 INFO - PROCESS | 30831 | 03:54:03 INFO - TEST-INFO | 30831: exit 0 03:54:03 INFO - TEST-OK | kraken | took 59428ms 03:54:03 INFO - SUITE-END | took 1172s 03:54:03 INFO - Completed test suite (00:19:32) 03:54:03 INFO - javascript benchmark 03:54:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3191.2819615586495, 3210.7270881975032, 3210.7270881975032, 3239.0930539448964, 3260.070879799258, 5481.698506582136, 5555.083411237146, 5568.470995255454, 5586.720663966806, 5609.9999999999945, 5556.805511807088, 5613.101903695409, 5645.237892884459, 5669.149627555868, 5686.4597863203035, 5029.547340739333, 5039.924401133986, 5116.360454943132, 5145.716985565792, 5202.8179013734525, 5082.517160869711, 5163.870903227431, 5167.7932882684645, 5168.53483186515, 5172.172452407615, 5016.573591244749, 5031.421386540558, 5040.117979353617, 5056.0, 5158.0, 5124.385073791132, 5128.769205385766, 5134.589232861362, 5148.794048238066, 5189.299444574972, 4956.826511072095, 4981.32752078472, 5034.370703662043, 5043.722595257259, 5044.142495775727, 5450.400455949882, 5472.644278121909, 5490.094134467808, 5521.668699878021, 5531.032069387881, 5996.730147143389, 6000.309964354068, 6000.519958403317, 6002.669853158074, 6017.729202185868, 5817.7382017809305, 5894.3810899855325, 5939.435753603444, 5944.881102377928, 6033.366496517846, 5581.888362232733, 5598.076317407623, 5609.607327487119, 5610.438956104357, 5615.157726341082, 6101.850741495737, 6107.908381374283, 6115.783375616726, 6120.663363515049, 6122.846928826726, 5694.857628559236, 5801.82594522165, 5839.737211825478, 5846.035404158266, 5914.585978981516, 5969.104634304802, 5969.283685957713, 6007.0, 6008.309044459856, 6008.519318454513, 5930.347661757203, 5934.643921364732, 5934.940650593525, 5937.584369094208, 5939.940600593939, 5767.279090113736, 5838.416158384212, 5878.323992740804, 5886.911696324559, 5966.791162309299, 4547.727136371828, 4577.382053422745, 4578.633709303248, 4580.65645076614, 4609.654275929319, 4030.314846476106, 4089.3048181809163, 4092.0383709828166, 4113.670906327487, 4118.876433706993, 5517.475839795213, 5619.100943848965, 5619.381867994599, 5630.042892708249, 5728.283964504437, 6036.9698151508965, 6038.486728628028, 6042.577019608673, 6045.0327947528185, 6069.241344831896, 5694.971525142348, 5705.828825135252, 5709.371969083398, 5711.057675483498, 5716.028275193227, 4888.560029597354, 4893.681910675795, 4902.632302577321, 4903.705777653352, 4985.227289770091, 6141.877162456815, 6156.5998210116195, 6156.938430615726, 6164.352742962014, 6169.198004259418, 5953.196318497121, 5955.493783028491, 5957.0, 5959.702014899324, 5960.910586341295, 5935.614185077956, 6137.447629713347, 6155.446009859134, 6166.630002199882, 6257.7184026718, 5925.4370834770625, 5935.258092738408, 5939.970300148471, 5941.1088336749835, 5941.67320797343, 5987.64074155552, 6064.363241859542, 6065.4541091302, 6066.211392518944, 6069.0, 5687.260656114679, 5811.389804070512, 5843.795467158629, 5860.326062502696, 5951.256092988377, 5873.735681894411, 5881.3236477803885, 5882.411758824083, 5888.0, 5892.823215303548, 5794.449527294901, 5825.970870145622, 5837.211976383134, 5839.065749480063, 5839.386864379179, 5757.050086735641, 5837.328707198726, 5881.9705901470215, 5885.323187833454, 5978.163057172086, 5790.305163380422, 5791.0734282514595, 5792.768289268382, 5795.3625101237985, 5798.0], "value": 5503.559690320035, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.1338306296591, 626.6021076616348, 630.6121735132891, 649.8342922554749, 651.1730102769486, 34575.30849383014, 38215.42676859846, 46274.76862615687, 46894.53105468953, 47049.764751176284, 49239.26141107886, 49650.0, 49700.751496242556, 49756.2536561951, 49860.750696246556, 8349.123342049088, 9096.63613455461, 9240.353175277733, 9253.30600204984, 9261.675841345554, 8364.539950302762, 8654.826903461926, 8656.697015604455, 10761.515731792088, 11064.723381915477, 11407.600733974312, 11480.598179063734, 11485.196036277464, 11486.540538378455, 11487.770244595104, 11152.944235278812, 11200.775984480264, 11206.103511719042, 11207.66377008691, 11216.270942388719, 11143.0, 11192.720181995433, 11211.215214934959, 11211.495482703216, 11219.439028048564, 45780.77109614431, 45827.77086114548, 46089.76955115236, 46176.3073553897, 46228.768856155504, 3863.594322596115, 4172.937405938914, 4566.88582785433, 4692.131955588193, 4748.3589715388325, 34743.30513389718, 34874.476882846524, 35193.712408693355, 35663.0, 37150.62849371499, 4583.656225783079, 4621.445426548802, 4622.422197225347, 4692.69497482666, 4698.130845793505, 377671.0, 378151.0, 379058.0, 379141.0, 379780.0, 64460.0, 64921.0, 65031.67484162644, 65036.349636503975, 65087.34912650908, 39641.80179099086, 40355.59644403577, 40439.393409098884, 42861.78569107197, 67330.32669673339, 17090.230939607747, 17242.482725518254, 17244.051577163125, 17247.310107595807, 17266.827331726774, 12643.936780316224, 12678.683032924251, 12710.809337859939, 12723.300218487886, 12723.427445764777, 18785.436436906915, 19152.329668461814, 19160.90419547893, 19524.902375488033, 20293.18827246923, 7270.672819723125, 7301.853962920818, 7465.962670186615, 7637.19809420014, 7765.844683106419, 1030.2324768047702, 1059.5549869055014, 1118.8042092633757, 1159.6405114414558, 1183.6863231243726, 35615.643843561236, 36552.26895462129, 36763.816180918926, 37639.4354084689, 38081.23837523234, 1120.4957769003981, 1159.9966029384523, 1172.9589464368705, 1183.5325046606542, 1193.2244041373003, 18201.81798182001, 18498.16758245882, 18505.629887402178, 18568.44294671162, 18586.349477768214, 553139.0, 555865.0, 555873.0, 556217.0, 557634.0, 64169.679151603945, 64510.0, 64694.35305646883, 64954.0, 65017.67491162514, 1401.2083173007218, 1417.5322143692556, 1434.6269969807925, 1476.0995792566525, 1490.3070072416162, 32915.50626740649, 34458.82770586131, 34461.0, 34618.30763384668, 34724.0, 56136.719316403156, 57221.42778572161, 57256.14115788183, 57280.71359643175, 57694.0, 481219.0, 483109.0, 484289.0, 484371.0, 486889.0, 27548.17355479339, 30529.236769080064, 30610.0, 31085.0, 31503.842480788368, 50981.0, 51202.23196652128, 51677.0, 51887.2216916739, 52206.47793522168, 43218.783906081524, 44182.0, 45172.548274516834, 45820.083598328514, 46778.76610616925, 44419.555804441545, 44524.0, 45134.54865451303, 46179.76910115428, 46354.536454635025, 43941.340879886186, 43955.560444396426, 44188.33717494176, 44215.0, 44455.0, 37805.81097094497, 39804.800975994935, 39835.80082099571, 40457.39313910235, 40657.79671101626, 29453.410931781673, 29582.0, 29860.402791944474, 29918.0, 30066.24834379158], "value": 21765.647009394852, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.7514053716427, 419.40025763158707, 427.57456330950697, 428.95710428957096, 447.4988013424962, 15743.291551880164, 20426.387208383734, 20796.0, 20845.16619335225, 21599.1360345586, 19097.427077187673, 19106.0, 19109.426717198472, 19111.61776764464, 19400.51498712533, 5775.422457754223, 5879.823605291848, 5994.400559944014, 6135.110408990694, 6176.444120029197, 6213.03697926822, 6247.125402443661, 6248.0, 6250.218722659668, 6253.624782513064, 6302.4958003359625, 6464.676766161697, 6533.346665333476, 6539.509536784736, 6552.639604821733, 5856.0630299151935, 6060.33336333003, 6674.399304062634, 6713.160854893138, 6713.530052896274, 6069.969650151766, 6080.513558915276, 6081.756729730805, 6088.11722300264, 6092.878142437171, 15141.697166056727, 15219.771703424458, 15386.230688465645, 15512.301946412439, 15520.456784012618, 2556.6931968163753, 2585.4570540186583, 2608.739126087395, 2618.685757709068, 3090.536419537065, 11051.336919784839, 11186.664400068012, 11285.0, 11337.886621133766, 11432.657020289322, 2005.5086503806515, 2030.6141833051672, 2122.07689654999, 2131.7015617813518, 2202.196198387577, 64720.0, 67806.66096669534, 73543.63228183879, 79421.0, 88030.55984720035, 11339.603113890975, 11483.770324593628, 11523.135764817673, 11598.536058557733, 11693.649190524298, 16122.677546449006, 16262.51212463628, 16305.347786088661, 16330.591735206715, 16365.263563139688, 7964.362850971908, 8203.0, 8286.212809783061, 8346.791330216793, 8433.03020152678, 7784.727534536377, 7830.882536761953, 7905.644246008944, 7930.167332430012, 7965.4822436541435, 4900.877478063006, 4952.777125029383, 5056.519630635084, 5071.797128114834, 5210.400803907523, 1871.8876867388, 2042.428120126367, 2074.958500829975, 2081.333973128584, 2095.319021318078, 960.5629438605417, 1002.5989604158249, 1020.7703266765067, 1061.4268295120548, 1103.8840921703265, 20681.793182068286, 20729.27447539329, 20833.270835520685, 20917.89541052285, 20991.895040525003, 1036.8652075230173, 1039.7972395382828, 1042.890496497872, 1092.814221582333, 1105.5798796457295, 10611.681649550526, 11381.0, 11395.259308144945, 11530.94234528822, 11560.190786645022, 469101.0, 487326.0, 491902.0, 498196.0, 499168.0, 94709.0, 94786.0, 98872.0, 98927.50536247273, 101406.0, 1008.0725732326277, 1059.6026490066224, 1065.984010239847, 1066.4188017530464, 1095.2497539185683, 17827.0, 18045.729314060038, 18095.36666216676, 18231.45305640833, 18537.53656158607, 43540.0, 45155.0, 45172.0, 45500.77249613731, 46348.0, 58957.705211473665, 61868.38131618626, 63498.36501634924, 63528.0, 63928.0, 8577.914220857712, 8834.95582522109, 8908.064653211319, 8998.23515001206, 9074.727758167266, 11459.541618335506, 13180.802287965496, 13501.257430841399, 13581.786297994588, 13627.250501222132, 11846.466908988943, 12008.75982480363, 12083.57707480234, 12213.75572488563, 12236.510539578674, 11503.0, 11748.353840538852, 11936.045116390495, 11963.521459141537, 12225.960793332666, 12023.21849079807, 12042.21725587834, 12119.515219391125, 12153.939230303791, 12206.694832629255, 8914.509701966195, 8955.328350373878, 8990.640374384951, 9099.772505687146, 9245.630174792934, 9480.620775168916, 11237.49431275611, 11436.94281528587, 11821.408929553316, 11882.16824822254], "value": 9548.892436767857, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1539.5997040769396, 1597.7283861743501, 1777.1469694546618, 1877.6432477829203, 1881.0312688965178, 9472.85790713139, 10231.641892533762, 10255.33340332878, 10267.589296428143, 10268.486575671206, 8212.630431630576, 8461.942257217848, 9351.298652601048, 9619.374740641853, 9964.153046990996, 2499.2627174983377, 2527.84832910026, 2528.3679080229945, 2531.620256961461, 2535.21408363407, 2493.6259561065804, 2560.9231723048247, 2566.4225549251455, 2570.498752743216, 2571.190075126339, 2530.1523989463553, 2535.822492425531, 2567.5250078735494, 2567.653366795487, 2569.216389001354, 2464.3592665906904, 2468.4445999650115, 2483.6522886795865, 2515.4466017476125, 2522.936926576832, 2455.668484754553, 2458.041363868093, 2462.938426539333, 2466.9753302467107, 2497.6628155198996, 10032.147267482273, 10089.949550252275, 10091.0, 10104.343217690826, 10164.44095574743, 5717.428257174291, 5729.169270455803, 5776.220210271602, 5781.595288329819, 5872.647641141545, 3485.7734247273847, 3617.981910090459, 3653.0, 3676.5771936227407, 3683.4843121962945, 1125.983110253347, 1189.2567145534042, 1197.3653963399413, 1212.6968257935516, 1226.5461779141774, 14049.08680935746, 14106.576802695936, 14117.64705882351, 14153.858461415357, 14164.787528187086, 5106.106431374569, 5117.0, 5181.481851814864, 5228.816991405282, 5306.814261500829, 11260.324380537195, 11353.205275630626, 11354.03490703283, 11356.659300221007, 11367.147463940237, 5901.616394934315, 5904.7342869570975, 5913.172155898178, 5915.112733090071, 5918.585699001114, 4737.45519265282, 5311.867203319948, 5365.195220716923, 5447.4552544746, 5536.944630553723, 4202.810873510699, 4224.5353011168745, 4263.4031235627035, 4298.828046878152, 4359.847405340798, 1278.2586100061942, 1298.3443361102584, 1308.9149205301626, 1309.260267948606, 1312.2454588611586, 911.3711539038175, 1040.2510192661273, 1052.984205236922, 1069.0218450118055, 1100.9889901101046, 6831.28271531482, 6908.1364829396325, 6957.791266261919, 7042.647867606599, 7137.250588688217, 499.8825276060123, 500.5520059546758, 502.4347608939943, 508.38231548667807, 510.2550276596137, 4637.1421287062, 4832.855014349575, 4841.661083724176, 4843.176659967814, 4892.779824907888, 11669.299842009506, 12101.092418068503, 12324.383780811102, 12633.93683031579, 12750.55373061957, 12395.566155184526, 12430.0, 12431.383920090511, 12436.067294952914, 12453.93773031129, 9172.908270917338, 9327.160555550034, 9337.43975361467, 9346.345755797029, 9358.578863951003, 6897.206821215625, 7051.612161331176, 7191.964040179766, 7246.565206087652, 7355.521891077063, 11291.209615326849, 11615.245009074382, 11782.410879456163, 11799.056075513767, 11802.645920622395, 11718.296902185555, 11764.823527647264, 11960.76078478443, 12003.459844307201, 12036.338001410006, 7995.2804247618, 8688.478691278544, 8769.868451973098, 8951.41815781972, 9130.223930965942, 9888.0, 9973.0, 9993.300468967103, 9994.350367226398, 10003.399796012263, 8256.339492840678, 8321.41750077513, 8322.791930201793, 8391.202835730595, 8470.068292487698, 8643.740687779376, 8645.8703119452, 8768.736937891874, 8769.605367758339, 8924.86612700797, 8236.546989915612, 8252.711155109542, 8303.62633681498, 8331.750047498585, 8371.455855369382, 5936.970315148396, 5972.70136493165, 6102.816915492543, 6170.413810687977, 6306.936930630818, 5866.149408335682, 5886.764529418775, 5892.911606325994, 6162.907556386568, 6209.813705588839], "value": 5091.656267377745, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.31191767764733, 360.6321552016943, 363.79263819622827, 365.40074278183766, 366.198026322354, 5511.9724401378035, 5553.8062465326175, 5559.499645031946, 5574.327701689492, 5594.58040646951, 5484.780608775644, 5516.0, 5521.944780552193, 5527.668339899609, 5531.368246367321, 4191.958080419195, 4316.223079845627, 4362.25841606926, 4376.518582955872, 4391.429114215148, 4364.2798938175165, 4370.366296886949, 4373.562643735617, 4377.606015458608, 4385.101054283864, 4339.522652508222, 4344.869653910388, 4346.261135606955, 4354.608085272325, 4359.716618419792, 4164.208800327928, 4346.239408103569, 4355.259605867011, 4364.541723119059, 4370.497392799837, 3850.3261929162563, 3854.286956912952, 3864.0, 3871.8644847430205, 3875.1087249932675, 5408.215808707755, 5414.214938833847, 5421.213923981, 5423.430539793304, 5435.157550579666, 4809.735464549449, 4848.29699693546, 4893.412790465131, 4908.509149085098, 4956.3804524434445, 5740.5981581289325, 5749.856253593652, 5753.453421924911, 5757.0, 5762.222100016486, 4122.711410201287, 4126.91746165075, 4128.504579450485, 4130.545639979599, 4139.565345638694, 5711.8000869969765, 5798.246227990377, 5834.941650583482, 5965.940340596582, 5984.0, 4183.707140500197, 4183.853565125206, 4184.644305234089, 4197.0, 4232.407462955189, 4317.589828966243, 4332.285172946428, 4339.262325404688, 4362.058883796743, 4363.36731173978, 4772.403449568804, 4930.13722598551, 4945.802167913315, 4946.9010619787405, 5010.772360771634, 5768.538516918637, 5816.8947899898885, 5824.359320474744, 5833.154192642043, 5833.854153646108, 1510.4109397335048, 1523.5962469945473, 1525.6719805241705, 1529.3118096856238, 1553.0526378908858, 935.5649622925372, 971.1793534463367, 976.72651657536, 977.5063592885547, 977.9584742249482, 4963.45402005779, 5014.598832093424, 5019.874503137451, 5021.4978502150225, 5023.79904803811, 5258.264772625024, 5272.0, 5283.471652834686, 5296.232046353257, 5305.4164041955355, 4997.000599880039, 5021.924671129936, 5023.748812559357, 5300.734963251822, 5690.516306113944, 3172.254520187754, 3177.1739347769744, 3193.0420873737785, 3193.473076942325, 3194.872205111816, 5979.312379076462, 6146.477549408351, 6161.8125565424525, 6167.074938759222, 6287.308396076428, 6005.39946005396, 6012.579119461596, 6046.727897244635, 6047.78832740852, 6050.394960503914, 6147.938520614736, 6149.723262453201, 6157.4458298753325, 6159.29168145669, 6309.873802524015, 5690.3456102548735, 5939.732712027882, 5968.0, 6011.849703757441, 6034.939650603438, 5935.605132793877, 5950.5239580834295, 5951.16683664296, 5956.344802071682, 5967.6121052131475, 5896.321922978741, 6129.387061293835, 6154.78458253959, 6174.14775567337, 6210.844728881814, 4302.225599392014, 4321.395004699281, 4348.521183053608, 4361.193179261847, 4361.280388735823, 5806.622569532967, 5980.162777211107, 6015.345779910384, 6036.9094463582205, 6042.395760424099, 5796.21751063601, 5822.0, 5846.269216347957, 5849.590528662953, 5858.7070646466655, 5848.093545500455, 5849.245226432138, 5850.736716847667, 5861.362386925815, 5863.970680146572, 5494.890102197854, 5783.624064435799, 5800.24596802413, 5807.245058142415, 5827.912581311199, 5861.794837180678, 5871.706414679335, 5878.647281163144, 5900.406890139724, 5902.20320256777, 5567.777288908398, 5731.226284451545, 5738.225339579103, 5744.3681195067675, 5753.280839895013], "value": 4412.565964670107, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [787.4763282417193, 842.359806547024, 856.2721686566417, 885.9424137431063, 906.5104843384572, 15933.0, 16702.415415460462, 16790.160491975414, 16821.327146914125, 16839.579010524743, 16007.919960400182, 16297.0, 16313.0, 16318.102504362256, 16350.427735029276, 729.5950747335227, 871.6949067826273, 881.850085485469, 902.5622573052065, 908.7728067983004, 903.0472851142042, 903.2051794420901, 905.5336501701596, 905.728281515546, 906.1482206725657, 963.2005435488528, 964.5177411294353, 964.6816550538306, 965.290511474066, 965.3049804141007, 780.6487080813628, 927.2165020557618, 945.2154711589365, 956.93779904306, 959.4674955399751, 697.6372286411089, 703.0614130136274, 703.5602748282323, 703.7290643102442, 704.0600797934763, 15727.606809829846, 15859.0, 15899.92050039754, 15901.1254381009, 15920.442784502487, 15665.295061722136, 15675.686486270211, 15749.212539372986, 15750.0, 15925.28336224861, 14175.787363189458, 14324.57026289213, 14481.275936203254, 14533.854661453355, 14666.853331466655, 4621.306803979396, 4643.117807616542, 4660.254359302529, 4742.739149346785, 4748.145333839908, 85820.57089714574, 86425.0, 86611.0, 87183.0, 89433.55283223608, 12614.306213158181, 12739.617811465485, 12815.871841281654, 12830.16603920742, 12850.293233872228, 23784.0, 23990.160344387863, 24013.399665008514, 24098.0, 24264.393390165387, 8776.517291548898, 8970.596323165473, 9010.098990100938, 9034.593443295067, 9099.363044586815, 4910.779014944264, 4932.334134891744, 4978.551930326288, 5014.548690617789, 5166.457521960216, 3547.8580856765957, 3641.2717456508803, 3658.798766067892, 3659.1949771050326, 3661.212839239576, 547.5838362844268, 613.0589545048418, 613.4632196827775, 619.0250355689807, 621.7450845153465, 701.9894701579481, 763.8090477380655, 801.5110782422718, 802.06959926485, 819.7704642700054, 10389.740256493496, 10683.30558513694, 10763.569457221623, 11085.667429977113, 11612.709682257842, 722.3101937649532, 783.2793829676712, 788.0425283280841, 798.508917016031, 819.3895547816795, 4910.410750709866, 5283.9471605284225, 5287.947120528823, 5381.78472861089, 5387.218853266255, 74872.62563687147, 88133.0, 113349.4332528332, 129305.35347323203, 136021.0, 112072.0, 119166.0, 119336.99999999827, 119523.0, 121286.0, 59966.700166498886, 61156.0, 62004.0, 93320.0, 98425.50787246018, 9135.451872887648, 9400.764980875532, 9631.747733793998, 9683.66107186245, 9763.755906102404, 39464.60535394609, 50598.494015059376, 55260.44739552553, 55560.0, 55876.0, 58380.12429813641, 65804.0, 75243.0, 78050.6097469509, 81577.0, 14188.503402380868, 14343.784843227151, 14522.20127892976, 14975.850241497446, 14993.625159370667, 15198.392064317304, 16121.75817362717, 16205.59486012859, 16796.58008549796, 17661.0, 12581.685457863627, 13386.598402047954, 13473.663158421117, 14475.710485790436, 15511.76732348993, 13965.58103256904, 13988.0, 14243.501477448239, 14276.143431393733, 14508.492202772852, 14212.289385530476, 14400.855991439952, 14794.334254958338, 14903.254837258311, 16048.358065677243, 11571.710707232387, 11850.229735067192, 11899.524019039141, 12002.57476036262, 12107.370072915784, 11527.365994870363, 11768.054002236751, 11920.76158476843, 12085.939570302093, 12270.509179632714], "value": 8131.102692173632, "unit": "score"}], "name": "dromaeo_css", "value": 7703.448799261006, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 109.0, 109.0, 111.0, 110.0, 109.0, 109.0, 108.0, 110.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 113.0, 120.0, 172.0, 116.0, 117.0, 141.0, 115.0, 160.0, 116.0], "value": 131.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 161.0, 162.0, 163.0, 162.0, 161.0, 162.0, 160.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 125.0, 75.0, 74.0, 73.0, 74.0, 106.0, 74.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 114.0, 82.0, 82.0, 82.0, 114.0, 83.0, 83.0, 128.0], "value": 93.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 50.0, 51.0, 50.0, 50.0, 50.0, 49.0, 51.0, 49.0], "value": 50.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 59.0, 60.0, 60.0, 60.0, 60.0, 60.0, 59.0, 61.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 72.0, 72.0, 80.0, 74.0, 71.0, 71.0, 71.0, 71.0, 72.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 121.0, 118.0, 127.0, 120.0, 120.0, 127.0, 120.0, 151.0, 120.0], "value": 125.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 153.0, 150.0, 149.0, 149.0, 152.0, 150.0, 149.0, 148.0, 148.0], "value": 149.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 65.0, 63.0, 60.0, 61.0, 62.0, 60.0, 59.0, 62.0, 59.0], "value": 61.1, "unit": "score"}], "name": "kraken", "value": 1454.3999999999999, "alertThreshold": 2.0}]} 03:54:03 INFO - Return code: 0 03:54:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:54:03 INFO - # TBPL SUCCESS # 03:54:03 INFO - Running post-action listener: _resource_record_post_action 03:54:03 INFO - [mozharness: 2016-08-06 10:54:03.504029Z] Finished run-tests step (success) 03:54:03 INFO - Running post-run listener: _resource_record_post_run 03:54:03 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 266240; Write bytes: 329588736; Read time: 28; Write time: 182788 03:54:03 INFO - TinderboxPrint: CPU usage
12.9% 03:54:03 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 03:54:03 INFO - TinderboxPrint: I/O write bytes / time
329,588,736 / 182,788 03:54:03 INFO - TinderboxPrint: CPU idle
8,263.1 (87.1%) 03:54:03 INFO - TinderboxPrint: CPU user
1,182.2 (12.5%) 03:54:03 INFO - TinderboxPrint: Swap in / out
0 / 0 03:54:03 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 79106048; Read time: 0; Write time: 43020 03:54:03 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 250482688; Read time: 28; Write time: 139768 03:54:04 INFO - Running post-run listener: _upload_blobber_files 03:54:04 INFO - Blob upload gear active. 03:54:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:54:04 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 03:54:04 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'] 03:54:04 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 03:54:04 INFO - (blobuploader) - INFO - Open directory for files ... 03:54:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:54:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:54:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:05 INFO - (blobuploader) - INFO - Done attempting. 03:54:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:54:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:54:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:08 INFO - (blobuploader) - INFO - Done attempting. 03:54:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:54:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:54:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:09 INFO - (blobuploader) - INFO - Done attempting. 03:54:09 INFO - (blobuploader) - INFO - Iteration through files over. 03:54:09 INFO - Return code: 0 03:54:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:54:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:54:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/679d02103d770b6528ca1af1b618deec36290c7630a3ef409868f2c322dfff51240661783e5dec3d38d6e274e3c57dad1a05b9d9183491c1a3d954f726998467", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/caaccf39afa7d92894ae585dc941bc8b840c1fd6141c6284202b8be00d581f44336bbf75dc3c20a1cf23d27d5f9d4289cda29941ae3e0e46b614b98888ea07c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5dd7aedf7e92366c2420a40751ca18e3bb355c8884ef561079e8f04c67cb5c27968c1586fe769705fc1546889457707a8cc083451d11284be4b9c341225dd18"} 03:54:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:54:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:54:09 INFO - Contents: 03:54:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/679d02103d770b6528ca1af1b618deec36290c7630a3ef409868f2c322dfff51240661783e5dec3d38d6e274e3c57dad1a05b9d9183491c1a3d954f726998467", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/caaccf39afa7d92894ae585dc941bc8b840c1fd6141c6284202b8be00d581f44336bbf75dc3c20a1cf23d27d5f9d4289cda29941ae3e0e46b614b98888ea07c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5dd7aedf7e92366c2420a40751ca18e3bb355c8884ef561079e8f04c67cb5c27968c1586fe769705fc1546889457707a8cc083451d11284be4b9c341225dd18"} 03:54:09 INFO - Running post-run listener: copy_logs_to_upload_dir 03:54:09 INFO - Copying logs to upload dir... 03:54:09 INFO - mkdir: /builds/slave/test/build/upload/logs 03:54:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1682.262155 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 2 secs) (at 2016-08-06 03:54:08.550701) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-06 03:54:08.554703) ========= 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=ed14279e38b05397cf4aa391000001a4-1470479164.559306-1625069966 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/679d02103d770b6528ca1af1b618deec36290c7630a3ef409868f2c322dfff51240661783e5dec3d38d6e274e3c57dad1a05b9d9183491c1a3d954f726998467", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/caaccf39afa7d92894ae585dc941bc8b840c1fd6141c6284202b8be00d581f44336bbf75dc3c20a1cf23d27d5f9d4289cda29941ae3e0e46b614b98888ea07c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5dd7aedf7e92366c2420a40751ca18e3bb355c8884ef561079e8f04c67cb5c27968c1586fe769705fc1546889457707a8cc083451d11284be4b9c341225dd18"} build_url:https://queue.taskcluster.net/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011358 build_url: 'https://queue.taskcluster.net/v1/task/b1edB_qQR1elR9NexbUY8A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/679d02103d770b6528ca1af1b618deec36290c7630a3ef409868f2c322dfff51240661783e5dec3d38d6e274e3c57dad1a05b9d9183491c1a3d954f726998467", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/caaccf39afa7d92894ae585dc941bc8b840c1fd6141c6284202b8be00d581f44336bbf75dc3c20a1cf23d27d5f9d4289cda29941ae3e0e46b614b98888ea07c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5dd7aedf7e92366c2420a40751ca18e3bb355c8884ef561079e8f04c67cb5c27968c1586fe769705fc1546889457707a8cc083451d11284be4b9c341225dd18"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-06 03:54:08.580138) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 03:54:08.580552) ========= 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=ed14279e38b05397cf4aa391000001a4-1470479164.559306-1625069966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004403 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 03:54:08.664079) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-06 03:54:08.664416) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-06 03:54:08.664779) ========= ========= Total master_lag: 0.17 =========